2024-05-06T22:21:57.592Z,1715034117.592 [Supervisor](DEBUG): Initializing supervisor. 2024-05-06T22:21:57.596Z,1715034117.596 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-06T22:21:57.596Z,1715034117.596 [SyncHandler](INFO): Protected caller Thread ID is 7575 2024-05-06T22:21:57.597Z,1715034117.597 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-06T22:21:57.598Z,1715034117.598 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-06T22:21:57.598Z,1715034117.598 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7576 2024-05-06T22:21:57.602Z,1715034117.602 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-06T22:21:57.619Z,1715034117.619 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-06T22:21:57.620Z,1715034117.620 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-06T22:21:57.621Z,1715034117.621 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7577 2024-05-06T22:21:57.625Z,1715034117.625 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-06T22:21:57.626Z,1715034117.626 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-06T22:21:57.626Z,1715034117.626 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7578 2024-05-06T22:21:57.628Z,1715034117.628 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-06T22:21:57.629Z,1715034117.629 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-06T22:21:57.629Z,1715034117.629 [logger ThreadHandler](INFO): Protected caller Thread ID is 7579 2024-05-06T22:21:57.633Z,1715034117.633 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-06T22:21:57.633Z,1715034117.633 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-06T22:21:57.635Z,1715034117.635 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-06T22:21:57.859Z,1715034117.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-06T22:21:57.860Z,1715034117.860 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-06T22:21:57.981Z,1715034117.981 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-06T22:21:57.982Z,1715034117.982 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-06T22:21:58.089Z,1715034118.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-06T22:21:58.090Z,1715034118.090 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-06T22:21:58.594Z,1715034118.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-06T22:21:58.595Z,1715034118.595 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-06T22:21:58.987Z,1715034118.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-06T22:21:58.988Z,1715034118.988 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-06T22:21:59.394Z,1715034119.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-06T22:21:59.395Z,1715034119.395 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-06T22:21:59.594Z,1715034119.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-06T22:21:59.595Z,1715034119.595 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-06T22:21:59.686Z,1715034119.686 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-06T22:21:59.780Z,1715034119.780 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-06T22:22:00.213Z,1715034120.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-06T22:22:00.214Z,1715034120.214 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-06T22:22:00.520Z,1715034120.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-06T22:22:00.521Z,1715034120.521 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-06T22:22:01.094Z,1715034121.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-06T22:22:01.094Z,1715034121.094 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-06T22:22:01.331Z,1715034121.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-06T22:22:01.332Z,1715034121.332 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-06T22:22:01.590Z,1715034121.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-06T22:22:01.591Z,1715034121.591 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-06T22:22:01.741Z,1715034121.741 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-06T22:22:01.742Z,1715034121.742 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-06T22:22:02.655Z,1715034122.655 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-06T22:22:02.658Z,1715034122.658 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-05-06T22:22:02.658Z,1715034122.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-05-06T22:22:02.856Z,1715034122.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-05-06T22:22:03.144Z,1715034123.144 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-05-06T22:22:03.463Z,1715034123.463 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-06T22:22:03.463Z,1715034123.463 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-05-06T22:22:03.600Z,1715034123.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-05-06T22:22:03.711Z,1715034123.711 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-05-06T22:22:03.816Z,1715034123.816 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-05-06T22:22:03.936Z,1715034123.936 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-05-06T22:22:04.043Z,1715034124.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-05-06T22:22:04.140Z,1715034124.140 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-05-06T22:22:04.242Z,1715034124.242 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-05-06T22:22:04.424Z,1715034124.424 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2024-05-06T22:22:04.424Z,1715034124.424 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-06T22:22:04.434Z,1715034124.434 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-06T22:22:04.485Z,1715034124.485 [DepthRateCalculator] Loaded 2024-05-06T22:22:04.486Z,1715034124.486 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-06T22:22:04.491Z,1715034124.491 [PitchRateCalculator] Loaded 2024-05-06T22:22:04.491Z,1715034124.491 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-06T22:22:04.501Z,1715034124.501 [SpeedCalculator] Loaded 2024-05-06T22:22:04.501Z,1715034124.501 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-06T22:22:04.506Z,1715034124.506 [YawRateCalculator] Loaded 2024-05-06T22:22:04.506Z,1715034124.506 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-06T22:22:04.527Z,1715034124.527 [ElevatorOffsetCalculator] Loaded 2024-05-06T22:22:04.528Z,1715034124.528 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-06T22:22:04.528Z,1715034124.528 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-06T22:22:04.529Z,1715034124.529 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-06T22:22:04.555Z,1715034124.555 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-06T22:22:04.556Z,1715034124.556 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-06T22:22:04.566Z,1715034124.566 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-06T22:22:04.566Z,1715034124.566 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-06T22:22:04.993Z,1715034124.993 [AHRS_M2] Loaded 2024-05-06T22:22:04.993Z,1715034124.993 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-06T22:22:05.028Z,1715034125.028 [BackseatComponent] Loaded 2024-05-06T22:22:05.028Z,1715034125.028 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-06T22:22:05.030Z,1715034125.030 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408584E0 2024-05-06T22:22:05.030Z,1715034125.030 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7662 2024-05-06T22:22:05.033Z,1715034125.033 [LcmUniversalReporter] Loaded 2024-05-06T22:22:05.033Z,1715034125.033 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-06T22:22:05.814Z,1715034125.814 [BPC1] Loaded 2024-05-06T22:22:05.814Z,1715034125.814 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-06T22:22:05.885Z,1715034125.885 [DataOverHttps] Loaded 2024-05-06T22:22:05.886Z,1715034125.886 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-06T22:22:05.887Z,1715034125.887 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408884E0 2024-05-06T22:22:05.887Z,1715034125.887 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7663 2024-05-06T22:22:05.907Z,1715034125.907 [Depth_Keller] Loaded 2024-05-06T22:22:05.907Z,1715034125.907 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-06T22:22:05.912Z,1715034125.912 [DropWeight] Loaded 2024-05-06T22:22:05.912Z,1715034125.912 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-06T22:22:05.930Z,1715034125.930 [MultiRay] Loaded 2024-05-06T22:22:05.930Z,1715034125.930 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2024-05-06T22:22:05.992Z,1715034125.992 [NAL9602] Loaded 2024-05-06T22:22:05.992Z,1715034125.992 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-06T22:22:06.021Z,1715034126.021 [Onboard] Loaded 2024-05-06T22:22:06.021Z,1715034126.021 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-06T22:22:06.022Z,1715034126.022 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0 2024-05-06T22:22:06.022Z,1715034126.022 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7664 2024-05-06T22:22:06.034Z,1715034126.034 [Power24vConverter] Loaded 2024-05-06T22:22:06.034Z,1715034126.034 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-06T22:22:06.048Z,1715034126.048 [Radio_Surface] Loaded 2024-05-06T22:22:06.048Z,1715034126.048 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-06T22:22:06.049Z,1715034126.049 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E84E0 2024-05-06T22:22:06.050Z,1715034126.050 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7665 2024-05-06T22:22:06.063Z,1715034126.063 [Sonardyne_Nano] Loaded 2024-05-06T22:22:06.063Z,1715034126.063 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-05-06T22:22:06.085Z,1715034126.085 [Waterlinked] Loaded 2024-05-06T22:22:06.086Z,1715034126.086 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-05-06T22:22:06.086Z,1715034126.086 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-06T22:22:06.086Z,1715034126.086 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-06T22:22:06.196Z,1715034126.196 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-06T22:22:06.197Z,1715034126.197 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-06T22:22:06.238Z,1715034126.238 [DeadReckonUsingSpeedCalculator] Loaded 2024-05-06T22:22:06.238Z,1715034126.238 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-05-06T22:22:06.251Z,1715034126.251 [NavChart] Loaded 2024-05-06T22:22:06.252Z,1715034126.252 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-06T22:22:06.257Z,1715034126.257 [UniversalFixResidualReporter] Loaded 2024-05-06T22:22:06.257Z,1715034126.257 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-06T22:22:06.258Z,1715034126.258 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-06T22:22:06.258Z,1715034126.258 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-06T22:22:06.398Z,1715034126.398 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-06T22:22:06.412Z,1715034126.412 [SBIT] Loaded 2024-05-06T22:22:06.413Z,1715034126.413 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-06T22:22:06.415Z,1715034126.415 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-06T22:22:06.428Z,1715034126.428 [IBIT] Loaded 2024-05-06T22:22:06.428Z,1715034126.428 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-06T22:22:06.434Z,1715034126.434 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-06T22:22:06.537Z,1715034126.537 [CBIT] Loaded 2024-05-06T22:22:06.537Z,1715034126.537 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-06T22:22:06.537Z,1715034126.537 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-06T22:22:06.538Z,1715034126.538 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-06T22:22:06.706Z,1715034126.706 [CTD_Seabird] Loaded 2024-05-06T22:22:06.706Z,1715034126.706 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-06T22:22:06.707Z,1715034126.707 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409F04E0 2024-05-06T22:22:06.708Z,1715034126.708 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7666 2024-05-06T22:22:06.728Z,1715034126.728 [PAR_Licor] Loaded 2024-05-06T22:22:06.728Z,1715034126.728 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-06T22:22:06.770Z,1715034126.770 [WetLabsBB2FL] Loaded 2024-05-06T22:22:06.771Z,1715034126.771 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-06T22:22:06.772Z,1715034126.772 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0 2024-05-06T22:22:06.772Z,1715034126.772 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7667 2024-05-06T22:22:06.773Z,1715034126.773 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-06T22:22:06.773Z,1715034126.773 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-06T22:22:06.905Z,1715034126.905 [BuoyancyServo] Loaded 2024-05-06T22:22:06.905Z,1715034126.905 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-06T22:22:06.927Z,1715034126.927 [ElevatorServo] Loaded 2024-05-06T22:22:06.927Z,1715034126.927 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-06T22:22:06.947Z,1715034126.947 [MassServo] Loaded 2024-05-06T22:22:06.948Z,1715034126.948 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-06T22:22:06.968Z,1715034126.968 [RudderServo] Loaded 2024-05-06T22:22:06.968Z,1715034126.968 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-06T22:22:06.983Z,1715034126.983 [ThrusterHE] Loaded 2024-05-06T22:22:06.984Z,1715034126.984 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-05-06T22:22:06.984Z,1715034126.984 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-06T22:22:06.984Z,1715034126.984 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-06T22:22:07.036Z,1715034127.036 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-06T22:22:07.086Z,1715034127.086 [VerticalControl] Loaded 2024-05-06T22:22:07.087Z,1715034127.087 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-06T22:22:07.089Z,1715034127.089 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-06T22:22:07.133Z,1715034127.133 [HorizontalControl] Loaded 2024-05-06T22:22:07.134Z,1715034127.134 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-06T22:22:07.136Z,1715034127.136 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-06T22:22:07.138Z,1715034127.138 [SpeedControl] Loaded 2024-05-06T22:22:07.138Z,1715034127.138 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-06T22:22:07.141Z,1715034127.141 [LoopControl](DEBUG): Construct LoopControl. 2024-05-06T22:22:07.141Z,1715034127.141 [LoopControl] Loaded 2024-05-06T22:22:07.142Z,1715034127.142 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-06T22:22:07.142Z,1715034127.142 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-06T22:22:07.143Z,1715034127.143 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-06T22:22:07.253Z,1715034127.253 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-06T22:22:07.253Z,1715034127.253 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-06T22:22:07.426Z,1715034127.426 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-06T22:22:07.427Z,1715034127.427 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-06T22:22:07.838Z,1715034127.838 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-06T22:22:07.839Z,1715034127.839 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-06T22:22:08.122Z,1715034128.122 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-06T22:22:08.131Z,1715034128.131 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-06T22:22:08.133Z,1715034128.133 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-06T22:22:08.144Z,1715034128.144 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-06T22:22:08.145Z,1715034128.145 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-05-06T22:22:08.146Z,1715034128.146 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7668 2024-05-06T22:22:08.223Z,1715034128.223 [Supervisor](INFO): Main Thread ID is 7574 2024-05-06T22:22:08.223Z,1715034128.223 [Supervisor](DEBUG): Running supervisor. 2024-05-06T22:22:08.224Z,1715034128.224 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7669 2024-05-06T22:22:08.224Z,1715034128.224 [CommandExec](INFO): Initializing the command executive. 2024-05-06T22:22:08.226Z,1715034128.226 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7670 2024-05-06T22:22:08.229Z,1715034128.229 [controlThread ThreadHandler](INFO): Handler Thread ID is 7671 2024-05-06T22:22:08.229Z,1715034128.229 [controlThread](DEBUG): Initializing ControlThread 2024-05-06T22:22:08.230Z,1715034128.230 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-06T22:22:08.230Z,1715034128.230 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-06T22:22:08.231Z,1715034128.231 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-06T22:22:08.231Z,1715034128.231 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-06T22:22:08.231Z,1715034128.231 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-06T22:22:08.240Z,1715034128.240 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:22:08.240Z,1715034128.240 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-06T22:22:08.240Z,1715034128.240 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-06T22:22:08.241Z,1715034128.241 [SBIT](INFO): Initialize SBIT Component. 2024-05-06T22:22:08.241Z,1715034128.241 [SBIT](IMPORTANT): git: 2024-05-06 2024-05-06T22:22:08.241Z,1715034128.241 [SBIT](INFO): git hash: 5fc11fab0683feef1094efea7282b340ac202615 2024-05-06T22:22:08.242Z,1715034128.242 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-06T22:22:08.243Z,1715034128.243 [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-05-06T22:22:08.244Z,1715034128.244 [SBIT](INFO): Beginning SBIT in 83.000000 seconds. 2024-05-06T22:22:08.244Z,1715034128.244 [IBIT](INFO): Initialize IBIT Component. 2024-05-06T22:22:08.245Z,1715034128.245 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-06T22:22:08.246Z,1715034128.246 [logger ThreadHandler](INFO): Handler Thread ID is 7672 2024-05-06T22:22:08.257Z,1715034128.257 [CBIT](DEBUG): Initialized mux pins. 2024-05-06T22:22:08.257Z,1715034128.257 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-06T22:22:08.265Z,1715034128.265 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7673 2024-05-06T22:22:08.277Z,1715034128.277 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7674 2024-05-06T22:22:08.279Z,1715034128.279 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-06T22:22:08.281Z,1715034128.281 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-06T22:22:08.281Z,1715034128.281 [CBIT](DEBUG): Initializing heartbeat. 2024-05-06T22:22:08.289Z,1715034128.289 [Onboard ThreadHandler](INFO): Handler Thread ID is 7675 2024-05-06T22:22:08.313Z,1715034128.313 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7676 2024-05-06T22:22:08.330Z,1715034128.330 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7677 2024-05-06T22:22:08.330Z,1715034128.330 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-06T22:22:08.334Z,1715034128.334 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7679 2024-05-06T22:22:08.337Z,1715034128.337 [WetLabsBB2FL](INFO): Powering up 2024-05-06T22:22:08.339Z,1715034128.339 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7681 2024-05-06T22:22:08.341Z,1715034128.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-06T22:22:08.341Z,1715034128.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-06T22:22:08.341Z,1715034128.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-06T22:22:08.341Z,1715034128.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-06T22:22:08.342Z,1715034128.342 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-06T22:22:08.342Z,1715034128.342 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-06T22:22:08.342Z,1715034128.342 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-06T22:22:08.342Z,1715034128.342 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-06T22:22:08.353Z,1715034128.353 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-06T22:22:08.353Z,1715034128.353 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-06T22:22:08.393Z,1715034128.393 [CBIT](DEBUG): Backplane powered. 2024-05-06T22:22:08.398Z,1715034128.398 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-06T22:22:08.400Z,1715034128.400 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-06T22:22:08.401Z,1715034128.401 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-06T22:22:08.401Z,1715034128.401 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-06T22:22:08.402Z,1715034128.402 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-06T22:22:08.403Z,1715034128.403 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-06T22:22:08.403Z,1715034128.403 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-06T22:22:08.404Z,1715034128.404 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-06T22:22:08.451Z,1715034128.451 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-06T22:22:08.455Z,1715034128.455 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-06T22:22:08.491Z,1715034128.491 [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-05-06T22:22:08.492Z,1715034128.492 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-06T22:22:08.492Z,1715034128.492 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-06T22:22:08.493Z,1715034128.493 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-06T22:22:08.709Z,1715034128.709 [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-05-06T22:22:08.715Z,1715034128.715 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-06T22:22:08.716Z,1715034128.716 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-06T22:22:08.717Z,1715034128.717 [Radio_Surface](INFO): Powering up 2024-05-06T22:22:08.720Z,1715034128.720 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-06T22:22:08.751Z,1715034128.751 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-06T22:22:08.760Z,1715034128.760 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-06T22:22:08.777Z,1715034128.777 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-06T22:22:08.780Z,1715034128.780 [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-05-06T22:22:08.785Z,1715034128.785 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T22:22:08.793Z,1715034128.793 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T22:22:08.855Z,1715034128.855 [MultiRay](INFO): Powering up MultiRay Lights 2024-05-06T22:22:08.886Z,1715034128.886 [Power24vConverter](INFO): Powering up. 2024-05-06T22:22:08.886Z,1715034128.886 [Sonardyne_Nano](INFO): Initializing. 2024-05-06T22:22:08.940Z,1715034128.940 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:08.945Z,1715034128.945 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-06T22:22:08.946Z,1715034128.946 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:08.961Z,1715034128.961 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:22:08.962Z,1715034128.962 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:08.969Z,1715034128.969 [MassServo](DEBUG): Initializing MassServo. 2024-05-06T22:22:08.970Z,1715034128.970 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:08.977Z,1715034128.977 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-06T22:22:08.978Z,1715034128.978 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:08.985Z,1715034128.985 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-05-06T22:22:09.227Z,1715034129.227 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-05-06T22:22:09.227Z,1715034129.227 [DropWeight] Hardware Fault, FailCount= 1 2024-05-06T22:22:09.227Z,1715034129.227 [DropWeight](ERROR): Hardware Fault 2024-05-06T22:22:09.304Z,1715034129.304 [CommandExec](FAULT): Scheduling is paused 2024-05-06T22:22:09.309Z,1715034129.309 [CBIT](INFO): Critical error at 20240506T222209 2024-05-06T22:22:09.309Z,1715034129.309 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-05-06T22:22:09.312Z,1715034129.312 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-05-06T22:22:09.317Z,1715034129.317 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-05-06T22:22:09.619Z,1715034129.619 [CBIT](INFO): Critical error at 20240506T222209 2024-05-06T22:22:10.815Z,1715034130.815 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-05-06T22:22:10.949Z,1715034130.949 [WetLabsBB2FL](INFO): Powering down 2024-05-06T22:22:12.461Z,1715034132.461 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2105 2024-05-06T22:22:14.694Z,1715034134.694 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-05-06T22:22:15.362Z,1715034135.362 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-05-06T22:22:19.091Z,1715034139.091 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004918 2024-05-06T22:22:32.397Z,1715034152.397 [MassServo](ERROR): getPosition uart error serial timeout 2024-05-06T22:22:32.397Z,1715034152.397 [MassServo](FAULT): Invalid EZ Servo response:"" 2024-05-06T22:22:32.397Z,1715034152.397 [MassServo] Communications Fault, FailCount= 1 2024-05-06T22:22:32.397Z,1715034152.397 [MassServo](ERROR): Communications Fault 2024-05-06T22:22:32.402Z,1715034152.402 [CBIT](ERROR): Communications Fault in component: MassServo 2024-05-06T22:22:32.663Z,1715034152.663 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-06T22:22:32.663Z,1715034152.663 [MassServo](INFO): Powering down 2024-05-06T22:22:33.476Z,1715034153.476 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:22:33.590Z,1715034153.590 [MassServo](DEBUG): Initializing MassServo. 2024-05-06T22:22:33.594Z,1715034153.594 [CBIT](INFO): Clearing failed state for component MassServo 2024-05-06T22:22:33.594Z,1715034153.594 [MassServo] No Fault, FailCount= 1 2024-05-06T22:22:36.286Z,1715034156.286 [NAL9602](INFO): Powering up NAL9602 2024-05-06T22:22:37.095Z,1715034157.095 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:22:37.095Z,1715034157.095 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:22:37.095Z,1715034157.095 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:22:37.217Z,1715034157.217 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:22:37.561Z,1715034157.561 [Waterlinked](INFO): Powering down 2024-05-06T22:22:38.381Z,1715034158.381 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:22:38.381Z,1715034158.381 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:22:47.190Z,1715034167.190 [NAL9602](INFO): NAL9602 initialized 2024-05-06T22:23:06.998Z,1715034186.998 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:23:06.998Z,1715034186.998 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:23:06.998Z,1715034186.998 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:23:07.020Z,1715034187.020 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:23:07.477Z,1715034187.477 [Waterlinked](INFO): Powering down 2024-05-06T22:23:08.219Z,1715034188.219 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:23:08.219Z,1715034188.219 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:23:32.059Z,1715034212.059 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-06T22:23:32.064Z,1715034212.064 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T22:23:34.101Z,1715034214.101 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:23:34.101Z,1715034214.101 [ElevatorServo] Hardware Fault, FailCount= 1 2024-05-06T22:23:34.101Z,1715034214.101 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:23:34.235Z,1715034214.235 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:23:34.476Z,1715034214.476 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:23:34.476Z,1715034214.476 [ElevatorServo](INFO): Powering down 2024-05-06T22:23:35.290Z,1715034215.290 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:23:35.406Z,1715034215.406 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:23:35.466Z,1715034215.466 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:23:35.466Z,1715034215.466 [ElevatorServo] No Fault, FailCount= 1 2024-05-06T22:23:36.884Z,1715034216.884 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:23:36.884Z,1715034216.884 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:23:36.884Z,1715034216.884 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:23:37.074Z,1715034217.074 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:23:37.074Z,1715034217.074 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:23:37.361Z,1715034217.361 [Waterlinked](INFO): Powering down 2024-05-06T22:23:37.408Z,1715034217.408 [CBIT](INFO): Critical error at 20240506T222337 2024-05-06T22:23:40.573Z,1715034220.573 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:23:40.573Z,1715034220.573 [ElevatorServo] Hardware Fault, FailCount= 2 2024-05-06T22:23:40.573Z,1715034220.573 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:23:40.630Z,1715034220.630 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:23:40.935Z,1715034220.935 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:23:40.935Z,1715034220.935 [ElevatorServo](INFO): Powering down 2024-05-06T22:23:41.748Z,1715034221.748 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:23:41.862Z,1715034221.862 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:23:41.894Z,1715034221.894 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:23:41.894Z,1715034221.894 [ElevatorServo] No Fault, FailCount= 2 2024-05-06T22:23:43.143Z,1715034223.143 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.007733 CHAN A1 (24V): 0.001201 CHAN A2 (12V): -0.005360 CHAN A3 (5V): -0.002260 CHAN B0 (3.3V): -0.001196 CHAN B1 (3.15aV): -0.001911 CHAN B2 (3.15bV): -0.001106 CHAN B3 (GND): -0.000700 OPEN: 0.004120 Full Scale: +/- 1 mA 2024-05-06T22:23:45.447Z,1715034225.447 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:18.645922 2024-05-06T22:23:46.665Z,1715034226.665 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:23:46.665Z,1715034226.665 [ElevatorServo] Hardware Fault, FailCount= 3 2024-05-06T22:23:46.665Z,1715034226.665 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:23:46.672Z,1715034226.672 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:23:46.672Z,1715034226.672 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-05-06T22:23:47.011Z,1715034227.011 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:23:47.011Z,1715034227.011 [ElevatorServo](INFO): Powering down 2024-05-06T22:23:47.015Z,1715034227.015 [CBIT](INFO): Critical error at 20240506T222346 2024-05-06T22:23:47.812Z,1715034227.812 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:23:47.930Z,1715034227.930 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:24:12.048Z,1715034252.048 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-05-06T22:24:12.048Z,1715034252.048 [SBIT](FAULT): Control surface position failure. 2024-05-06T22:24:25.818Z,1715034265.818 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-05-06T22:24:25.818Z,1715034265.818 [SBIT](FAULT): Control surface position failure. 2024-05-06T22:24:26.202Z,1715034266.202 [SBIT](CRITICAL): SBIT FAILED 2024-05-06T22:24:26.202Z,1715034266.202 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-05-06T22:24:26.203Z,1715034266.203 [SBIT](IMPORTANT): BackseatComponent.poTimeout=30 second; 2024-05-06T22:24:26.203Z,1715034266.203 [SBIT](IMPORTANT): CBIT.gfScanTimeout=1 hour; 2024-05-06T22:24:26.203Z,1715034266.203 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=2 ampere_hour; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): MultiRay.brightnessRed=82 none; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): MultiRay.brightnessWhite=82 none; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=131.145249 cubic_centimeter; 2024-05-06T22:24:26.204Z,1715034266.204 [SBIT](IMPORTANT): VerticalControl.massDefault=15.869193 millimeter; 2024-05-06T22:24:26.206Z,1715034266.206 [CBIT](INFO): Critical error at 20240506T222426 2024-05-06T22:24:26.600Z,1715034266.600 [MissionManager](IMPORTANT): Started mission Startup 2024-05-06T22:24:26.600Z,1715034266.600 [Startup] Running Loop=1 2024-05-06T22:24:26.600Z,1715034266.600 [Startup](DEBUG): Aggregate::initialize Startup 2024-05-06T22:24:26.600Z,1715034266.600 [Startup:A.GoToSurface] Running Loop=1 2024-05-06T22:24:26.600Z,1715034266.600 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-06T22:24:26.601Z,1715034266.601 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-06T22:24:26.602Z,1715034266.602 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-06T22:24:26.602Z,1715034266.602 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-06T22:24:26.602Z,1715034266.602 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-06T22:24:26.603Z,1715034266.603 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-06T22:24:26.604Z,1715034266.604 [Startup:StartupSatComms] Running Loop=1 2024-05-06T22:24:26.604Z,1715034266.604 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-05-06T22:24:26.604Z,1715034266.604 [Startup:StartupSatComms:A] Running Loop=1 2024-05-06T22:24:26.997Z,1715034266.997 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-05-06T22:24:46.084Z,1715034286.084 [CommandExec](IMPORTANT): got command report mod PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2024-05-06T22:24:46.422Z,1715034286.422 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.632913 umol/s/m2 2024-05-06T22:24:46.834Z,1715034286.834 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.546435 umol/s/m2 2024-05-06T22:24:47.244Z,1715034287.244 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.604088 umol/s/m2 2024-05-06T22:24:47.618Z,1715034287.618 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:24:48.027Z,1715034288.027 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.667505 umol/s/m2 2024-05-06T22:24:48.418Z,1715034288.418 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.650210 umol/s/m2 2024-05-06T22:24:48.825Z,1715034288.825 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.606970 umol/s/m2 2024-05-06T22:24:49.232Z,1715034289.232 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:24:49.643Z,1715034289.643 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.676154 umol/s/m2 2024-05-06T22:24:50.165Z,1715034290.165 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.650210 umol/s/m2 2024-05-06T22:24:50.444Z,1715034290.444 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.635797 umol/s/m2 2024-05-06T22:24:51.286Z,1715034291.286 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:24:51.679Z,1715034291.679 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.624266 umol/s/m2 2024-05-06T22:24:52.070Z,1715034292.070 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.630031 umol/s/m2 2024-05-06T22:24:52.470Z,1715034292.470 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.670388 umol/s/m2 2024-05-06T22:24:52.873Z,1715034292.873 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.831815 umol/s/m2 2024-05-06T22:24:53.261Z,1715034293.261 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.849111 umol/s/m2 2024-05-06T22:24:53.668Z,1715034293.668 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.886585 umol/s/m2 2024-05-06T22:24:54.075Z,1715034294.075 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.918293 umol/s/m2 2024-05-06T22:24:54.490Z,1715034294.490 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.895233 umol/s/m2 2024-05-06T22:24:54.878Z,1715034294.878 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.765515 umol/s/m2 2024-05-06T22:24:55.282Z,1715034295.282 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.661740 umol/s/m2 2024-05-06T22:24:55.697Z,1715034295.697 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:24:56.106Z,1715034296.106 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.655974 umol/s/m2 2024-05-06T22:24:56.528Z,1715034296.528 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.730923 umol/s/m2 2024-05-06T22:24:56.918Z,1715034296.918 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.831815 umol/s/m2 2024-05-06T22:24:57.318Z,1715034297.318 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.846228 umol/s/m2 2024-05-06T22:24:57.730Z,1715034297.730 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.869289 umol/s/m2 2024-05-06T22:24:58.109Z,1715034298.109 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.860641 umol/s/m2 2024-05-06T22:24:58.518Z,1715034298.518 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.854875 umol/s/m2 2024-05-06T22:24:58.924Z,1715034298.924 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.837580 umol/s/m2 2024-05-06T22:24:59.333Z,1715034299.333 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.869289 umol/s/m2 2024-05-06T22:24:59.723Z,1715034299.723 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.817402 umol/s/m2 2024-05-06T22:25:00.134Z,1715034300.134 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.869289 umol/s/m2 2024-05-06T22:25:00.545Z,1715034300.545 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.872172 umol/s/m2 2024-05-06T22:25:00.957Z,1715034300.957 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.932706 umol/s/m2 2024-05-06T22:25:01.342Z,1715034301.342 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.970181 umol/s/m2 2024-05-06T22:25:01.786Z,1715034301.786 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 7.019186 umol/s/m2 2024-05-06T22:25:02.174Z,1715034302.174 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.938472 umol/s/m2 2024-05-06T22:25:02.578Z,1715034302.578 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.889467 umol/s/m2 2024-05-06T22:25:02.989Z,1715034302.989 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.857759 umol/s/m2 2024-05-06T22:25:03.519Z,1715034303.519 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.854875 umol/s/m2 2024-05-06T22:25:03.799Z,1715034303.799 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.817402 umol/s/m2 2024-05-06T22:25:04.194Z,1715034304.194 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.785693 umol/s/m2 2024-05-06T22:25:04.607Z,1715034304.607 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.696332 umol/s/m2 2024-05-06T22:25:04.978Z,1715034304.978 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.635797 umol/s/m2 2024-05-06T22:25:05.393Z,1715034305.393 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.655974 umol/s/m2 2024-05-06T22:25:05.782Z,1715034305.782 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.725158 umol/s/m2 2024-05-06T22:25:06.189Z,1715034306.189 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.655974 umol/s/m2 2024-05-06T22:25:06.590Z,1715034306.590 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.658857 umol/s/m2 2024-05-06T22:25:07.018Z,1715034307.018 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.702097 umol/s/m2 2024-05-06T22:25:07.426Z,1715034307.426 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.722275 umol/s/m2 2024-05-06T22:25:07.854Z,1715034307.854 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:25:08.244Z,1715034308.244 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-05-06T22:25:08.245Z,1715034308.245 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:25:08.250Z,1715034308.250 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-05-06T22:25:08.250Z,1715034308.250 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:25:08.269Z,1715034308.269 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:25:08.269Z,1715034308.269 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:25:08.271Z,1715034308.271 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.566613 umol/s/m2 2024-05-06T22:25:08.635Z,1715034308.635 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:25:08.635Z,1715034308.635 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-05-06T22:25:08.635Z,1715034308.635 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:25:08.635Z,1715034308.635 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-05-06T22:25:08.641Z,1715034308.641 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.569496 umol/s/m2 2024-05-06T22:25:09.012Z,1715034309.012 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:25:09.053Z,1715034309.053 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.612735 umol/s/m2 2024-05-06T22:25:09.427Z,1715034309.427 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.638679 umol/s/m2 2024-05-06T22:25:09.843Z,1715034309.843 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:25:10.257Z,1715034310.257 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.549318 umol/s/m2 2024-05-06T22:25:10.652Z,1715034310.652 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.526257 umol/s/m2 2024-05-06T22:25:11.063Z,1715034311.063 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.555084 umol/s/m2 2024-05-06T22:25:11.446Z,1715034311.446 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.549318 umol/s/m2 2024-05-06T22:25:11.862Z,1715034311.862 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.520492 umol/s/m2 2024-05-06T22:25:12.276Z,1715034312.276 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.552200 umol/s/m2 2024-05-06T22:25:12.688Z,1715034312.688 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.503196 umol/s/m2 2024-05-06T22:25:13.078Z,1715034313.078 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:25:13.498Z,1715034313.498 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.627149 umol/s/m2 2024-05-06T22:25:13.883Z,1715034313.883 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.581026 umol/s/m2 2024-05-06T22:25:14.676Z,1715034314.676 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.722275 umol/s/m2 2024-05-06T22:25:15.088Z,1715034315.088 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.549318 umol/s/m2 2024-05-06T22:25:15.499Z,1715034315.499 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.431130 umol/s/m2 2024-05-06T22:25:16.294Z,1715034316.294 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.370595 umol/s/m2 2024-05-06T22:25:16.757Z,1715034316.757 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.356182 umol/s/m2 2024-05-06T22:25:17.212Z,1715034317.212 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.373478 umol/s/m2 2024-05-06T22:25:17.558Z,1715034317.558 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.483017 umol/s/m2 2024-05-06T22:25:17.954Z,1715034317.954 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.520492 umol/s/m2 2024-05-06T22:25:18.358Z,1715034318.358 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.532022 umol/s/m2 2024-05-06T22:25:18.729Z,1715034318.729 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.526257 umol/s/m2 2024-05-06T22:25:19.120Z,1715034319.120 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.549318 umol/s/m2 2024-05-06T22:25:19.524Z,1715034319.524 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.609853 umol/s/m2 2024-05-06T22:25:19.929Z,1715034319.929 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.578144 umol/s/m2 2024-05-06T22:25:20.342Z,1715034320.342 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.566613 umol/s/m2 2024-05-06T22:25:20.750Z,1715034320.750 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.598322 umol/s/m2 2024-05-06T22:25:21.138Z,1715034321.138 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.641562 umol/s/m2 2024-05-06T22:25:21.544Z,1715034321.544 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.503196 umol/s/m2 2024-05-06T22:25:21.952Z,1715034321.952 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.555084 umol/s/m2 2024-05-06T22:25:22.374Z,1715034322.374 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.480135 umol/s/m2 2024-05-06T22:25:22.786Z,1715034322.786 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.523374 umol/s/m2 2024-05-06T22:25:23.179Z,1715034323.179 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.462839 umol/s/m2 2024-05-06T22:25:23.590Z,1715034323.590 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.434012 umol/s/m2 2024-05-06T22:25:23.984Z,1715034323.984 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.560848 umol/s/m2 2024-05-06T22:25:24.370Z,1715034324.370 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.491665 umol/s/m2 2024-05-06T22:25:24.777Z,1715034324.777 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.488782 umol/s/m2 2024-05-06T22:25:25.186Z,1715034325.186 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.459956 umol/s/m2 2024-05-06T22:25:25.597Z,1715034325.597 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.442661 umol/s/m2 2024-05-06T22:25:25.985Z,1715034325.985 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.500313 umol/s/m2 2024-05-06T22:25:26.392Z,1715034326.392 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.506079 umol/s/m2 2024-05-06T22:25:26.789Z,1715034326.789 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-06T22:24:26.6Z 2024-05-06T22:25:26.790Z,1715034326.790 [Startup:StartupSatComms:A] Stopped 2024-05-06T22:25:26.790Z,1715034326.790 [Startup:StartupSatComms:B] Running Loop=1 2024-05-06T22:25:26.800Z,1715034326.800 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.540669 umol/s/m2 2024-05-06T22:25:27.188Z,1715034327.188 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-06T22:25:27.247Z,1715034327.247 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.549318 umol/s/m2 2024-05-06T22:25:27.626Z,1715034327.626 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.606970 umol/s/m2 2024-05-06T22:25:28.023Z,1715034328.023 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:25:28.438Z,1715034328.438 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.534904 umol/s/m2 2024-05-06T22:25:28.846Z,1715034328.846 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.557965 umol/s/m2 2024-05-06T22:25:29.279Z,1715034329.279 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.667505 umol/s/m2 2024-05-06T22:25:29.650Z,1715034329.650 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:25:30.046Z,1715034330.046 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:25:30.531Z,1715034330.531 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.644444 umol/s/m2 2024-05-06T22:25:30.999Z,1715034330.999 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:25:31.302Z,1715034331.302 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:25:31.679Z,1715034331.679 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.627149 umol/s/m2 2024-05-06T22:25:32.097Z,1715034332.097 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.653092 umol/s/m2 2024-05-06T22:25:32.493Z,1715034332.493 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.601205 umol/s/m2 2024-05-06T22:25:32.870Z,1715034332.870 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.578144 umol/s/m2 2024-05-06T22:25:33.282Z,1715034333.282 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.615618 umol/s/m2 2024-05-06T22:25:33.693Z,1715034333.693 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.557965 umol/s/m2 2024-05-06T22:25:33.777Z,1715034333.777 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240506T160721/Courier0082.lzma 2024-05-06T22:25:34.082Z,1715034334.082 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.632913 umol/s/m2 2024-05-06T22:25:34.478Z,1715034334.478 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:25:34.779Z,1715034334.779 [DataOverHttps](INFO): Moved sent file to Logs/20240506T160721/Courier0082.lzma.bak 2024-05-06T22:25:34.779Z,1715034334.779 [DataOverHttps](INFO): SBD MOMSN=19986525 2024-05-06T22:25:34.892Z,1715034334.892 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.655974 umol/s/m2 2024-05-06T22:25:35.278Z,1715034335.278 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.696332 umol/s/m2 2024-05-06T22:25:35.686Z,1715034335.686 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.578144 umol/s/m2 2024-05-06T22:25:36.098Z,1715034336.098 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.679036 umol/s/m2 2024-05-06T22:25:36.506Z,1715034336.506 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.664623 umol/s/m2 2024-05-06T22:25:36.893Z,1715034336.893 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.578144 umol/s/m2 2024-05-06T22:25:37.299Z,1715034337.299 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.494548 umol/s/m2 2024-05-06T22:25:37.713Z,1715034337.713 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.517609 umol/s/m2 2024-05-06T22:25:38.150Z,1715034338.150 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.644444 umol/s/m2 2024-05-06T22:25:38.570Z,1715034338.570 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.635797 umol/s/m2 2024-05-06T22:25:38.942Z,1715034338.942 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.604088 umol/s/m2 2024-05-06T22:25:39.357Z,1715034339.357 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.733805 umol/s/m2 2024-05-06T22:25:39.756Z,1715034339.756 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.722275 umol/s/m2 2024-05-06T22:25:40.146Z,1715034340.146 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.624266 umol/s/m2 2024-05-06T22:25:40.558Z,1715034340.558 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.618500 umol/s/m2 2024-05-06T22:25:40.961Z,1715034340.961 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.612735 umol/s/m2 2024-05-06T22:25:41.342Z,1715034341.342 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.540669 umol/s/m2 2024-05-06T22:25:41.746Z,1715034341.746 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.529140 umol/s/m2 2024-05-06T22:25:42.154Z,1715034342.154 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.506079 umol/s/m2 2024-05-06T22:25:42.565Z,1715034342.565 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.523374 umol/s/m2 2024-05-06T22:25:42.954Z,1715034342.954 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.546435 umol/s/m2 2024-05-06T22:25:43.398Z,1715034343.398 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:25:43.841Z,1715034343.841 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:25:44.334Z,1715034344.334 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.653092 umol/s/m2 2024-05-06T22:25:44.635Z,1715034344.635 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.664623 umol/s/m2 2024-05-06T22:25:45.018Z,1715034345.018 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.618500 umol/s/m2 2024-05-06T22:25:45.393Z,1715034345.393 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.575262 umol/s/m2 2024-05-06T22:25:45.801Z,1715034345.801 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.563731 umol/s/m2 2024-05-06T22:25:46.237Z,1715034346.237 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.532022 umol/s/m2 2024-05-06T22:25:46.639Z,1715034346.639 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.491665 umol/s/m2 2024-05-06T22:25:47.042Z,1715034347.042 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.511843 umol/s/m2 2024-05-06T22:25:47.428Z,1715034347.428 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.540669 umol/s/m2 2024-05-06T22:25:47.845Z,1715034347.845 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.630031 umol/s/m2 2024-05-06T22:25:48.223Z,1715034348.223 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.606970 umol/s/m2 2024-05-06T22:25:48.658Z,1715034348.658 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.702097 umol/s/m2 2024-05-06T22:25:49.103Z,1715034349.103 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.794341 umol/s/m2 2024-05-06T22:25:49.483Z,1715034349.483 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.860641 umol/s/m2 2024-05-06T22:25:49.867Z,1715034349.867 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.820284 umol/s/m2 2024-05-06T22:25:50.235Z,1715034350.234 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.846228 umol/s/m2 2024-05-06T22:25:50.645Z,1715034350.645 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.918293 umol/s/m2 2024-05-06T22:25:50.941Z,1715034350.941 [DataOverHttps](INFO): Sending 308 bytes from file Logs/20240506T211312/Courier0000.lzma 2024-05-06T22:25:51.057Z,1715034351.057 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.877936 umol/s/m2 2024-05-06T22:25:51.438Z,1715034351.438 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.889467 umol/s/m2 2024-05-06T22:25:51.846Z,1715034351.846 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.872172 umol/s/m2 2024-05-06T22:25:51.943Z,1715034351.943 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Courier0000.lzma.bak 2024-05-06T22:25:51.943Z,1715034351.943 [DataOverHttps](INFO): SBD MOMSN=19986527 2024-05-06T22:25:52.259Z,1715034352.259 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.831815 umol/s/m2 2024-05-06T22:25:52.650Z,1715034352.650 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.759749 umol/s/m2 2024-05-06T22:25:53.067Z,1715034353.067 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.817402 umol/s/m2 2024-05-06T22:25:53.466Z,1715034353.466 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.826049 umol/s/m2 2024-05-06T22:25:53.886Z,1715034353.886 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.820284 umol/s/m2 2024-05-06T22:25:54.297Z,1715034354.297 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.843346 umol/s/m2 2024-05-06T22:25:54.712Z,1715034354.712 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.820284 umol/s/m2 2024-05-06T22:25:55.122Z,1715034355.122 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.849111 umol/s/m2 2024-05-06T22:25:55.509Z,1715034355.509 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.843346 umol/s/m2 2024-05-06T22:25:55.919Z,1715034355.919 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.854875 umol/s/m2 2024-05-06T22:25:56.302Z,1715034356.302 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.883702 umol/s/m2 2024-05-06T22:25:56.715Z,1715034356.715 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 7.050893 umol/s/m2 2024-05-06T22:25:57.239Z,1715034357.239 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.944237 umol/s/m2 2024-05-06T22:25:57.660Z,1715034357.660 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.837580 umol/s/m2 2024-05-06T22:25:57.975Z,1715034357.975 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.886585 umol/s/m2 2024-05-06T22:25:58.356Z,1715034358.356 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.941354 umol/s/m2 2024-05-06T22:25:58.728Z,1715034358.728 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.843346 umol/s/m2 2024-05-06T22:25:59.146Z,1715034359.146 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.828932 umol/s/m2 2024-05-06T22:25:59.538Z,1715034359.538 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.768397 umol/s/m2 2024-05-06T22:25:59.936Z,1715034359.936 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.828932 umol/s/m2 2024-05-06T22:26:00.346Z,1715034360.346 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.900997 umol/s/m2 2024-05-06T22:26:00.730Z,1715034360.730 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.967298 umol/s/m2 2024-05-06T22:26:01.130Z,1715034361.130 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.964416 umol/s/m2 2024-05-06T22:26:01.544Z,1715034361.544 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.978828 umol/s/m2 2024-05-06T22:26:01.958Z,1715034361.958 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.967298 umol/s/m2 2024-05-06T22:26:02.345Z,1715034362.345 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.912528 umol/s/m2 2024-05-06T22:26:02.752Z,1715034362.752 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.929823 umol/s/m2 2024-05-06T22:26:03.161Z,1715034363.161 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.823167 umol/s/m2 2024-05-06T22:26:03.625Z,1715034363.625 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.785693 umol/s/m2 2024-05-06T22:26:03.998Z,1715034363.998 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.782810 umol/s/m2 2024-05-06T22:26:04.414Z,1715034364.414 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.762631 umol/s/m2 2024-05-06T22:26:04.798Z,1715034364.798 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.774162 umol/s/m2 2024-05-06T22:26:05.210Z,1715034365.210 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.817402 umol/s/m2 2024-05-06T22:26:05.629Z,1715034365.629 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.826049 umol/s/m2 2024-05-06T22:26:06.003Z,1715034366.003 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.886585 umol/s/m2 2024-05-06T22:26:06.415Z,1715034366.415 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.915411 umol/s/m2 2024-05-06T22:26:06.822Z,1715034366.822 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.906763 umol/s/m2 2024-05-06T22:26:07.199Z,1715034367.199 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.834697 umol/s/m2 2024-05-06T22:26:07.599Z,1715034367.599 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.788575 umol/s/m2 2024-05-06T22:26:07.901Z,1715034367.901 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20240506T211312/Courier0004.lzma 2024-05-06T22:26:08.012Z,1715034368.012 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.733805 umol/s/m2 2024-05-06T22:26:08.423Z,1715034368.423 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.785693 umol/s/m2 2024-05-06T22:26:08.810Z,1715034368.810 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.713627 umol/s/m2 2024-05-06T22:26:08.903Z,1715034368.903 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Courier0004.lzma.bak 2024-05-06T22:26:08.903Z,1715034368.903 [DataOverHttps](INFO): SBD MOMSN=19986535 2024-05-06T22:26:09.217Z,1715034369.217 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.647327 umol/s/m2 2024-05-06T22:26:09.639Z,1715034369.639 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.667505 umol/s/m2 2024-05-06T22:26:10.048Z,1715034370.048 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.670388 umol/s/m2 2024-05-06T22:26:10.564Z,1715034370.564 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.618500 umol/s/m2 2024-05-06T22:26:10.895Z,1715034370.895 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.621384 umol/s/m2 2024-05-06T22:26:11.258Z,1715034371.258 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.630031 umol/s/m2 2024-05-06T22:26:11.666Z,1715034371.666 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.644444 umol/s/m2 2024-05-06T22:26:12.081Z,1715034372.081 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.624266 umol/s/m2 2024-05-06T22:26:12.488Z,1715034372.488 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.670388 umol/s/m2 2024-05-06T22:26:12.874Z,1715034372.874 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.664623 umol/s/m2 2024-05-06T22:26:13.284Z,1715034373.284 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.733805 umol/s/m2 2024-05-06T22:26:13.694Z,1715034373.694 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.615618 umol/s/m2 2024-05-06T22:26:14.153Z,1715034374.153 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.606970 umol/s/m2 2024-05-06T22:26:14.490Z,1715034374.490 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.601205 umol/s/m2 2024-05-06T22:26:14.910Z,1715034374.910 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.667505 umol/s/m2 2024-05-06T22:26:15.325Z,1715034375.325 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.765515 umol/s/m2 2024-05-06T22:26:15.699Z,1715034375.699 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.831815 umol/s/m2 2024-05-06T22:26:16.099Z,1715034376.099 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.826049 umol/s/m2 2024-05-06T22:26:16.487Z,1715034376.487 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.851993 umol/s/m2 2024-05-06T22:26:16.889Z,1715034376.889 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.808753 umol/s/m2 2024-05-06T22:26:17.297Z,1715034377.297 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.875054 umol/s/m2 2024-05-06T22:26:17.710Z,1715034377.710 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.846228 umol/s/m2 2024-05-06T22:26:18.118Z,1715034378.118 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.849111 umol/s/m2 2024-05-06T22:26:18.512Z,1715034378.512 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.846228 umol/s/m2 2024-05-06T22:26:18.916Z,1715034378.916 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.828932 umol/s/m2 2024-05-06T22:26:19.330Z,1715034379.330 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.808753 umol/s/m2 2024-05-06T22:26:20.158Z,1715034380.158 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.782810 umol/s/m2 2024-05-06T22:26:20.575Z,1715034380.575 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.748219 umol/s/m2 2024-05-06T22:26:20.980Z,1715034380.980 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 6.687684 umol/s/m2 2024-05-06T22:26:21.324Z,1715034381.324 [CommandExec](IMPORTANT): got command report clear 2024-05-06T22:26:24.704Z,1715034384.704 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20240506T211312/Courier0007.lzma 2024-05-06T22:26:25.707Z,1715034385.707 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Courier0007.lzma.bak 2024-05-06T22:26:25.707Z,1715034385.707 [DataOverHttps](INFO): SBD MOMSN=19986538 2024-05-06T22:26:26.988Z,1715034386.988 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-06T22:25:26.8Z 2024-05-06T22:26:26.988Z,1715034386.988 [Startup:StartupSatComms:B] Stopped 2024-05-06T22:26:26.988Z,1715034386.988 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-05-06T22:26:26.988Z,1715034386.988 [Startup:StartupSatComms] Stopped 2024-05-06T22:26:26.988Z,1715034386.988 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-05-06T22:26:26.989Z,1715034386.989 [Startup](INFO): Completed Startup 2024-05-06T22:26:26.990Z,1715034386.990 [MissionManager](INFO): Startup is completed. 2024-05-06T22:26:26.990Z,1715034386.990 [MissionManager](INFO): Uninitializing Mission Startup 2024-05-06T22:26:26.990Z,1715034386.990 [Startup] Stopped 2024-05-06T22:26:26.990Z,1715034386.990 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-05-06T22:26:26.990Z,1715034386.990 [Startup:A.GoToSurface] Stopped 2024-05-06T22:26:26.990Z,1715034386.990 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-06T22:26:27.387Z,1715034387.387 [MissionManager](IMPORTANT): Started mission Default 2024-05-06T22:26:27.387Z,1715034387.387 [Default] Running Loop=1 2024-05-06T22:26:27.388Z,1715034387.388 [Default](DEBUG): Aggregate::initialize Default 2024-05-06T22:26:27.388Z,1715034387.388 [Default:B.GoToSurface] Running Loop=1 2024-05-06T22:26:27.388Z,1715034387.388 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-06T22:26:27.388Z,1715034387.388 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-06T22:26:27.388Z,1715034387.388 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-06T22:26:27.389Z,1715034387.389 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-06T22:26:27.389Z,1715034387.389 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-06T22:26:27.390Z,1715034387.390 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-06T22:26:27.390Z,1715034387.390 [Default:A.Wait] Running Loop=1 2024-05-06T22:26:27.390Z,1715034387.390 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-05-06T22:26:37.125Z,1715034397.125 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:26:37.125Z,1715034397.125 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:26:40.716Z,1715034400.716 [Default:A.Wait](INFO): Done Waiting. 2024-05-06T22:26:40.716Z,1715034400.716 [Default:A.Wait] Stopped 2024-05-06T22:26:40.716Z,1715034400.716 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T22:26:41.140Z,1715034401.140 [Default:CheckIn] Running Loop=1 2024-05-06T22:26:41.140Z,1715034401.140 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T22:26:41.140Z,1715034401.140 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T22:26:41.542Z,1715034401.542 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-05-06T22:27:04.945Z,1715034424.945 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-05-06T22:27:05.776Z,1715034425.776 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:27:05.776Z,1715034425.776 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:27:05.776Z,1715034425.776 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:27:05.846Z,1715034425.846 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:27:06.237Z,1715034426.237 [Waterlinked](INFO): Powering down 2024-05-06T22:27:07.030Z,1715034427.030 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:27:07.030Z,1715034427.030 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:27:08.521Z,1715034428.521 [DataOverHttps](INFO): Sending 309 bytes from file Logs/20240506T212851/Courier0000.lzma 2024-05-06T22:27:09.523Z,1715034429.523 [DataOverHttps](INFO): Moved sent file to Logs/20240506T212851/Courier0000.lzma.bak 2024-05-06T22:27:09.523Z,1715034429.523 [DataOverHttps](INFO): SBD MOMSN=19986542 2024-05-06T22:27:35.652Z,1715034455.652 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:27:35.652Z,1715034455.652 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:27:35.652Z,1715034455.652 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:27:35.693Z,1715034455.693 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:27:36.125Z,1715034456.125 [Waterlinked](INFO): Powering down 2024-05-06T22:27:36.888Z,1715034456.888 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:27:36.888Z,1715034456.888 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:27:51.002Z,1715034471.002 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-05-06T22:28:05.547Z,1715034485.547 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:28:05.547Z,1715034485.547 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:28:05.547Z,1715034485.547 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:28:05.584Z,1715034485.584 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:28:05.589Z,1715034485.589 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:28:06.034Z,1715034486.034 [Waterlinked](INFO): Powering down 2024-05-06T22:28:06.055Z,1715034486.055 [CBIT](INFO): Critical error at 20240506T222805 2024-05-06T22:28:09.206Z,1715034489.206 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-05-06T22:28:09.206Z,1715034489.206 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:28:09.207Z,1715034489.207 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-05-06T22:28:09.208Z,1715034489.208 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:28:09.241Z,1715034489.241 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:28:09.242Z,1715034489.242 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:28:09.620Z,1715034489.620 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:28:09.620Z,1715034489.620 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-05-06T22:28:09.620Z,1715034489.620 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:28:09.621Z,1715034489.621 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-05-06T22:28:10.010Z,1715034490.010 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:29:33.214Z,1715034573.214 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2024-05-06T22:29:33.217Z,1715034573.217 [BPC1](INFO): Received data from all battery sticks. 2024-05-06T22:31:05.749Z,1715034665.749 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:31:05.749Z,1715034665.749 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:31:10.181Z,1715034670.181 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-05-06T22:31:10.181Z,1715034670.181 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:31:10.182Z,1715034670.182 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-05-06T22:31:10.183Z,1715034670.183 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:31:10.193Z,1715034670.193 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:31:10.193Z,1715034670.193 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:31:10.595Z,1715034670.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:31:10.595Z,1715034670.595 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-05-06T22:31:10.595Z,1715034670.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:31:10.595Z,1715034670.595 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-05-06T22:31:10.996Z,1715034670.996 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:31:34.434Z,1715034694.434 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:31:34.434Z,1715034694.434 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:31:34.434Z,1715034694.434 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:31:34.478Z,1715034694.478 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:31:34.909Z,1715034694.909 [Waterlinked](INFO): Powering down 2024-05-06T22:31:35.665Z,1715034695.665 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:31:35.665Z,1715034695.665 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:31:41.296Z,1715034701.296 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T22:26:41.1Z 2024-05-06T22:31:41.296Z,1715034701.296 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T22:31:41.296Z,1715034701.296 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T22:31:41.707Z,1715034701.707 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-06T22:31:48.664Z,1715034708.664 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20240506T212851/Courier0004.lzma 2024-05-06T22:31:49.666Z,1715034709.666 [DataOverHttps](INFO): Moved sent file to Logs/20240506T212851/Courier0004.lzma.bak 2024-05-06T22:31:49.667Z,1715034709.667 [DataOverHttps](INFO): SBD MOMSN=19986569 2024-05-06T22:32:04.330Z,1715034724.330 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:32:04.330Z,1715034724.330 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:32:04.330Z,1715034724.330 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:32:04.353Z,1715034724.353 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:32:04.801Z,1715034724.801 [Waterlinked](INFO): Powering down 2024-05-06T22:32:05.221Z,1715034725.221 [DataOverHttps](INFO): Sending 310 bytes from file Logs/20240506T222157/Courier0000.lzma 2024-05-06T22:32:05.544Z,1715034725.544 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:32:05.544Z,1715034725.544 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:32:06.223Z,1715034726.223 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0000.lzma.bak 2024-05-06T22:32:06.223Z,1715034726.223 [DataOverHttps](INFO): SBD MOMSN=19986573 2024-05-06T22:32:21.949Z,1715034741.949 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20240506T222157/Courier0004.lzma 2024-05-06T22:32:22.951Z,1715034742.951 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0004.lzma.bak 2024-05-06T22:32:22.951Z,1715034742.951 [DataOverHttps](INFO): SBD MOMSN=19986727 2024-05-06T22:32:34.240Z,1715034754.240 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:32:34.240Z,1715034754.240 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:32:34.240Z,1715034754.240 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:32:34.274Z,1715034754.274 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:32:34.274Z,1715034754.274 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:32:34.681Z,1715034754.681 [Waterlinked](INFO): Powering down 2024-05-06T22:32:34.722Z,1715034754.722 [CBIT](INFO): Critical error at 20240506T223234 2024-05-06T22:32:38.404Z,1715034758.404 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240506T160721/Express0083.lzma 2024-05-06T22:32:38.669Z,1715034758.669 [Power24vConverter](INFO): Powering down. 2024-05-06T22:32:39.407Z,1715034759.407 [DataOverHttps](INFO): Moved sent file to Logs/20240506T160721/Express0083.lzma.bak 2024-05-06T22:32:39.407Z,1715034759.407 [DataOverHttps](INFO): SBD MOMSN=19986732 2024-05-06T22:32:48.356Z,1715034768.356 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T22:32:48.356Z,1715034768.356 [NAL9602] Data Fault, FailCount= 1 2024-05-06T22:32:48.356Z,1715034768.356 [NAL9602](ERROR): Data Fault 2024-05-06T22:32:48.374Z,1715034768.374 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T22:32:48.754Z,1715034768.754 [NAL9602](INFO): Powering down 2024-05-06T22:32:49.724Z,1715034769.724 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T22:32:49.724Z,1715034769.724 [NAL9602] No Fault, FailCount= 1 2024-05-06T22:32:54.890Z,1715034774.890 [DataOverHttps](INFO): Sending 1039 bytes from file Logs/20240506T211312/Express0001.lzma 2024-05-06T22:32:55.891Z,1715034775.891 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Express0001.lzma.bak 2024-05-06T22:32:55.891Z,1715034775.891 [DataOverHttps](INFO): SBD MOMSN=19986734 2024-05-06T22:33:11.197Z,1715034791.197 [DataOverHttps](INFO): Sending 306 bytes from file Logs/20240506T211312/Express0005.lzma 2024-05-06T22:33:12.199Z,1715034792.199 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Express0005.lzma.bak 2024-05-06T22:33:12.199Z,1715034792.199 [DataOverHttps](INFO): SBD MOMSN=19986765 2024-05-06T22:33:19.054Z,1715034799.054 [NAL9602](INFO): Powering up NAL9602 2024-05-06T22:33:28.001Z,1715034808.001 [DataOverHttps](INFO): Sending 440 bytes from file Logs/20240506T211312/Express0008.lzma 2024-05-06T22:33:29.003Z,1715034809.003 [DataOverHttps](INFO): Moved sent file to Logs/20240506T211312/Express0008.lzma.bak 2024-05-06T22:33:29.003Z,1715034809.003 [DataOverHttps](INFO): SBD MOMSN=19986777 2024-05-06T22:33:29.963Z,1715034809.963 [NAL9602](INFO): NAL9602 initialized 2024-05-06T22:33:43.426Z,1715034823.426 [DataOverHttps](INFO): Sending 1093 bytes from file Logs/20240506T212851/Express0001.lzma 2024-05-06T22:33:44.427Z,1715034824.427 [DataOverHttps](INFO): Moved sent file to Logs/20240506T212851/Express0001.lzma.bak 2024-05-06T22:33:44.427Z,1715034824.427 [DataOverHttps](INFO): SBD MOMSN=19986802 2024-05-06T22:33:59.837Z,1715034839.837 [DataOverHttps](INFO): Sending 686 bytes from file Logs/20240506T212851/Express0005.lzma 2024-05-06T22:34:00.838Z,1715034840.838 [DataOverHttps](INFO): Moved sent file to Logs/20240506T212851/Express0005.lzma.bak 2024-05-06T22:34:00.839Z,1715034840.839 [DataOverHttps](INFO): SBD MOMSN=19986837 2024-05-06T22:34:11.177Z,1715034851.177 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-05-06T22:34:11.177Z,1715034851.177 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:34:11.178Z,1715034851.178 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-05-06T22:34:11.178Z,1715034851.178 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:34:11.189Z,1715034851.189 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:34:11.189Z,1715034851.189 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:34:11.595Z,1715034851.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:34:11.595Z,1715034851.595 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-05-06T22:34:11.596Z,1715034851.596 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:34:11.596Z,1715034851.596 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-05-06T22:34:11.997Z,1715034851.997 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:34:16.347Z,1715034856.347 [DataOverHttps](INFO): Sending 1184 bytes from file Logs/20240506T222157/Express0001.lzma 2024-05-06T22:34:17.347Z,1715034857.347 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0001.lzma.bak 2024-05-06T22:34:17.347Z,1715034857.347 [DataOverHttps](INFO): SBD MOMSN=19986882 2024-05-06T22:34:32.729Z,1715034872.729 [DataOverHttps](INFO): Sending 258 bytes from file Logs/20240506T222157/Express0005.lzma 2024-05-06T22:34:33.731Z,1715034873.731 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0005.lzma.bak 2024-05-06T22:34:33.731Z,1715034873.731 [DataOverHttps](INFO): SBD MOMSN=19986916 2024-05-06T22:34:35.019Z,1715034875.019 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T22:34:35.020Z,1715034875.020 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T22:34:35.020Z,1715034875.020 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T22:35:34.412Z,1715034934.412 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:35:34.412Z,1715034934.412 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:35:35.203Z,1715034935.203 [Power24vConverter](INFO): Powering up. 2024-05-06T22:36:03.094Z,1715034963.094 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:36:03.094Z,1715034963.094 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:36:03.095Z,1715034963.095 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:36:03.111Z,1715034963.111 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:36:03.565Z,1715034963.565 [Waterlinked](INFO): Powering down 2024-05-06T22:36:04.308Z,1715034964.308 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:36:04.308Z,1715034964.308 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:36:32.976Z,1715034992.976 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:36:32.976Z,1715034992.976 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:36:32.976Z,1715034992.976 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:36:32.994Z,1715034992.994 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:36:33.449Z,1715034993.449 [Waterlinked](INFO): Powering down 2024-05-06T22:36:34.232Z,1715034994.232 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:36:34.232Z,1715034994.232 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:37:02.873Z,1715035022.873 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:37:02.873Z,1715035022.873 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:37:02.873Z,1715035022.873 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:37:02.890Z,1715035022.890 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:37:02.890Z,1715035022.890 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:37:03.337Z,1715035023.337 [Waterlinked](INFO): Powering down 2024-05-06T22:37:03.378Z,1715035023.378 [CBIT](INFO): Critical error at 20240506T223702 2024-05-06T22:37:09.367Z,1715035029.367 [CBIT](INFO): Clearing failed state for component DropWeight 2024-05-06T22:37:09.367Z,1715035029.367 [DropWeight] No Fault, FailCount= 1 2024-05-06T22:37:12.176Z,1715035032.176 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-05-06T22:37:12.176Z,1715035032.176 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:37:12.177Z,1715035032.177 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-05-06T22:37:12.177Z,1715035032.177 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:37:12.188Z,1715035032.188 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:37:12.188Z,1715035032.188 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:37:12.599Z,1715035032.599 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:37:12.599Z,1715035032.599 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-05-06T22:37:12.600Z,1715035032.600 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:37:12.600Z,1715035032.600 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-05-06T22:37:12.978Z,1715035032.978 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:38:41.853Z,1715035121.853 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-05-06T22:38:41.853Z,1715035121.853 [AHRS_M2] Data Fault, FailCount= 1 2024-05-06T22:38:41.853Z,1715035121.853 [AHRS_M2](ERROR): Data Fault 2024-05-06T22:38:41.896Z,1715035121.896 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-05-06T22:38:42.243Z,1715035122.243 [AHRS_M2](INFO): Powering down 2024-05-06T22:38:43.080Z,1715035123.080 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-06T22:38:43.080Z,1715035123.080 [AHRS_M2] No Fault, FailCount= 1 2024-05-06T22:38:43.455Z,1715035123.455 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T22:38:47.013Z,1715035127.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:47.068Z,1715035127.068 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:38:47.068Z,1715035127.068 [ElevatorServo] No Fault, FailCount= 3 2024-05-06T22:38:47.433Z,1715035127.433 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:47.873Z,1715035127.873 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:48.273Z,1715035128.273 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:48.673Z,1715035128.673 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:49.077Z,1715035129.077 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:49.477Z,1715035129.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:49.881Z,1715035129.881 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:50.313Z,1715035130.313 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:50.717Z,1715035130.717 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:51.129Z,1715035131.129 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:51.533Z,1715035131.533 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:51.585Z,1715035131.585 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:38:51.585Z,1715035131.585 [ElevatorServo] Hardware Fault, FailCount= 1 2024-05-06T22:38:51.585Z,1715035131.585 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:38:51.630Z,1715035131.630 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:38:51.961Z,1715035131.961 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:51.994Z,1715035131.994 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:38:51.995Z,1715035131.995 [ElevatorServo](INFO): Powering down 2024-05-06T22:38:52.369Z,1715035132.369 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:52.765Z,1715035132.765 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:52.808Z,1715035132.808 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:38:52.926Z,1715035132.926 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:38:52.931Z,1715035132.931 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:38:52.931Z,1715035132.931 [ElevatorServo] No Fault, FailCount= 1 2024-05-06T22:38:53.261Z,1715035133.261 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:53.669Z,1715035133.669 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:54.081Z,1715035134.081 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:54.497Z,1715035134.497 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:54.901Z,1715035134.901 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:55.305Z,1715035135.305 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:55.709Z,1715035135.709 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:56.121Z,1715035136.121 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:56.289Z,1715035136.289 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2024-05-06T22:38:56.289Z,1715035136.289 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-05-06T22:38:56.289Z,1715035136.289 [AHRS_M2] Communications Fault, FailCount= 2 2024-05-06T22:38:56.289Z,1715035136.289 [AHRS_M2](ERROR): Communications Fault 2024-05-06T22:38:56.389Z,1715035136.389 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-05-06T22:38:56.599Z,1715035136.599 [AHRS_M2](INFO): Powering down 2024-05-06T22:38:57.462Z,1715035137.462 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-06T22:38:57.462Z,1715035137.462 [AHRS_M2] No Fault, FailCount= 2 2024-05-06T22:38:57.812Z,1715035137.812 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T22:38:57.881Z,1715035137.881 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:38:57.881Z,1715035137.881 [ElevatorServo] Hardware Fault, FailCount= 2 2024-05-06T22:38:57.881Z,1715035137.881 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:38:57.926Z,1715035137.926 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:38:58.256Z,1715035138.256 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:38:58.256Z,1715035138.256 [ElevatorServo](INFO): Powering down 2024-05-06T22:38:59.043Z,1715035139.043 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:38:59.158Z,1715035139.158 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:38:59.164Z,1715035139.164 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:38:59.164Z,1715035139.164 [ElevatorServo] No Fault, FailCount= 2 2024-05-06T22:39:04.361Z,1715035144.361 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:39:04.361Z,1715035144.361 [ElevatorServo] Hardware Fault, FailCount= 3 2024-05-06T22:39:04.361Z,1715035144.361 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:39:04.390Z,1715035144.390 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:39:04.390Z,1715035144.390 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-05-06T22:39:04.746Z,1715035144.746 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:39:04.746Z,1715035144.746 [ElevatorServo](INFO): Powering down 2024-05-06T22:39:04.749Z,1715035144.749 [CBIT](INFO): Critical error at 20240506T223904 2024-05-06T22:39:05.528Z,1715035145.528 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:39:05.646Z,1715035145.646 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:39:11.157Z,1715035151.157 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-05-06T22:39:11.157Z,1715035151.157 [AHRS_M2] Data Fault, FailCount= 3 2024-05-06T22:39:11.157Z,1715035151.157 [AHRS_M2](ERROR): Data Fault 2024-05-06T22:39:11.183Z,1715035151.183 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-05-06T22:39:11.547Z,1715035151.547 [AHRS_M2](INFO): Powering down 2024-05-06T22:39:12.379Z,1715035152.379 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-06T22:39:12.379Z,1715035152.379 [AHRS_M2] No Fault, FailCount= 3 2024-05-06T22:39:12.760Z,1715035152.760 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T22:39:26.105Z,1715035166.105 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2024-05-06T22:39:26.105Z,1715035166.105 [AHRS_M2] Data Fault, FailCount= 4 2024-05-06T22:39:26.105Z,1715035166.105 [AHRS_M2](ERROR): Data Fault 2024-05-06T22:39:26.132Z,1715035166.132 [CBIT](ERROR): Data Fault in component: AHRS_M2 2024-05-06T22:39:26.495Z,1715035166.495 [AHRS_M2](INFO): Powering down 2024-05-06T22:39:27.327Z,1715035167.327 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-06T22:39:27.327Z,1715035167.327 [AHRS_M2] No Fault, FailCount= 4 2024-05-06T22:39:27.707Z,1715035167.707 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T22:39:35.803Z,1715035175.803 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T22:39:35.803Z,1715035175.803 [Default:CheckIn:C.Wait] Stopped 2024-05-06T22:39:35.803Z,1715035175.803 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T22:39:35.803Z,1715035175.803 [Default:CheckIn:D] Running Loop=1 2024-05-06T22:39:36.215Z,1715035176.215 [Default:CheckIn:D] Stopped 2024-05-06T22:39:36.215Z,1715035176.215 [Default:CheckIn:E] Running Loop=1 2024-05-06T22:39:36.623Z,1715035176.623 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.147130 min 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn:E] Stopped 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn] Stopped 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn](INFO): Running loop #2 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn] Running Loop=2 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T22:39:36.624Z,1715035176.624 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T22:40:02.904Z,1715035202.904 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:40:02.904Z,1715035202.904 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:40:13.382Z,1715035213.382 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-05-06T22:40:13.382Z,1715035213.382 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:40:13.383Z,1715035213.383 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-05-06T22:40:13.383Z,1715035213.383 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:40:13.394Z,1715035213.394 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:40:13.394Z,1715035213.394 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:40:13.811Z,1715035213.811 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:40:13.811Z,1715035213.811 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-05-06T22:40:13.812Z,1715035213.812 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:40:13.812Z,1715035213.812 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-05-06T22:40:14.208Z,1715035214.208 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:40:31.548Z,1715035231.548 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:40:31.548Z,1715035231.548 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:40:31.548Z,1715035231.548 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:40:31.616Z,1715035231.616 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:40:32.033Z,1715035232.033 [Waterlinked](INFO): Powering down 2024-05-06T22:40:32.848Z,1715035232.848 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:40:32.848Z,1715035232.848 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:41:01.460Z,1715035261.460 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:41:01.460Z,1715035261.460 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:41:01.460Z,1715035261.460 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:41:01.509Z,1715035261.509 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:41:01.941Z,1715035261.941 [Waterlinked](INFO): Powering down 2024-05-06T22:41:02.709Z,1715035262.709 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:41:02.709Z,1715035262.709 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:41:31.372Z,1715035291.372 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:41:31.372Z,1715035291.372 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:41:31.372Z,1715035291.372 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:41:31.414Z,1715035291.414 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:41:31.414Z,1715035291.414 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:41:31.845Z,1715035291.845 [Waterlinked](INFO): Powering down 2024-05-06T22:41:31.874Z,1715035291.874 [CBIT](INFO): Critical error at 20240506T224131 2024-05-06T22:43:14.378Z,1715035394.378 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-05-06T22:43:14.378Z,1715035394.378 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:43:14.379Z,1715035394.379 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-05-06T22:43:14.379Z,1715035394.379 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:43:14.390Z,1715035394.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:43:14.390Z,1715035394.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:43:14.819Z,1715035394.819 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:43:14.820Z,1715035394.820 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-05-06T22:43:14.820Z,1715035394.820 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:43:14.820Z,1715035394.820 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-05-06T22:43:15.209Z,1715035395.209 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:43:32.963Z,1715035412.963 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T22:43:32.963Z,1715035412.963 [NAL9602] Data Fault, FailCount= 2 2024-05-06T22:43:32.963Z,1715035412.963 [NAL9602](ERROR): Data Fault 2024-05-06T22:43:32.986Z,1715035412.986 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T22:43:33.362Z,1715035413.362 [NAL9602](INFO): Powering down 2024-05-06T22:43:34.187Z,1715035414.187 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T22:43:34.187Z,1715035414.187 [NAL9602] No Fault, FailCount= 2 2024-05-06T22:44:03.658Z,1715035443.658 [NAL9602](INFO): Powering up NAL9602 2024-05-06T22:44:14.571Z,1715035454.571 [NAL9602](INFO): NAL9602 initialized 2024-05-06T22:44:31.556Z,1715035471.556 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:44:31.556Z,1715035471.556 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:44:36.819Z,1715035476.819 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T22:39:36.6Z 2024-05-06T22:44:36.819Z,1715035476.819 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T22:44:36.819Z,1715035476.819 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T22:44:41.796Z,1715035481.796 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240506T222157/Courier0007.lzma 2024-05-06T22:44:42.798Z,1715035482.798 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0007.lzma.bak 2024-05-06T22:44:42.799Z,1715035482.799 [DataOverHttps](INFO): SBD MOMSN=19986936 2024-05-06T22:44:58.177Z,1715035498.177 [DataOverHttps](INFO): Sending 341 bytes from file Logs/20240506T222157/Express0008.lzma 2024-05-06T22:44:59.179Z,1715035499.179 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0008.lzma.bak 2024-05-06T22:44:59.179Z,1715035499.179 [DataOverHttps](INFO): SBD MOMSN=19986945 2024-05-06T22:45:00.234Z,1715035500.234 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:45:00.234Z,1715035500.234 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:45:00.234Z,1715035500.234 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:45:00.299Z,1715035500.299 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:45:00.709Z,1715035500.709 [Waterlinked](INFO): Powering down 2024-05-06T22:45:00.724Z,1715035500.724 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T22:45:00.724Z,1715035500.724 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T22:45:00.724Z,1715035500.724 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T22:45:01.482Z,1715035501.482 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:45:01.482Z,1715035501.482 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:45:30.119Z,1715035530.119 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:45:30.119Z,1715035530.119 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:45:30.119Z,1715035530.119 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:45:30.162Z,1715035530.162 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:45:30.593Z,1715035530.593 [Waterlinked](INFO): Powering down 2024-05-06T22:45:31.372Z,1715035531.372 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:45:31.372Z,1715035531.372 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:46:00.016Z,1715035560.016 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:46:00.016Z,1715035560.016 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:46:00.016Z,1715035560.016 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:46:00.049Z,1715035560.049 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:46:00.049Z,1715035560.049 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:46:00.489Z,1715035560.489 [Waterlinked](INFO): Powering down 2024-05-06T22:46:00.515Z,1715035560.515 [CBIT](INFO): Critical error at 20240506T224600 2024-05-06T22:46:04.474Z,1715035564.474 [Power24vConverter](INFO): Powering down. 2024-05-06T22:46:15.405Z,1715035575.405 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-05-06T22:46:15.405Z,1715035575.405 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:46:15.407Z,1715035575.407 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-05-06T22:46:15.407Z,1715035575.407 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:46:15.430Z,1715035575.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:46:15.430Z,1715035575.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:46:15.802Z,1715035575.802 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:46:15.803Z,1715035575.803 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-05-06T22:46:15.803Z,1715035575.803 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:46:15.803Z,1715035575.803 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-05-06T22:46:16.189Z,1715035576.189 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:49:00.229Z,1715035740.229 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:49:00.229Z,1715035740.229 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:49:01.003Z,1715035741.003 [Power24vConverter](INFO): Powering up. 2024-05-06T22:49:16.386Z,1715035756.386 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-05-06T22:49:16.386Z,1715035756.386 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:49:16.387Z,1715035756.387 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-05-06T22:49:16.387Z,1715035756.387 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:49:16.398Z,1715035756.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:49:16.398Z,1715035756.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:49:16.786Z,1715035756.786 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:49:16.786Z,1715035756.786 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-05-06T22:49:16.787Z,1715035756.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:49:16.787Z,1715035756.787 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-05-06T22:49:17.170Z,1715035757.170 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:49:28.884Z,1715035768.884 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:49:28.884Z,1715035768.884 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:49:28.884Z,1715035768.884 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:49:28.901Z,1715035768.901 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:49:29.357Z,1715035769.357 [Waterlinked](INFO): Powering down 2024-05-06T22:49:30.112Z,1715035770.112 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:49:30.112Z,1715035770.112 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:49:58.780Z,1715035798.780 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:49:58.780Z,1715035798.780 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:49:58.780Z,1715035798.780 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:49:58.797Z,1715035798.797 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:49:59.245Z,1715035799.245 [Waterlinked](INFO): Powering down 2024-05-06T22:50:00.008Z,1715035800.008 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:50:00.008Z,1715035800.008 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:50:01.236Z,1715035801.236 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T22:50:01.236Z,1715035801.236 [Default:CheckIn:C.Wait] Stopped 2024-05-06T22:50:01.236Z,1715035801.236 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T22:50:01.236Z,1715035801.236 [Default:CheckIn:D] Running Loop=1 2024-05-06T22:50:01.615Z,1715035801.615 [Default:CheckIn:D] Stopped 2024-05-06T22:50:01.615Z,1715035801.615 [Default:CheckIn:E] Running Loop=1 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.570457 min 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn:E] Stopped 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn] Stopped 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn](INFO): Running loop #3 2024-05-06T22:50:02.020Z,1715035802.020 [Default:CheckIn] Running Loop=3 2024-05-06T22:50:02.021Z,1715035802.021 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T22:50:02.021Z,1715035802.021 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T22:50:28.696Z,1715035828.696 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:50:28.696Z,1715035828.696 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:50:28.696Z,1715035828.696 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:50:28.724Z,1715035828.724 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:50:28.724Z,1715035828.724 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:50:29.157Z,1715035829.157 [Waterlinked](INFO): Powering down 2024-05-06T22:50:29.178Z,1715035829.178 [CBIT](INFO): Critical error at 20240506T225028 2024-05-06T22:52:17.357Z,1715035937.357 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-05-06T22:52:17.358Z,1715035937.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:52:17.359Z,1715035937.359 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-05-06T22:52:17.359Z,1715035937.359 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:52:17.369Z,1715035937.369 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:52:17.370Z,1715035937.370 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:52:17.777Z,1715035937.777 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:52:17.777Z,1715035937.777 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-05-06T22:52:17.778Z,1715035937.778 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:52:17.778Z,1715035937.778 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-05-06T22:52:18.165Z,1715035938.165 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:53:28.911Z,1715036008.911 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:53:28.911Z,1715036008.911 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:53:57.540Z,1715036037.540 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:53:57.540Z,1715036037.540 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:53:57.540Z,1715036037.540 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:53:57.585Z,1715036037.585 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:53:58.017Z,1715036038.017 [Waterlinked](INFO): Powering down 2024-05-06T22:53:58.777Z,1715036038.777 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:53:58.777Z,1715036038.777 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:54:04.444Z,1715036044.444 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:54:04.447Z,1715036044.447 [ElevatorServo] No Fault, FailCount= 3 2024-05-06T22:54:08.909Z,1715036048.909 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:54:08.909Z,1715036048.909 [ElevatorServo] Hardware Fault, FailCount= 1 2024-05-06T22:54:08.909Z,1715036048.909 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:54:08.942Z,1715036048.942 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:54:09.296Z,1715036049.296 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:54:09.296Z,1715036049.296 [ElevatorServo](INFO): Powering down 2024-05-06T22:54:10.086Z,1715036050.086 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:54:10.203Z,1715036050.203 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:54:10.208Z,1715036050.208 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:54:10.208Z,1715036050.208 [ElevatorServo] No Fault, FailCount= 1 2024-05-06T22:54:15.377Z,1715036055.377 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:54:15.377Z,1715036055.377 [ElevatorServo] Hardware Fault, FailCount= 2 2024-05-06T22:54:15.377Z,1715036055.377 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:54:15.406Z,1715036055.406 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:54:15.721Z,1715036055.721 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T22:54:15.722Z,1715036055.722 [NAL9602] Data Fault, FailCount= 3 2024-05-06T22:54:15.722Z,1715036055.722 [NAL9602](ERROR): Data Fault 2024-05-06T22:54:15.736Z,1715036055.736 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:54:15.736Z,1715036055.736 [ElevatorServo](INFO): Powering down 2024-05-06T22:54:15.741Z,1715036055.741 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T22:54:16.127Z,1715036056.127 [NAL9602](INFO): Powering down 2024-05-06T22:54:16.551Z,1715036056.551 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:54:16.666Z,1715036056.666 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:54:16.671Z,1715036056.671 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T22:54:16.671Z,1715036056.671 [ElevatorServo] No Fault, FailCount= 2 2024-05-06T22:54:16.968Z,1715036056.968 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T22:54:16.968Z,1715036056.968 [NAL9602] No Fault, FailCount= 3 2024-05-06T22:54:21.837Z,1715036061.837 [ElevatorServo](FAULT): Overload Error 2024-05-06T22:54:21.837Z,1715036061.837 [ElevatorServo] Hardware Fault, FailCount= 3 2024-05-06T22:54:21.837Z,1715036061.837 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T22:54:21.869Z,1715036061.869 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T22:54:21.870Z,1715036061.870 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-05-06T22:54:22.200Z,1715036062.200 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T22:54:22.200Z,1715036062.200 [ElevatorServo](INFO): Powering down 2024-05-06T22:54:22.203Z,1715036062.203 [CBIT](INFO): Critical error at 20240506T225421 2024-05-06T22:54:23.015Z,1715036063.015 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T22:54:23.130Z,1715036063.130 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T22:54:27.435Z,1715036067.435 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:54:27.436Z,1715036067.436 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:54:27.436Z,1715036067.436 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:54:27.469Z,1715036067.469 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:54:27.909Z,1715036067.909 [Waterlinked](INFO): Powering down 2024-05-06T22:54:28.700Z,1715036068.700 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:54:28.700Z,1715036068.700 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:54:46.425Z,1715036086.425 [NAL9602](INFO): Powering up NAL9602 2024-05-06T22:54:57.335Z,1715036097.335 [NAL9602](INFO): NAL9602 initialized 2024-05-06T22:54:57.336Z,1715036097.336 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:54:57.336Z,1715036097.336 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:54:57.336Z,1715036097.336 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:54:57.373Z,1715036097.373 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:54:57.373Z,1715036097.373 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:54:57.809Z,1715036097.809 [Waterlinked](INFO): Powering down 2024-05-06T22:54:57.834Z,1715036097.834 [CBIT](INFO): Critical error at 20240506T225457 2024-05-06T22:55:02.199Z,1715036102.199 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T22:50:02.0Z 2024-05-06T22:55:02.199Z,1715036102.199 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T22:55:02.199Z,1715036102.199 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T22:55:07.156Z,1715036107.156 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240506T222157/Courier0010.lzma 2024-05-06T22:55:08.159Z,1715036108.159 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0010.lzma.bak 2024-05-06T22:55:08.159Z,1715036108.159 [DataOverHttps](INFO): SBD MOMSN=19987014 2024-05-06T22:55:18.369Z,1715036118.369 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-05-06T22:55:18.369Z,1715036118.369 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:55:18.371Z,1715036118.371 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-05-06T22:55:18.371Z,1715036118.371 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:55:18.415Z,1715036118.415 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:55:18.415Z,1715036118.415 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:55:18.788Z,1715036118.788 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:55:18.788Z,1715036118.788 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-05-06T22:55:18.788Z,1715036118.788 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:55:18.788Z,1715036118.788 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-05-06T22:55:19.181Z,1715036119.181 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:55:23.617Z,1715036123.617 [DataOverHttps](INFO): Sending 246 bytes from file Logs/20240506T222157/Express0011.lzma 2024-05-06T22:55:24.619Z,1715036124.619 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0011.lzma.bak 2024-05-06T22:55:24.619Z,1715036124.619 [DataOverHttps](INFO): SBD MOMSN=19987027 2024-05-06T22:55:26.031Z,1715036126.031 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T22:55:26.031Z,1715036126.031 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T22:55:26.031Z,1715036126.031 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T22:57:57.552Z,1715036277.552 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:57:57.553Z,1715036277.553 [Waterlinked] No Fault, FailCount= 3 2024-05-06T22:58:19.372Z,1715036299.372 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-05-06T22:58:19.372Z,1715036299.372 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T22:58:19.373Z,1715036299.373 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-05-06T22:58:19.373Z,1715036299.373 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T22:58:19.384Z,1715036299.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T22:58:19.384Z,1715036299.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T22:58:19.799Z,1715036299.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T22:58:19.799Z,1715036299.799 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-05-06T22:58:19.799Z,1715036299.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T22:58:19.799Z,1715036299.799 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-05-06T22:58:20.179Z,1715036300.179 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T22:58:26.214Z,1715036306.214 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:58:26.214Z,1715036306.214 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T22:58:26.214Z,1715036306.214 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:58:26.276Z,1715036306.276 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:58:26.669Z,1715036306.669 [Waterlinked](INFO): Powering down 2024-05-06T22:58:27.469Z,1715036307.469 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:58:27.469Z,1715036307.469 [Waterlinked] No Fault, FailCount= 1 2024-05-06T22:58:56.118Z,1715036336.118 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:58:56.118Z,1715036336.118 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T22:58:56.118Z,1715036336.118 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:58:56.161Z,1715036336.161 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:58:56.589Z,1715036336.589 [Waterlinked](INFO): Powering down 2024-05-06T22:58:57.328Z,1715036337.328 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T22:58:57.328Z,1715036337.328 [Waterlinked] No Fault, FailCount= 2 2024-05-06T22:59:25.992Z,1715036365.992 [Waterlinked](FAULT): Could not initialize. 2024-05-06T22:59:25.992Z,1715036365.992 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T22:59:25.992Z,1715036365.992 [Waterlinked](ERROR): Communications Fault 2024-05-06T22:59:26.028Z,1715036366.028 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T22:59:26.028Z,1715036366.028 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T22:59:26.469Z,1715036366.469 [Waterlinked](INFO): Powering down 2024-05-06T22:59:26.494Z,1715036366.494 [CBIT](INFO): Critical error at 20240506T225926 2024-05-06T22:59:30.453Z,1715036370.453 [Power24vConverter](INFO): Powering down. 2024-05-06T23:00:26.599Z,1715036426.599 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T23:00:26.599Z,1715036426.599 [Default:CheckIn:C.Wait] Stopped 2024-05-06T23:00:26.600Z,1715036426.600 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T23:00:26.600Z,1715036426.600 [Default:CheckIn:D] Running Loop=1 2024-05-06T23:00:27.006Z,1715036427.006 [Default:CheckIn:D] Stopped 2024-05-06T23:00:27.006Z,1715036427.006 [Default:CheckIn:E] Running Loop=1 2024-05-06T23:00:27.409Z,1715036427.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.993646 min 2024-05-06T23:00:27.409Z,1715036427.409 [Default:CheckIn:E] Stopped 2024-05-06T23:00:27.409Z,1715036427.409 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T23:00:27.409Z,1715036427.409 [Default:CheckIn] Stopped 2024-05-06T23:00:27.409Z,1715036427.409 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T23:00:27.410Z,1715036427.410 [Default:CheckIn](INFO): Running loop #4 2024-05-06T23:00:27.410Z,1715036427.410 [Default:CheckIn] Running Loop=4 2024-05-06T23:00:27.410Z,1715036427.410 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T23:00:27.410Z,1715036427.410 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T23:01:20.359Z,1715036480.359 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-05-06T23:01:20.359Z,1715036480.359 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:01:20.361Z,1715036480.361 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-05-06T23:01:20.361Z,1715036480.361 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:01:20.371Z,1715036480.371 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:01:20.371Z,1715036480.371 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:01:20.783Z,1715036480.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:01:20.783Z,1715036480.783 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-05-06T23:01:20.784Z,1715036480.784 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:01:20.784Z,1715036480.784 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-05-06T23:01:21.181Z,1715036481.181 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:02:26.225Z,1715036546.225 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:02:26.225Z,1715036546.225 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:02:26.999Z,1715036546.999 [Power24vConverter](INFO): Powering up. 2024-05-06T23:02:54.896Z,1715036574.896 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:02:54.896Z,1715036574.896 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:02:54.897Z,1715036574.897 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:02:54.921Z,1715036574.921 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:02:55.349Z,1715036575.349 [Waterlinked](INFO): Powering down 2024-05-06T23:02:56.125Z,1715036576.125 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:02:56.125Z,1715036576.125 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:03:24.772Z,1715036604.772 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:03:24.772Z,1715036604.772 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:03:24.772Z,1715036604.772 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:03:24.789Z,1715036604.789 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:03:25.237Z,1715036605.237 [Waterlinked](INFO): Powering down 2024-05-06T23:03:26.000Z,1715036606.000 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:03:26.001Z,1715036606.001 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:03:54.676Z,1715036634.676 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:03:54.676Z,1715036634.676 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:03:54.676Z,1715036634.676 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:03:54.694Z,1715036634.694 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:03:54.694Z,1715036634.694 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:03:55.153Z,1715036635.153 [Waterlinked](INFO): Powering down 2024-05-06T23:03:55.175Z,1715036635.175 [CBIT](INFO): Critical error at 20240506T230354 2024-05-06T23:04:21.369Z,1715036661.369 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-05-06T23:04:21.369Z,1715036661.369 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:04:21.370Z,1715036661.370 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2024-05-06T23:04:21.370Z,1715036661.370 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:04:21.381Z,1715036661.381 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:04:21.381Z,1715036661.381 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:04:21.784Z,1715036661.784 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:04:21.784Z,1715036661.784 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-05-06T23:04:21.785Z,1715036661.785 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:04:21.785Z,1715036661.785 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2024-05-06T23:04:22.170Z,1715036662.170 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:04:58.495Z,1715036698.495 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T23:04:58.495Z,1715036698.495 [NAL9602] Data Fault, FailCount= 4 2024-05-06T23:04:58.495Z,1715036698.495 [NAL9602](ERROR): Data Fault 2024-05-06T23:04:58.534Z,1715036698.534 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T23:04:58.902Z,1715036698.902 [NAL9602](INFO): Powering down 2024-05-06T23:04:59.731Z,1715036699.731 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T23:04:59.731Z,1715036699.731 [NAL9602] No Fault, FailCount= 4 2024-05-06T23:05:27.598Z,1715036727.598 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T23:00:27.4Z 2024-05-06T23:05:27.598Z,1715036727.598 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T23:05:27.598Z,1715036727.598 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T23:05:29.199Z,1715036729.199 [NAL9602](INFO): Powering up NAL9602 2024-05-06T23:05:32.464Z,1715036732.464 [DataOverHttps](INFO): Sending 98 bytes from file Logs/20240506T222157/Courier0013.lzma 2024-05-06T23:05:33.467Z,1715036733.467 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0013.lzma.bak 2024-05-06T23:05:33.467Z,1715036733.467 [DataOverHttps](INFO): SBD MOMSN=19987050 2024-05-06T23:05:40.107Z,1715036740.107 [NAL9602](INFO): NAL9602 initialized 2024-05-06T23:05:49.332Z,1715036749.332 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20240506T222157/Express0014.lzma 2024-05-06T23:05:50.335Z,1715036750.335 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0014.lzma.bak 2024-05-06T23:05:50.335Z,1715036750.335 [DataOverHttps](INFO): SBD MOMSN=19987054 2024-05-06T23:05:51.859Z,1715036751.859 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T23:05:51.859Z,1715036751.859 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T23:05:51.859Z,1715036751.859 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T23:06:54.900Z,1715036814.900 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:06:54.900Z,1715036814.900 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:07:10.618Z,1715036830.618 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-05-06T23:07:10.618Z,1715036830.618 [DropWeight] Hardware Fault, FailCount= 1 2024-05-06T23:07:10.618Z,1715036830.618 [DropWeight](ERROR): Hardware Fault 2024-05-06T23:07:10.635Z,1715036830.635 [CBIT](INFO): Critical error at 20240506T230710 2024-05-06T23:07:10.637Z,1715036830.637 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-05-06T23:07:10.638Z,1715036830.638 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-05-06T23:07:11.043Z,1715036831.043 [CBIT](INFO): Critical error at 20240506T230710 2024-05-06T23:07:22.326Z,1715036842.326 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-05-06T23:07:22.326Z,1715036842.326 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:07:22.327Z,1715036842.327 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2024-05-06T23:07:22.327Z,1715036842.327 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:07:22.362Z,1715036842.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:07:22.362Z,1715036842.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:07:22.743Z,1715036842.743 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:07:22.744Z,1715036842.744 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-05-06T23:07:22.744Z,1715036842.744 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:07:22.744Z,1715036842.744 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2024-05-06T23:07:23.139Z,1715036843.139 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:07:23.532Z,1715036843.532 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:07:23.532Z,1715036843.532 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:07:23.532Z,1715036843.532 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:07:23.569Z,1715036843.569 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:07:24.017Z,1715036844.017 [Waterlinked](INFO): Powering down 2024-05-06T23:07:24.779Z,1715036844.779 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:07:24.779Z,1715036844.779 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:07:53.431Z,1715036873.431 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:07:53.431Z,1715036873.431 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:07:53.431Z,1715036873.431 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:07:53.469Z,1715036873.469 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:07:53.897Z,1715036873.897 [Waterlinked](INFO): Powering down 2024-05-06T23:07:54.667Z,1715036874.667 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:07:54.667Z,1715036874.667 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:08:23.328Z,1715036903.328 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:08:23.328Z,1715036903.328 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:08:23.328Z,1715036903.328 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:08:23.345Z,1715036903.345 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:08:23.345Z,1715036903.345 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:08:23.797Z,1715036903.797 [Waterlinked](INFO): Powering down 2024-05-06T23:08:23.819Z,1715036903.819 [CBIT](INFO): Critical error at 20240506T230823 2024-05-06T23:09:10.531Z,1715036950.531 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-05-06T23:09:10.535Z,1715036950.535 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2024-05-06T23:09:10.645Z,1715036950.645 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:09:21.986Z,1715036961.986 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T23:09:21.986Z,1715036961.986 [ElevatorServo] No Fault, FailCount= 3 2024-05-06T23:09:26.445Z,1715036966.445 [ElevatorServo](FAULT): Overload Error 2024-05-06T23:09:26.445Z,1715036966.445 [ElevatorServo] Hardware Fault, FailCount= 1 2024-05-06T23:09:26.445Z,1715036966.445 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T23:09:26.482Z,1715036966.482 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T23:09:26.827Z,1715036966.827 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T23:09:26.827Z,1715036966.827 [ElevatorServo](INFO): Powering down 2024-05-06T23:09:27.654Z,1715036967.654 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T23:09:27.774Z,1715036967.774 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T23:09:27.779Z,1715036967.779 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T23:09:27.779Z,1715036967.779 [ElevatorServo] No Fault, FailCount= 1 2024-05-06T23:09:32.893Z,1715036972.893 [ElevatorServo](FAULT): Overload Error 2024-05-06T23:09:32.893Z,1715036972.893 [ElevatorServo] Hardware Fault, FailCount= 2 2024-05-06T23:09:32.893Z,1715036972.893 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T23:09:32.922Z,1715036972.922 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T23:09:33.282Z,1715036973.282 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T23:09:33.282Z,1715036973.282 [ElevatorServo](INFO): Powering down 2024-05-06T23:09:34.082Z,1715036974.082 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T23:09:34.202Z,1715036974.202 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T23:09:34.207Z,1715036974.207 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-05-06T23:09:34.207Z,1715036974.207 [ElevatorServo] No Fault, FailCount= 2 2024-05-06T23:09:39.361Z,1715036979.361 [ElevatorServo](FAULT): Overload Error 2024-05-06T23:09:39.361Z,1715036979.361 [ElevatorServo] Hardware Fault, FailCount= 3 2024-05-06T23:09:39.361Z,1715036979.361 [ElevatorServo](ERROR): Hardware Fault 2024-05-06T23:09:39.410Z,1715036979.410 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-05-06T23:09:39.410Z,1715036979.410 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-05-06T23:09:39.735Z,1715036979.735 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T23:09:39.735Z,1715036979.735 [ElevatorServo](INFO): Powering down 2024-05-06T23:09:39.755Z,1715036979.755 [CBIT](INFO): Critical error at 20240506T230939 2024-05-06T23:09:40.530Z,1715036980.530 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T23:09:40.650Z,1715036980.650 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T23:10:23.330Z,1715037023.330 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-05-06T23:10:23.330Z,1715037023.330 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:10:23.331Z,1715037023.331 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2024-05-06T23:10:23.331Z,1715037023.331 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:10:23.407Z,1715037023.407 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:10:23.407Z,1715037023.407 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:10:23.782Z,1715037023.782 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:10:23.782Z,1715037023.782 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-05-06T23:10:23.782Z,1715037023.782 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:10:23.782Z,1715037023.782 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2024-05-06T23:10:24.136Z,1715037024.136 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:10:28.043Z,1715037028.043 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitFwd millimeter 2024-05-06T23:10:28.044Z,1715037028.044 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitFwd 38.000000 mm 2024-05-06T23:10:52.424Z,1715037052.424 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T23:10:52.424Z,1715037052.424 [Default:CheckIn:C.Wait] Stopped 2024-05-06T23:10:52.424Z,1715037052.424 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T23:10:52.424Z,1715037052.424 [Default:CheckIn:D] Running Loop=1 2024-05-06T23:10:52.846Z,1715037052.846 [Default:CheckIn:D] Stopped 2024-05-06T23:10:52.846Z,1715037052.846 [Default:CheckIn:E] Running Loop=1 2024-05-06T23:10:53.235Z,1715037053.235 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.424312 min 2024-05-06T23:10:53.235Z,1715037053.235 [Default:CheckIn:E] Stopped 2024-05-06T23:10:53.235Z,1715037053.235 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T23:10:53.235Z,1715037053.235 [Default:CheckIn] Stopped 2024-05-06T23:10:53.236Z,1715037053.236 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T23:10:53.236Z,1715037053.236 [Default:CheckIn](INFO): Running loop #5 2024-05-06T23:10:53.236Z,1715037053.236 [Default:CheckIn] Running Loop=5 2024-05-06T23:10:53.236Z,1715037053.236 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T23:10:53.236Z,1715037053.236 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T23:11:23.553Z,1715037083.553 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:11:23.553Z,1715037083.553 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:11:38.156Z,1715037098.156 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitAft millimeter 2024-05-06T23:11:38.156Z,1715037098.156 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitAft -26.000000 mm 2024-05-06T23:11:52.192Z,1715037112.192 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:11:52.192Z,1715037112.192 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:11:52.192Z,1715037112.192 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:11:52.210Z,1715037112.210 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:11:52.669Z,1715037112.669 [Waterlinked](INFO): Powering down 2024-05-06T23:11:53.441Z,1715037113.441 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:11:53.441Z,1715037113.441 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:12:08.584Z,1715037128.584 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -26 millimeter 2024-05-06T23:12:08.587Z,1715037128.587 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2024-05-06T23:12:08.791Z,1715037128.791 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:12:22.091Z,1715037142.091 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:12:22.091Z,1715037142.091 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:12:22.091Z,1715037142.091 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:12:22.190Z,1715037142.190 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:12:22.561Z,1715037142.561 [Waterlinked](INFO): Powering down 2024-05-06T23:12:23.368Z,1715037143.368 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:12:23.368Z,1715037143.368 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:12:51.998Z,1715037171.998 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:12:51.998Z,1715037171.998 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:12:51.998Z,1715037171.998 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:12:52.077Z,1715037172.077 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:12:52.078Z,1715037172.078 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:12:52.481Z,1715037172.481 [Waterlinked](INFO): Powering down 2024-05-06T23:12:52.539Z,1715037172.539 [CBIT](INFO): Critical error at 20240506T231252 2024-05-06T23:12:56.431Z,1715037176.431 [Power24vConverter](INFO): Powering down. 2024-05-06T23:13:24.314Z,1715037204.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-05-06T23:13:24.314Z,1715037204.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:13:24.315Z,1715037204.315 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2024-05-06T23:13:24.315Z,1715037204.315 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:13:24.327Z,1715037204.327 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:13:24.327Z,1715037204.327 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:13:24.739Z,1715037204.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:13:24.739Z,1715037204.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-05-06T23:13:24.739Z,1715037204.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:13:24.739Z,1715037204.739 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2024-05-06T23:13:25.144Z,1715037205.144 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:14:27.700Z,1715037267.700 [CommandExec](IMPORTANT): got command get platform_mass_position 2024-05-06T23:14:27.701Z,1715037267.701 [CommandExec](IMPORTANT): platform_mass_position -0.026000 m 2024-05-06T23:15:41.263Z,1715037341.263 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T23:15:41.263Z,1715037341.263 [NAL9602] Data Fault, FailCount= 5 2024-05-06T23:15:41.263Z,1715037341.263 [NAL9602](ERROR): Data Fault 2024-05-06T23:15:41.322Z,1715037341.322 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T23:15:41.322Z,1715037341.322 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-05-06T23:15:41.662Z,1715037341.662 [NAL9602](INFO): Powering down 2024-05-06T23:15:41.687Z,1715037341.687 [CBIT](INFO): Critical error at 20240506T231541 2024-05-06T23:15:51.849Z,1715037351.849 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 38 millimeter 2024-05-06T23:15:52.195Z,1715037352.195 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:15:52.195Z,1715037352.195 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:15:52.978Z,1715037352.978 [Power24vConverter](INFO): Powering up. 2024-05-06T23:15:53.391Z,1715037353.391 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T23:10:53.2Z 2024-05-06T23:15:53.391Z,1715037353.391 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T23:15:53.391Z,1715037353.391 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T23:15:58.904Z,1715037358.904 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20240506T222157/Courier0016.lzma 2024-05-06T23:15:59.906Z,1715037359.906 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0016.lzma.bak 2024-05-06T23:15:59.907Z,1715037359.907 [DataOverHttps](INFO): SBD MOMSN=19987076 2024-05-06T23:16:15.634Z,1715037375.634 [DataOverHttps](INFO): Sending 448 bytes from file Logs/20240506T222157/Express0017.lzma 2024-05-06T23:16:16.635Z,1715037376.635 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0017.lzma.bak 2024-05-06T23:16:16.635Z,1715037376.635 [DataOverHttps](INFO): SBD MOMSN=19987086 2024-05-06T23:16:18.039Z,1715037378.039 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T23:16:18.039Z,1715037378.039 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T23:16:18.039Z,1715037378.039 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T23:16:20.850Z,1715037380.850 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:16:20.851Z,1715037380.851 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:16:20.851Z,1715037380.851 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:16:20.946Z,1715037380.946 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:16:21.325Z,1715037381.325 [Waterlinked](INFO): Powering down 2024-05-06T23:16:22.141Z,1715037382.141 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:16:22.142Z,1715037382.142 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:16:25.305Z,1715037385.305 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2024-05-06T23:16:25.305Z,1715037385.305 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:16:25.306Z,1715037385.306 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2024-05-06T23:16:25.306Z,1715037385.306 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:16:25.368Z,1715037385.368 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:16:25.368Z,1715037385.368 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:16:25.758Z,1715037385.758 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:16:25.758Z,1715037385.758 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2024-05-06T23:16:25.758Z,1715037385.758 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:16:25.758Z,1715037385.758 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2024-05-06T23:16:26.114Z,1715037386.114 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:16:50.751Z,1715037410.751 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:16:50.751Z,1715037410.751 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:16:50.751Z,1715037410.751 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:16:50.818Z,1715037410.818 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:16:51.229Z,1715037411.229 [Waterlinked](INFO): Powering down 2024-05-06T23:16:52.014Z,1715037412.014 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:16:52.014Z,1715037412.014 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:16:58.243Z,1715037418.243 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-05-06T23:16:58.251Z,1715037418.251 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2024-05-06T23:16:58.506Z,1715037418.506 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:17:20.648Z,1715037440.648 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:17:20.648Z,1715037440.648 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:17:20.648Z,1715037440.648 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:17:20.666Z,1715037440.666 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:17:20.667Z,1715037440.667 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:17:21.117Z,1715037441.117 [Waterlinked](INFO): Powering down 2024-05-06T23:17:21.140Z,1715037441.140 [CBIT](INFO): Critical error at 20240506T231720 2024-05-06T23:17:41.263Z,1715037461.263 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T23:17:41.263Z,1715037461.263 [NAL9602] No Fault, FailCount= 5 2024-05-06T23:17:41.655Z,1715037461.655 [NAL9602](INFO): Powering up NAL9602 2024-05-06T23:17:52.559Z,1715037472.559 [NAL9602](INFO): NAL9602 initialized 2024-05-06T23:18:07.869Z,1715037487.869 [CommandExec](IMPORTANT): got command get platform_mass_position 2024-05-06T23:18:07.870Z,1715037487.870 [CommandExec](IMPORTANT): platform_mass_position 0.037999 m 2024-05-06T23:18:36.044Z,1715037516.044 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-05-06T23:18:54.278Z,1715037534.278 [CommandExec](IMPORTANT): got command failComponent 2024-05-06T23:18:54.278Z,1715037534.278 [CommandExec](IMPORTANT): Failed components: 2024-05-06T23:18:54.278Z,1715037534.278 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-05-06T23:18:54.278Z,1715037534.278 [CommandExec](IMPORTANT): Waterlinked: Communications Fault 2024-05-06T23:18:54.279Z,1715037534.279 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-05-06T23:19:23.589Z,1715037563.589 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo 2024-05-06T23:19:23.589Z,1715037563.589 [ElevatorServo] No Fault, FailCount= 3 2024-05-06T23:19:23.589Z,1715037563.589 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault 2024-05-06T23:19:26.297Z,1715037566.297 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2024-05-06T23:19:26.297Z,1715037566.297 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:19:26.298Z,1715037566.298 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2024-05-06T23:19:26.298Z,1715037566.298 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:19:26.362Z,1715037566.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:19:26.362Z,1715037566.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:19:26.754Z,1715037566.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:19:26.754Z,1715037566.754 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2024-05-06T23:19:26.754Z,1715037566.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:19:26.754Z,1715037566.754 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2024-05-06T23:19:27.102Z,1715037567.102 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:19:28.573Z,1715037568.573 [CommandExec](IMPORTANT): got command failComponent 2024-05-06T23:19:28.574Z,1715037568.574 [CommandExec](IMPORTANT): Failed components: 2024-05-06T23:19:28.574Z,1715037568.574 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-05-06T23:19:28.574Z,1715037568.574 [CommandExec](IMPORTANT): Waterlinked: Communications Fault 2024-05-06T23:19:43.466Z,1715037583.466 [CommandExec](IMPORTANT): got command gfscan 2024-05-06T23:19:43.691Z,1715037583.691 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T23:19:54.640Z,1715037594.640 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006664 CHAN A1 (24V): 0.001178 CHAN A2 (12V): -0.005908 CHAN A3 (5V): -0.002372 CHAN B0 (3.3V): -0.001157 CHAN B1 (3.15aV): -0.001417 CHAN B2 (3.15bV): -0.001355 CHAN B3 (GND): -0.000786 OPEN: 0.004752 Full Scale: +/- 1 mA 2024-05-06T23:20:16.668Z,1715037616.668 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-05-06T23:20:20.878Z,1715037620.878 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:20:20.878Z,1715037620.878 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:20:23.309Z,1715037623.309 [ElevatorServo](INFO): Failure count cleared after critical for ElevatorServo 2024-05-06T23:20:28.950Z,1715037628.950 [CommandExec](IMPORTANT): got command gfscan 2024-05-06T23:20:29.386Z,1715037629.386 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T23:20:40.263Z,1715037640.263 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006840 CHAN A1 (24V): 0.000143 CHAN A2 (12V): -0.005655 CHAN A3 (5V): -0.003287 CHAN B0 (3.3V): -0.000902 CHAN B1 (3.15aV): -0.001197 CHAN B2 (3.15bV): -0.001309 CHAN B3 (GND): -0.000847 OPEN: 0.004882 Full Scale: +/- 1 mA 2024-05-06T23:20:49.512Z,1715037649.512 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:20:49.512Z,1715037649.512 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:20:49.512Z,1715037649.512 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:20:49.559Z,1715037649.559 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:20:49.989Z,1715037649.989 [Waterlinked](INFO): Powering down 2024-05-06T23:20:50.758Z,1715037650.758 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:20:50.758Z,1715037650.758 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:21:18.611Z,1715037678.611 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T23:21:18.611Z,1715037678.611 [Default:CheckIn:C.Wait] Stopped 2024-05-06T23:21:18.611Z,1715037678.611 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T23:21:18.611Z,1715037678.611 [Default:CheckIn:D] Running Loop=1 2024-05-06T23:21:19.015Z,1715037679.015 [Default:CheckIn:D] Stopped 2024-05-06T23:21:19.015Z,1715037679.015 [Default:CheckIn:E] Running Loop=1 2024-05-06T23:21:19.412Z,1715037679.412 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:21:19.412Z,1715037679.412 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:21:19.412Z,1715037679.412 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.860457 min 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn:E] Stopped 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn] Stopped 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T23:21:19.420Z,1715037679.420 [Default:CheckIn](INFO): Running loop #6 2024-05-06T23:21:19.421Z,1715037679.421 [Default:CheckIn] Running Loop=6 2024-05-06T23:21:19.421Z,1715037679.421 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T23:21:19.421Z,1715037679.421 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T23:21:19.432Z,1715037679.432 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:21:19.877Z,1715037679.877 [Waterlinked](INFO): Powering down 2024-05-06T23:21:20.672Z,1715037680.672 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:21:20.672Z,1715037680.672 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:21:35.367Z,1715037695.367 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 2024-05-06T23:21:35.367Z,1715037695.367 [CommandExec](FAULT): Incomplete syntax. Try: help maintain 2024-05-06T23:21:42.785Z,1715037702.785 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-05-06T23:21:42.789Z,1715037702.789 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2024-05-06T23:21:42.892Z,1715037702.892 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:21:49.318Z,1715037709.318 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:21:49.318Z,1715037709.318 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:21:49.318Z,1715037709.318 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:21:49.373Z,1715037709.373 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:21:49.373Z,1715037709.373 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:21:49.797Z,1715037709.797 [Waterlinked](INFO): Powering down 2024-05-06T23:21:49.828Z,1715037709.828 [CBIT](INFO): Critical error at 20240506T232149 2024-05-06T23:22:10.780Z,1715037730.780 [CBIT](INFO): Clearing failed state for component DropWeight 2024-05-06T23:22:10.780Z,1715037730.780 [DropWeight] No Fault, FailCount= 1 2024-05-06T23:22:27.290Z,1715037747.290 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2024-05-06T23:22:27.290Z,1715037747.290 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:22:27.291Z,1715037747.291 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20 2024-05-06T23:22:27.291Z,1715037747.291 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:22:27.362Z,1715037747.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:22:27.362Z,1715037747.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:22:27.709Z,1715037747.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:22:27.709Z,1715037747.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2024-05-06T23:22:27.710Z,1715037747.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:22:27.710Z,1715037747.710 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20 2024-05-06T23:22:28.098Z,1715037748.098 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:22:29.626Z,1715037749.626 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2024-05-06T23:22:52.575Z,1715037772.575 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2024-05-06T23:23:43.050Z,1715037823.050 [CommandExec](IMPORTANT): got command get 2024-05-06T23:23:43.050Z,1715037823.050 [CommandExec](FAULT): Incomplete syntax. Try: help get 2024-05-06T23:24:49.556Z,1715037889.556 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:24:49.556Z,1715037889.556 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:25:18.184Z,1715037918.184 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:25:18.184Z,1715037918.184 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:25:18.184Z,1715037918.184 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:25:18.235Z,1715037918.235 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:25:18.657Z,1715037918.657 [Waterlinked](INFO): Powering down 2024-05-06T23:25:19.436Z,1715037919.436 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:25:19.436Z,1715037919.436 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:25:28.320Z,1715037928.320 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2024-05-06T23:25:28.320Z,1715037928.320 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:25:28.321Z,1715037928.321 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 21 2024-05-06T23:25:28.321Z,1715037928.321 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:25:28.358Z,1715037928.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:25:28.358Z,1715037928.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:25:28.731Z,1715037928.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:25:28.731Z,1715037928.731 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2024-05-06T23:25:28.731Z,1715037928.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:25:28.731Z,1715037928.731 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 21 2024-05-06T23:25:29.119Z,1715037929.119 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:25:35.481Z,1715037935.481 [CommandExec](IMPORTANT): got command get 2024-05-06T23:25:35.481Z,1715037935.481 [CommandExec](FAULT): Incomplete syntax. Try: help get 2024-05-06T23:25:48.090Z,1715037948.090 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:25:48.090Z,1715037948.090 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:25:48.090Z,1715037948.090 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:25:48.167Z,1715037948.167 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:25:48.565Z,1715037948.565 [Waterlinked](INFO): Powering down 2024-05-06T23:25:49.325Z,1715037949.325 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:25:49.325Z,1715037949.325 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:25:58.381Z,1715037958.381 [CommandExec](IMPORTANT): got command failComponent 2024-05-06T23:25:58.382Z,1715037958.382 [CommandExec](IMPORTANT): Failed components: 2024-05-06T23:25:58.382Z,1715037958.382 [CommandExec](IMPORTANT): No failed Components. 2024-05-06T23:26:17.992Z,1715037977.992 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:26:17.992Z,1715037977.992 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:26:17.992Z,1715037977.992 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:26:18.011Z,1715037978.011 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:26:18.012Z,1715037978.012 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:26:18.461Z,1715037978.461 [Waterlinked](INFO): Powering down 2024-05-06T23:26:18.485Z,1715037978.485 [CBIT](INFO): Critical error at 20240506T232618 2024-05-06T23:26:19.611Z,1715037979.611 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T23:21:19.4Z 2024-05-06T23:26:19.611Z,1715037979.611 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T23:26:19.611Z,1715037979.611 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T23:26:22.415Z,1715037982.415 [Power24vConverter](INFO): Powering down. 2024-05-06T23:26:25.988Z,1715037985.988 [DataOverHttps](INFO): Sending 102 bytes from file Logs/20240506T222157/Courier0019.lzma 2024-05-06T23:26:26.991Z,1715037986.991 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0019.lzma.bak 2024-05-06T23:26:26.991Z,1715037986.991 [DataOverHttps](INFO): SBD MOMSN=19987250 2024-05-06T23:26:39.983Z,1715037999.983 [CommandExec](IMPORTANT): got command get 2024-05-06T23:26:39.983Z,1715037999.983 [CommandExec](FAULT): Incomplete syntax. Try: help get 2024-05-06T23:26:43.722Z,1715038003.722 [DataOverHttps](INFO): Sending 814 bytes from file Logs/20240506T222157/Express0020.lzma 2024-05-06T23:26:44.723Z,1715038004.723 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0020.lzma.bak 2024-05-06T23:26:44.723Z,1715038004.723 [DataOverHttps](INFO): SBD MOMSN=19987255 2024-05-06T23:26:46.294Z,1715038006.294 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T23:26:46.294Z,1715038006.294 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T23:26:46.295Z,1715038006.295 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T23:26:46.521Z,1715038006.521 [CommandExec](IMPORTANT): got command get Depth_Keller.depth 2024-05-06T23:26:46.522Z,1715038006.522 [CommandExec](IMPORTANT): Depth_Keller.depth 0.043080 m 2024-05-06T23:27:53.719Z,1715038073.719 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-06T23:27:53.719Z,1715038073.719 [NAL9602] Data Fault, FailCount= 1 2024-05-06T23:27:53.719Z,1715038073.719 [NAL9602](ERROR): Data Fault 2024-05-06T23:27:53.739Z,1715038073.739 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-06T23:27:54.128Z,1715038074.128 [NAL9602](INFO): Powering down 2024-05-06T23:27:54.950Z,1715038074.950 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-06T23:27:54.950Z,1715038074.950 [NAL9602] No Fault, FailCount= 1 2024-05-06T23:28:24.426Z,1715038104.426 [NAL9602](INFO): Powering up NAL9602 2024-05-06T23:28:29.280Z,1715038109.280 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2024-05-06T23:28:29.280Z,1715038109.280 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:28:29.282Z,1715038109.282 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 22 2024-05-06T23:28:29.282Z,1715038109.282 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:28:29.294Z,1715038109.294 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:28:29.294Z,1715038109.294 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:28:29.699Z,1715038109.699 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:28:29.699Z,1715038109.699 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2024-05-06T23:28:29.699Z,1715038109.699 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:28:29.699Z,1715038109.699 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 22 2024-05-06T23:28:30.098Z,1715038110.098 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:28:35.331Z,1715038115.331 [NAL9602](INFO): NAL9602 initialized 2024-05-06T23:29:18.199Z,1715038158.199 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:29:18.199Z,1715038158.199 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:29:18.985Z,1715038158.985 [Power24vConverter](INFO): Powering up. 2024-05-06T23:29:46.858Z,1715038186.858 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:29:46.858Z,1715038186.858 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:29:46.858Z,1715038186.858 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:29:46.922Z,1715038186.922 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:29:47.329Z,1715038187.329 [Waterlinked](INFO): Powering down 2024-05-06T23:29:48.127Z,1715038188.127 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:29:48.127Z,1715038188.127 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:30:16.772Z,1715038216.772 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:30:16.773Z,1715038216.773 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:30:16.773Z,1715038216.773 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:30:16.824Z,1715038216.824 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:30:17.229Z,1715038217.229 [Waterlinked](INFO): Powering down 2024-05-06T23:30:17.975Z,1715038217.975 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:30:17.975Z,1715038217.975 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:30:31.898Z,1715038231.898 [CommandExec](IMPORTANT): got command strobe off 2024-05-06T23:30:31.898Z,1715038231.898 [CommandExec](IMPORTANT): Deactivating strobe 2024-05-06T23:30:46.650Z,1715038246.650 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:30:46.650Z,1715038246.650 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:30:46.650Z,1715038246.650 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:30:46.775Z,1715038246.775 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:30:46.776Z,1715038246.776 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:30:47.117Z,1715038247.117 [Waterlinked](INFO): Powering down 2024-05-06T23:30:47.184Z,1715038247.184 [CBIT](INFO): Critical error at 20240506T233046 2024-05-06T23:31:30.306Z,1715038290.306 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2024-05-06T23:31:30.306Z,1715038290.306 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:31:30.307Z,1715038290.307 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 23 2024-05-06T23:31:30.307Z,1715038290.307 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:31:30.320Z,1715038290.320 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:31:30.320Z,1715038290.320 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:31:30.709Z,1715038290.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:31:30.709Z,1715038290.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2024-05-06T23:31:30.710Z,1715038290.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:31:30.710Z,1715038290.710 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 23 2024-05-06T23:31:31.102Z,1715038291.102 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:31:46.846Z,1715038306.846 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T23:31:46.846Z,1715038306.846 [Default:CheckIn:C.Wait] Stopped 2024-05-06T23:31:46.846Z,1715038306.846 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T23:31:46.846Z,1715038306.846 [Default:CheckIn:D] Running Loop=1 2024-05-06T23:31:47.251Z,1715038307.251 [Default:CheckIn:D] Stopped 2024-05-06T23:31:47.251Z,1715038307.251 [Default:CheckIn:E] Running Loop=1 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.331059 min 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn:E] Stopped 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn] Stopped 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn](INFO): Running loop #7 2024-05-06T23:31:47.714Z,1715038307.714 [Default:CheckIn] Running Loop=7 2024-05-06T23:31:47.715Z,1715038307.715 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T23:31:47.715Z,1715038307.715 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T23:33:17.327Z,1715038397.327 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:33:46.845Z,1715038426.845 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:33:46.845Z,1715038426.845 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:33:48.941Z,1715038428.941 [NAL9602](ERROR): getFix uart error: serial timeout 2024-05-06T23:34:15.260Z,1715038455.260 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:34:15.260Z,1715038455.260 [Waterlinked] Communications Fault, FailCount= 1 2024-05-06T23:34:15.260Z,1715038455.260 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:34:15.303Z,1715038455.303 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:34:15.729Z,1715038455.729 [Waterlinked](INFO): Powering down 2024-05-06T23:34:16.556Z,1715038456.556 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:34:16.556Z,1715038456.556 [Waterlinked] No Fault, FailCount= 1 2024-05-06T23:34:19.300Z,1715038459.300 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:34:31.455Z,1715038471.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2024-05-06T23:34:31.455Z,1715038471.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:34:31.456Z,1715038471.456 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 24 2024-05-06T23:34:31.456Z,1715038471.456 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:34:31.481Z,1715038471.481 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:34:31.481Z,1715038471.481 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:34:31.885Z,1715038471.885 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:34:31.885Z,1715038471.885 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2024-05-06T23:34:31.886Z,1715038471.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:34:31.886Z,1715038471.886 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 24 2024-05-06T23:34:32.245Z,1715038472.245 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:34:34.445Z,1715038474.445 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2024-05-06T23:34:34.449Z,1715038474.449 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2024-05-06T23:34:34.698Z,1715038474.698 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:34:45.163Z,1715038485.163 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:34:45.164Z,1715038485.164 [Waterlinked] Communications Fault, FailCount= 2 2024-05-06T23:34:45.164Z,1715038485.164 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:34:45.276Z,1715038485.276 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:34:45.629Z,1715038485.629 [Waterlinked](INFO): Powering down 2024-05-06T23:34:46.460Z,1715038486.460 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:34:46.460Z,1715038486.460 [Waterlinked] No Fault, FailCount= 2 2024-05-06T23:34:50.913Z,1715038490.913 [NAL9602](ERROR): getFix uart error: serial timeout 2024-05-06T23:35:14.887Z,1715038514.887 [Waterlinked](FAULT): Could not initialize. 2024-05-06T23:35:14.887Z,1715038514.887 [Waterlinked] Communications Fault, FailCount= 3 2024-05-06T23:35:14.887Z,1715038514.887 [Waterlinked](ERROR): Communications Fault 2024-05-06T23:35:14.976Z,1715038514.976 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-05-06T23:35:14.977Z,1715038514.977 [CBIT](CRITICAL): Communications Fault in component: Waterlinked 2024-05-06T23:35:15.361Z,1715038515.361 [Waterlinked](INFO): Powering down 2024-05-06T23:35:15.443Z,1715038515.443 [CBIT](INFO): Critical error at 20240506T233514 2024-05-06T23:35:21.355Z,1715038521.355 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:35:33.510Z,1715038533.510 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 0 revolution_per_minute 2024-05-06T23:35:45.844Z,1715038545.844 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction -300 revolution_per_minute 2024-05-06T23:35:52.969Z,1715038552.969 [NAL9602](ERROR): getFix uart error: serial timeout 2024-05-06T23:36:23.351Z,1715038583.351 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:36:24.859Z,1715038584.859 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 0 revolution_per_minute 2024-05-06T23:36:48.016Z,1715038608.016 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T23:31:47.7Z 2024-05-06T23:36:48.016Z,1715038608.016 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T23:36:48.016Z,1715038608.016 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T23:36:49.069Z,1715038609.069 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2024-05-06T23:36:55.009Z,1715038615.009 [NAL9602](ERROR): getFix uart error: serial timeout 2024-05-06T23:36:55.844Z,1715038615.844 [DataOverHttps](INFO): Sending 98 bytes from file Logs/20240506T222157/Courier0022.lzma 2024-05-06T23:36:56.847Z,1715038616.847 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Courier0022.lzma.bak 2024-05-06T23:36:56.847Z,1715038616.847 [DataOverHttps](INFO): SBD MOMSN=19987377 2024-05-06T23:37:12.805Z,1715038632.805 [DataOverHttps](INFO): Sending 414 bytes from file Logs/20240506T222157/Express0023.lzma 2024-05-06T23:37:13.807Z,1715038633.807 [DataOverHttps](INFO): Moved sent file to Logs/20240506T222157/Express0023.lzma.bak 2024-05-06T23:37:13.807Z,1715038633.807 [DataOverHttps](INFO): SBD MOMSN=19987381 2024-05-06T23:37:15.378Z,1715038635.378 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T23:37:15.379Z,1715038635.379 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T23:37:15.379Z,1715038635.379 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T23:37:25.459Z,1715038645.459 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:37:27.681Z,1715038647.681 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 0 revolution_per_minute 2024-05-06T23:37:32.336Z,1715038652.336 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2024-05-06T23:37:32.336Z,1715038652.336 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-06T23:37:32.337Z,1715038652.337 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 25 2024-05-06T23:37:32.337Z,1715038652.337 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-05-06T23:37:32.350Z,1715038652.350 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-06T23:37:32.350Z,1715038652.350 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-05-06T23:37:32.764Z,1715038652.764 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-06T23:37:32.764Z,1715038652.764 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2024-05-06T23:37:32.765Z,1715038652.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-05-06T23:37:32.765Z,1715038652.765 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 25 2024-05-06T23:37:33.137Z,1715038653.137 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T23:37:38.711Z,1715038658.711 [CommandExec](IMPORTANT): got command maintain clear 2024-05-06T23:37:38.819Z,1715038658.819 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T23:37:57.069Z,1715038677.069 [NAL9602](ERROR): getFix uart error: serial timeout 2024-05-06T23:37:58.993Z,1715038678.993 [CommandExec](IMPORTANT): got command failComponent 2024-05-06T23:37:58.994Z,1715038678.994 [CommandExec](IMPORTANT): Failed components: 2024-05-06T23:37:58.994Z,1715038678.994 [CommandExec](IMPORTANT): Waterlinked: Communications Fault 2024-05-06T23:38:05.862Z,1715038685.862 [CommandExec](IMPORTANT): got command gfscan 2024-05-06T23:38:06.193Z,1715038686.193 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T23:38:15.042Z,1715038695.042 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-05-06T23:38:15.042Z,1715038695.042 [Waterlinked] No Fault, FailCount= 3 2024-05-06T23:38:17.080Z,1715038697.080 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.007543 CHAN A1 (24V): -0.000123 CHAN A2 (12V): -0.005623 CHAN A3 (5V): -0.002463 CHAN B0 (3.3V): -0.001316 CHAN B1 (3.15aV): -0.001255 CHAN B2 (3.15bV): -0.001331 CHAN B3 (GND): -0.000998 OPEN: 0.004946 Full Scale: +/- 1 mA 2024-05-06T23:38:20.754Z,1715038700.754 [CommandExec](IMPORTANT): got command quit 2024-05-06T23:38:21.757Z,1715038701.757 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:21.757Z,1715038701.757 [CommandExec](INFO): Uninitializing the command executive. 2024-05-06T23:38:21.757Z,1715038701.757 [CommandExec](INFO): Uninitializing the command scheduler. 2024-05-06T23:38:21.757Z,1715038701.757 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:21.911Z,1715038701.911 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-05-06T23:38:21.911Z,1715038701.911 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-05-06T23:38:21.912Z,1715038701.912 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:21.912Z,1715038701.912 [NavChartDb](INFO): Join timeout helper Thread ID is 7895 2024-05-06T23:38:22.097Z,1715038702.097 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:22.097Z,1715038702.097 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:22.109Z,1715038702.109 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-05-06T23:38:22.110Z,1715038702.110 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:22.111Z,1715038702.111 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7896 2024-05-06T23:38:22.429Z,1715038702.429 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:22.429Z,1715038702.429 [WetLabsBB2FL](INFO): Powering down 2024-05-06T23:38:22.430Z,1715038702.430 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:22.449Z,1715038702.449 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-05-06T23:38:22.449Z,1715038702.449 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:22.449Z,1715038702.449 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7897 2024-05-06T23:38:23.225Z,1715038703.225 [CTD_Seabird](INFO): Powering down 2024-05-06T23:38:23.237Z,1715038703.237 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:23.237Z,1715038703.237 [CTD_Seabird](INFO): Powering down 2024-05-06T23:38:23.260Z,1715038703.260 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:23.261Z,1715038703.261 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-05-06T23:38:23.261Z,1715038703.261 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:23.261Z,1715038703.261 [Radio_Surface](INFO): Join timeout helper Thread ID is 7898 2024-05-06T23:38:23.317Z,1715038703.317 [Radio_Surface](INFO): Powering down 2024-05-06T23:38:23.318Z,1715038703.318 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:23.318Z,1715038703.318 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:23.321Z,1715038703.321 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-05-06T23:38:23.321Z,1715038703.321 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:23.321Z,1715038703.321 [Onboard](INFO): Join timeout helper Thread ID is 7899 2024-05-06T23:38:24.045Z,1715038704.045 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-05-06T23:38:27.105Z,1715038707.105 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:27.105Z,1715038707.105 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:27.107Z,1715038707.107 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-05-06T23:38:27.107Z,1715038707.107 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:27.107Z,1715038707.107 [DataOverHttps](INFO): Join timeout helper Thread ID is 7900 2024-05-06T23:38:27.523Z,1715038707.523 [NAL9602](ERROR): parseGSV uart error: serial timeout 2024-05-06T23:38:28.061Z,1715038708.061 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:28.061Z,1715038708.061 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.082Z,1715038708.082 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-05-06T23:38:28.082Z,1715038708.082 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.082Z,1715038708.082 [BackseatComponent](INFO): Join timeout helper Thread ID is 7901 2024-05-06T23:38:28.083Z,1715038708.083 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:28.083Z,1715038708.083 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.084Z,1715038708.084 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-05-06T23:38:28.084Z,1715038708.084 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.085Z,1715038708.085 [logger](INFO): Join timeout helper Thread ID is 7902 2024-05-06T23:38:28.089Z,1715038708.089 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:28.089Z,1715038708.089 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.105Z,1715038708.105 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-05-06T23:38:28.106Z,1715038708.106 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.106Z,1715038708.106 [CommandLine](INFO): Join timeout helper Thread ID is 7903 2024-05-06T23:38:28.125Z,1715038708.125 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:28.125Z,1715038708.125 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.145Z,1715038708.145 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-05-06T23:38:28.146Z,1715038708.146 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.146Z,1715038708.146 [CommandExec](INFO): Join timeout helper Thread ID is 7904 2024-05-06T23:38:28.147Z,1715038708.147 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-05-06T23:38:28.147Z,1715038708.147 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.148Z,1715038708.148 [controlThread](INFO): Join timeout helper Thread ID is 7905 2024-05-06T23:38:28.313Z,1715038708.313 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-06T23:38:28.313Z,1715038708.313 [controlThread](DEBUG): Uninitializing ControlThread 2024-05-06T23:38:28.314Z,1715038708.314 [AHRS_M2](INFO): Powering down 2024-05-06T23:38:28.386Z,1715038708.386 [MultiRay](INFO): Powering down. 2024-05-06T23:38:28.387Z,1715038708.387 [NAL9602](INFO): Powering down 2024-05-06T23:38:28.388Z,1715038708.388 [Sonardyne_Nano](INFO): Powering down 2024-05-06T23:38:28.581Z,1715038708.581 [Waterlinked](INFO): Powering down 2024-05-06T23:38:28.582Z,1715038708.582 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-05-06T23:38:28.583Z,1715038708.583 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-05-06T23:38:28.584Z,1715038708.584 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-05-06T23:38:28.584Z,1715038708.584 [MissionManager](INFO): Uninitializing Mission Default 2024-05-06T23:38:28.584Z,1715038708.584 [Default] Stopped 2024-05-06T23:38:28.584Z,1715038708.584 [Default](DEBUG): Aggregate::uninitialize Default 2024-05-06T23:38:28.584Z,1715038708.584 [Default:B.GoToSurface] Stopped 2024-05-06T23:38:28.585Z,1715038708.585 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-06T23:38:28.585Z,1715038708.585 [Default:CheckIn] Stopped 2024-05-06T23:38:28.585Z,1715038708.585 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T23:38:28.585Z,1715038708.585 [Default:CheckIn:C.Wait] Stopped 2024-05-06T23:38:28.585Z,1715038708.585 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T23:38:28.588Z,1715038708.588 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-05-06T23:38:28.588Z,1715038708.588 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-05-06T23:38:28.588Z,1715038708.588 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-05-06T23:38:28.589Z,1715038708.589 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-05-06T23:38:28.589Z,1715038708.589 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-05-06T23:38:28.589Z,1715038708.589 [BuoyancyServo](INFO): Powering down 2024-05-06T23:38:28.721Z,1715038708.721 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-06T23:38:28.721Z,1715038708.721 [ElevatorServo](INFO): Powering down 2024-05-06T23:38:28.722Z,1715038708.722 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-06T23:38:28.722Z,1715038708.722 [MassServo](INFO): Powering down 2024-05-06T23:38:28.723Z,1715038708.723 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-05-06T23:38:28.723Z,1715038708.723 [RudderServo](INFO): Powering down 2024-05-06T23:38:28.724Z,1715038708.724 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-05-06T23:38:28.724Z,1715038708.724 [ThrusterHE](INFO): Powering down 2024-05-06T23:38:28.725Z,1715038708.725 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-05-06T23:38:28.725Z,1715038708.725 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-05-06T23:38:28.726Z,1715038708.726 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-05-06T23:38:28.726Z,1715038708.726 [CBIT](DEBUG): Powering off loads. 2024-05-06T23:38:28.737Z,1715038708.737 [CBIT](DEBUG): Disabling WDT. 2024-05-06T23:38:28.749Z,1715038708.749 [CBIT](DEBUG): Opening all GF detection circuits. 2024-05-06T23:38:28.750Z,1715038708.750 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.780Z,1715038708.780 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.783Z,1715038708.783 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.789Z,1715038708.789 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.832Z,1715038708.832 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.880Z,1715038708.880 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.884Z,1715038708.884 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.935Z,1715038708.935 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-06T23:38:28.983Z,1715038708.983 [logger ThreadHandler](INFO): Thread cancelled.