2021-10-07T21:21:31.087Z,1633641691.087 [Supervisor](DEBUG): Initializing supervisor.
2021-10-07T21:21:31.092Z,1633641691.092 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-10-07T21:21:31.092Z,1633641691.092 [SyncHandler](INFO): Protected caller Thread ID is 9507
2021-10-07T21:21:31.092Z,1633641691.092 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-10-07T21:21:31.093Z,1633641691.093 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-10-07T21:21:31.094Z,1633641691.094 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9508
2021-10-07T21:21:31.098Z,1633641691.098 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-10-07T21:21:31.119Z,1633641691.119 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-10-07T21:21:31.120Z,1633641691.120 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-10-07T21:21:31.120Z,1633641691.120 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9509
2021-10-07T21:21:31.122Z,1633641691.122 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-10-07T21:21:31.123Z,1633641691.123 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-10-07T21:21:31.124Z,1633641691.124 [logger ThreadHandler](INFO): Protected caller Thread ID is 9510
2021-10-07T21:21:31.128Z,1633641691.128 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-10-07T21:21:31.128Z,1633641691.128 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-10-07T21:21:31.129Z,1633641691.129 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-10-07T21:21:31.680Z,1633641691.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-10-07T21:21:31.681Z,1633641691.681 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-10-07T21:21:31.918Z,1633641691.918 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-10-07T21:21:31.918Z,1633641691.918 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-10-07T21:21:32.126Z,1633641692.126 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-10-07T21:21:32.127Z,1633641692.127 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-10-07T21:21:32.241Z,1633641692.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-10-07T21:21:32.242Z,1633641692.242 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-10-07T21:21:32.641Z,1633641692.641 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-10-07T21:21:32.642Z,1633641692.642 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-10-07T21:21:33.004Z,1633641693.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-10-07T21:21:33.005Z,1633641693.005 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-10-07T21:21:33.107Z,1633641693.107 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-10-07T21:21:33.107Z,1633641693.107 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-10-07T21:21:33.268Z,1633641693.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-10-07T21:21:33.268Z,1633641693.268 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-10-07T21:21:33.844Z,1633641693.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-10-07T21:21:33.845Z,1633641693.845 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-10-07T21:21:34.229Z,1633641694.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-10-07T21:21:34.230Z,1633641694.230 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-10-07T21:21:34.315Z,1633641694.315 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-10-07T21:21:34.538Z,1633641694.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-10-07T21:21:34.539Z,1633641694.539 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-10-07T21:21:34.673Z,1633641694.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-10-07T21:21:34.674Z,1633641694.674 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-10-07T21:21:35.401Z,1633641695.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-10-07T21:21:35.402Z,1633641695.402 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-10-07T21:21:35.486Z,1633641695.486 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-10-07T21:21:35.762Z,1633641695.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-10-07T21:21:35.764Z,1633641695.764 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2021-10-07T21:21:35.765Z,1633641695.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2021-10-07T21:21:35.950Z,1633641695.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2021-10-07T21:21:36.049Z,1633641696.049 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2021-10-07T21:21:36.166Z,1633641696.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2021-10-07T21:21:36.273Z,1633641696.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2021-10-07T21:21:36.361Z,1633641696.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2021-10-07T21:21:36.452Z,1633641696.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2021-10-07T21:21:36.573Z,1633641696.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2021-10-07T21:21:36.728Z,1633641696.728 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2021-10-07T21:21:37.075Z,1633641697.075 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2021-10-07T21:21:37.606Z,1633641697.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-10-07T21:21:37.606Z,1633641697.606 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2021-10-07T21:21:37.711Z,1633641697.711 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2021-10-07T21:21:37.711Z,1633641697.711 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-10-07T21:21:37.730Z,1633641697.730 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-10-07T21:21:38.081Z,1633641698.081 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-10-07T21:21:38.082Z,1633641698.082 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-10-07T21:21:38.167Z,1633641698.167 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-10-07T21:21:38.167Z,1633641698.167 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-10-07T21:21:38.202Z,1633641698.202 [DeadReckonUsingSpeedCalculator] Loaded
2021-10-07T21:21:38.203Z,1633641698.203 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2021-10-07T21:21:38.216Z,1633641698.216 [NavChart] Loaded
2021-10-07T21:21:38.216Z,1633641698.216 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-10-07T21:21:38.222Z,1633641698.222 [UniversalFixResidualReporter] Loaded
2021-10-07T21:21:38.222Z,1633641698.222 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-10-07T21:21:38.223Z,1633641698.223 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-10-07T21:21:38.224Z,1633641698.224 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-10-07T21:21:38.235Z,1633641698.235 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-10-07T21:21:38.235Z,1633641698.235 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-10-07T21:21:38.440Z,1633641698.440 [CTD_Seabird] Loaded
2021-10-07T21:21:38.441Z,1633641698.441 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-10-07T21:21:38.442Z,1633641698.442 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406214E0
2021-10-07T21:21:38.442Z,1633641698.442 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9592
2021-10-07T21:21:38.462Z,1633641698.462 [PAR_Licor] Loaded
2021-10-07T21:21:38.462Z,1633641698.462 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-10-07T21:21:38.495Z,1633641698.495 [WetLabsBB2FL] Loaded
2021-10-07T21:21:38.495Z,1633641698.495 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-10-07T21:21:38.496Z,1633641698.496 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406514E0
2021-10-07T21:21:38.497Z,1633641698.497 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9593
2021-10-07T21:21:38.497Z,1633641698.497 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-10-07T21:21:38.498Z,1633641698.498 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-10-07T21:21:38.555Z,1633641698.555 [VerticalControl](DEBUG): Construct VerticalControl.
2021-10-07T21:21:38.618Z,1633641698.618 [VerticalControl] Loaded
2021-10-07T21:21:38.618Z,1633641698.618 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-10-07T21:21:38.621Z,1633641698.621 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-10-07T21:21:38.660Z,1633641698.660 [HorizontalControl] Loaded
2021-10-07T21:21:38.660Z,1633641698.661 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-10-07T21:21:38.663Z,1633641698.663 [SpeedControl](DEBUG): Construct SpeedControl.
2021-10-07T21:21:38.666Z,1633641698.666 [SpeedControl] Loaded
2021-10-07T21:21:38.667Z,1633641698.667 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-10-07T21:21:38.669Z,1633641698.669 [LoopControl](DEBUG): Construct LoopControl.
2021-10-07T21:21:38.670Z,1633641698.670 [LoopControl] Loaded
2021-10-07T21:21:38.670Z,1633641698.670 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-10-07T21:21:38.671Z,1633641698.671 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-10-07T21:21:38.671Z,1633641698.671 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-10-07T21:21:38.716Z,1633641698.716 [DepthRateCalculator] Loaded
2021-10-07T21:21:38.716Z,1633641698.716 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-10-07T21:21:38.721Z,1633641698.721 [PitchRateCalculator] Loaded
2021-10-07T21:21:38.722Z,1633641698.722 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-10-07T21:21:38.731Z,1633641698.731 [SpeedCalculator] Loaded
2021-10-07T21:21:38.732Z,1633641698.732 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-10-07T21:21:38.745Z,1633641698.745 [TempGradientCalculator] Loaded
2021-10-07T21:21:38.746Z,1633641698.746 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-10-07T21:21:38.750Z,1633641698.750 [YawRateCalculator] Loaded
2021-10-07T21:21:38.751Z,1633641698.751 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-10-07T21:21:38.769Z,1633641698.769 [ElevatorOffsetCalculator] Loaded
2021-10-07T21:21:38.769Z,1633641698.769 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-10-07T21:21:38.770Z,1633641698.770 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-10-07T21:21:38.770Z,1633641698.770 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-10-07T21:21:38.872Z,1633641698.872 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-10-07T21:21:38.873Z,1633641698.873 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-10-07T21:21:38.934Z,1633641698.934 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-10-07T21:21:38.935Z,1633641698.935 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-10-07T21:21:39.075Z,1633641699.075 [BuoyancyServo] Loaded
2021-10-07T21:21:39.075Z,1633641699.075 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-10-07T21:21:39.095Z,1633641699.095 [ElevatorServo] Loaded
2021-10-07T21:21:39.096Z,1633641699.096 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-10-07T21:21:39.116Z,1633641699.116 [MassServo] Loaded
2021-10-07T21:21:39.116Z,1633641699.116 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-10-07T21:21:39.135Z,1633641699.135 [RudderServo] Loaded
2021-10-07T21:21:39.135Z,1633641699.135 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-10-07T21:21:39.151Z,1633641699.151 [ThrusterHE] Loaded
2021-10-07T21:21:39.151Z,1633641699.151 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2021-10-07T21:21:39.151Z,1633641699.151 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-10-07T21:21:39.152Z,1633641699.152 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-10-07T21:21:39.263Z,1633641699.263 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-10-07T21:21:39.263Z,1633641699.263 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-10-07T21:21:39.648Z,1633641699.648 [AHRS_M2] Loaded
2021-10-07T21:21:39.648Z,1633641699.648 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-10-07T21:21:39.686Z,1633641699.686 [BackseatComponent] Loaded
2021-10-07T21:21:39.686Z,1633641699.686 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2021-10-07T21:21:39.687Z,1633641699.687 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A194E0
2021-10-07T21:21:39.688Z,1633641699.688 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9594
2021-10-07T21:21:39.690Z,1633641699.690 [LcmUniversalReporter] Loaded
2021-10-07T21:21:39.691Z,1633641699.691 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2021-10-07T21:21:40.547Z,1633641700.547 [BPC1] Loaded
2021-10-07T21:21:40.548Z,1633641700.548 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-10-07T21:21:40.622Z,1633641700.622 [DataOverHttps] Loaded
2021-10-07T21:21:40.622Z,1633641700.622 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-10-07T21:21:40.624Z,1633641700.624 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A494E0
2021-10-07T21:21:40.624Z,1633641700.624 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9595
2021-10-07T21:21:40.645Z,1633641700.645 [Depth_Keller] Loaded
2021-10-07T21:21:40.645Z,1633641700.645 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-10-07T21:21:40.708Z,1633641700.708 [NAL9602] Loaded
2021-10-07T21:21:40.708Z,1633641700.708 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-10-07T21:21:40.737Z,1633641700.737 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2021-10-07T21:21:40.738Z,1633641700.738 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2021-10-07T21:21:40.738Z,1633641700.738 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2021-10-07T21:21:40.739Z,1633641700.739 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2021-10-07T21:21:40.739Z,1633641700.739 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2021-10-07T21:21:40.740Z,1633641700.740 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2021-10-07T21:21:40.740Z,1633641700.740 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2021-10-07T21:21:40.741Z,1633641700.741 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2021-10-07T21:21:40.741Z,1633641700.741 [Onboard] Loaded
2021-10-07T21:21:40.741Z,1633641700.741 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-10-07T21:21:40.742Z,1633641700.742 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A794E0
2021-10-07T21:21:40.743Z,1633641700.743 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9596
2021-10-07T21:21:40.757Z,1633641700.757 [Power24vConverter] Loaded
2021-10-07T21:21:40.757Z,1633641700.757 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-10-07T21:21:40.771Z,1633641700.771 [Radio_Surface] Loaded
2021-10-07T21:21:40.771Z,1633641700.771 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-10-07T21:21:40.772Z,1633641700.772 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2021-10-07T21:21:40.773Z,1633641700.773 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9597
2021-10-07T21:21:40.774Z,1633641700.774 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-10-07T21:21:40.774Z,1633641700.774 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-10-07T21:21:40.933Z,1633641700.933 [SBIT](DEBUG): Construct Startup Built In Test.
2021-10-07T21:21:40.942Z,1633641700.942 [SBIT] Loaded
2021-10-07T21:21:40.943Z,1633641700.943 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-10-07T21:21:40.946Z,1633641700.946 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-10-07T21:21:40.959Z,1633641700.959 [IBIT] Loaded
2021-10-07T21:21:40.959Z,1633641700.959 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-10-07T21:21:40.965Z,1633641700.965 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-10-07T21:21:41.071Z,1633641701.071 [CBIT] Loaded
2021-10-07T21:21:41.072Z,1633641701.072 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-10-07T21:21:41.072Z,1633641701.072 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-10-07T21:21:41.073Z,1633641701.073 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-10-07T21:21:41.102Z,1633641701.102 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-10-07T21:21:41.108Z,1633641701.108 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-10-07T21:21:41.111Z,1633641701.111 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-10-07T21:21:41.122Z,1633641701.122 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-10-07T21:21:41.123Z,1633641701.123 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B354E0
2021-10-07T21:21:41.123Z,1633641701.123 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9598
2021-10-07T21:21:41.128Z,1633641701.128 [Supervisor](INFO): Main Thread ID is 9278
2021-10-07T21:21:41.128Z,1633641701.128 [Supervisor](DEBUG): Running supervisor.
2021-10-07T21:21:41.129Z,1633641701.129 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9599
2021-10-07T21:21:41.132Z,1633641701.132 [controlThread ThreadHandler](INFO): Handler Thread ID is 9600
2021-10-07T21:21:41.132Z,1633641701.132 [controlThread](DEBUG): Initializing ControlThread
2021-10-07T21:21:41.134Z,1633641701.134 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-10-07T21:21:41.134Z,1633641701.134 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-10-07T21:21:41.135Z,1633641701.135 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-10-07T21:21:41.140Z,1633641701.140 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-10-07T21:21:41.141Z,1633641701.141 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-10-07T21:21:41.142Z,1633641701.142 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-10-07T21:21:41.143Z,1633641701.143 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-10-07T21:21:41.143Z,1633641701.143 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-10-07T21:21:41.144Z,1633641701.144 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-10-07T21:21:41.144Z,1633641701.144 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-10-07T21:21:41.144Z,1633641701.144 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-10-07T21:21:41.145Z,1633641701.145 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-10-07T21:21:41.145Z,1633641701.145 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-10-07T21:21:41.152Z,1633641701.152 [SBIT](INFO): Initialize SBIT Component.
2021-10-07T21:21:41.153Z,1633641701.153 [SBIT](IMPORTANT): git: 2021-09-29
2021-10-07T21:21:41.153Z,1633641701.153 [SBIT](INFO): git hash: d0bedea221735b48726a30f35f8acb1d414c6dbf
2021-10-07T21:21:41.153Z,1633641701.153 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-10-07T21:21:41.154Z,1633641701.154 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2021-10-07T21:21:41.156Z,1633641701.156 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2021-10-07T21:21:41.156Z,1633641701.156 [IBIT](INFO): Initialize IBIT Component.
2021-10-07T21:21:41.157Z,1633641701.157 [CBIT](DEBUG): Initialize CBIT Component.
2021-10-07T21:21:41.158Z,1633641701.158 [logger ThreadHandler](INFO): Handler Thread ID is 9601
2021-10-07T21:21:41.171Z,1633641701.171 [CBIT](DEBUG): Initialized mux pins.
2021-10-07T21:21:41.171Z,1633641701.171 [CBIT](DEBUG): Initializing the watchdog timer.
2021-10-07T21:21:41.176Z,1633641701.176 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9602
2021-10-07T21:21:41.176Z,1633641701.176 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-07T21:21:41.181Z,1633641701.181 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9604
2021-10-07T21:21:41.184Z,1633641701.184 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:21:41.185Z,1633641701.185 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9606
2021-10-07T21:21:41.192Z,1633641701.192 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9607
2021-10-07T21:21:41.193Z,1633641701.193 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-10-07T21:21:41.195Z,1633641701.195 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-10-07T21:21:41.196Z,1633641701.196 [CBIT](DEBUG): Initializing heartbeat.
2021-10-07T21:21:41.204Z,1633641701.204 [Onboard ThreadHandler](INFO): Handler Thread ID is 9608
2021-10-07T21:21:41.220Z,1633641701.220 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9609
2021-10-07T21:21:41.228Z,1633641701.228 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9610
2021-10-07T21:21:41.231Z,1633641701.231 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-10-07T21:21:41.232Z,1633641701.232 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-10-07T21:21:41.233Z,1633641701.233 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-10-07T21:21:41.233Z,1633641701.233 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-10-07T21:21:41.233Z,1633641701.233 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-10-07T21:21:41.233Z,1633641701.233 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-10-07T21:21:41.233Z,1633641701.233 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-10-07T21:21:41.234Z,1633641701.234 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-10-07T21:21:41.234Z,1633641701.234 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-10-07T21:21:41.234Z,1633641701.234 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-10-07T21:21:41.234Z,1633641701.234 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-10-07T21:21:41.267Z,1633641701.267 [CBIT](DEBUG): Deactivating GF circuits.
2021-10-07T21:21:41.267Z,1633641701.267 [CBIT](DEBUG): Deactivating emergency mode.
2021-10-07T21:21:41.303Z,1633641701.303 [CBIT](DEBUG): Backplane powered.
2021-10-07T21:21:41.304Z,1633641701.304 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-10-07T21:21:41.317Z,1633641701.317 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-10-07T21:21:41.341Z,1633641701.341 [MissionManager](DEBUG):
2021-10-07T21:21:41.342Z,1633641701.342 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-10-07T21:21:41.421Z,1633641701.421 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-10-07T21:21:41.423Z,1633641701.423 [Default:A.Wait](DEBUG): Construct Wait.
2021-10-07T21:21:41.441Z,1633641701.441 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-10-07T21:21:41.470Z,1633641701.470 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-10-07T21:21:41.473Z,1633641701.473 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-10-07T21:21:41.506Z,1633641701.506 [Default:E.Execute](DEBUG): Construct Execute.
2021-10-07T21:21:41.533Z,1633641701.533 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2021-10-07T21:21:41.538Z,1633641701.538 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2021-10-07T21:21:41.563Z,1633641701.563 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-07T21:21:41.623Z,1633641701.623 [Radio_Surface](INFO): Powering up
2021-10-07T21:21:41.646Z,1633641701.646 [Power24vConverter](INFO): Powering up.
2021-10-07T21:21:41.709Z,1633641701.709 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:41.716Z,1633641701.716 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-10-07T21:21:41.717Z,1633641701.717 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:41.732Z,1633641701.732 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-10-07T21:21:41.733Z,1633641701.733 [MassServo](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:41.748Z,1633641701.748 [MassServo](DEBUG): Initializing MassServo.
2021-10-07T21:21:41.748Z,1633641701.748 [RudderServo](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:41.756Z,1633641701.756 [RudderServo](DEBUG): Initializing RudderServo.
2021-10-07T21:21:41.757Z,1633641701.757 [ThrusterHE](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:41.764Z,1633641701.764 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2021-10-07T21:21:42.683Z,1633641702.683 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-10-07T21:21:42.683Z,1633641702.683 [RudderServo](FAULT): Rudder failed to initialize
2021-10-07T21:21:42.684Z,1633641702.684 [RudderServo] Communications Fault, FailCount= 1
2021-10-07T21:21:42.684Z,1633641702.684 [RudderServo](ERROR): Communications Fault
2021-10-07T21:21:42.699Z,1633641702.699 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-10-07T21:21:42.920Z,1633641702.920 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-10-07T21:21:42.921Z,1633641702.921 [RudderServo](INFO): Powering down
2021-10-07T21:21:43.585Z,1633641703.585 [RudderServo](DEBUG): Initializing EZServoServo.
2021-10-07T21:21:43.704Z,1633641703.704 [RudderServo](DEBUG): Initializing RudderServo.
2021-10-07T21:21:43.708Z,1633641703.708 [CBIT](INFO): Clearing failed state for component RudderServo
2021-10-07T21:21:43.708Z,1633641703.708 [RudderServo] No Fault, FailCount= 1
2021-10-07T21:21:45.103Z,1633641705.103 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:45.531Z,1633641705.531 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:46.099Z,1633641706.099 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:46.471Z,1633641706.471 [WetLabsBB2FL] Communications Fault, FailCount= 1
2021-10-07T21:21:46.471Z,1633641706.471 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:21:46.563Z,1633641706.563 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:46.740Z,1633641706.740 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:21:46.971Z,1633641706.971 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:21:47.079Z,1633641707.079 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:47.551Z,1633641707.551 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:48.007Z,1633641708.007 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:48.307Z,1633641708.307 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-07T21:21:48.307Z,1633641708.307 [WetLabsBB2FL] No Fault, FailCount= 1
2021-10-07T21:21:48.589Z,1633641708.589 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:21:48.635Z,1633641708.635 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:49.067Z,1633641709.067 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:49.495Z,1633641709.495 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:49.919Z,1633641709.919 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:50.331Z,1633641710.331 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:50.763Z,1633641710.763 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:51.199Z,1633641711.199 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:51.647Z,1633641711.647 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:52.087Z,1633641712.087 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:52.507Z,1633641712.507 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:52.923Z,1633641712.923 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:53.335Z,1633641713.335 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:53.763Z,1633641713.763 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:53.879Z,1633641713.879 [WetLabsBB2FL] Communications Fault, FailCount= 2
2021-10-07T21:21:53.879Z,1633641713.879 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:21:54.191Z,1633641714.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:54.227Z,1633641714.227 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-07T21:21:54.228Z,1633641714.228 [CTD_Seabird] Communications Fault, FailCount= 1
2021-10-07T21:21:54.228Z,1633641714.228 [CTD_Seabird](ERROR): Communications Fault
2021-10-07T21:21:54.250Z,1633641714.250 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-07T21:21:54.250Z,1633641714.250 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:21:54.379Z,1633641714.379 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:21:54.611Z,1633641714.611 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:54.612Z,1633641714.612 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-07T21:21:54.612Z,1633641714.612 [AHRS_M2] Communications Fault, FailCount= 1
2021-10-07T21:21:54.612Z,1633641714.612 [AHRS_M2](ERROR): Communications Fault
2021-10-07T21:21:54.632Z,1633641714.632 [CTD_Seabird](INFO): Powering down
2021-10-07T21:21:54.674Z,1633641714.674 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-07T21:21:54.712Z,1633641714.712 [AHRS_M2](INFO): Powering down
2021-10-07T21:21:55.517Z,1633641715.517 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-07T21:21:55.517Z,1633641715.517 [WetLabsBB2FL] No Fault, FailCount= 2
2021-10-07T21:21:55.518Z,1633641715.518 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-07T21:21:55.518Z,1633641715.518 [AHRS_M2] No Fault, FailCount= 1
2021-10-07T21:21:55.597Z,1633641715.597 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:21:55.896Z,1633641715.896 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-07T21:21:55.954Z,1633641715.954 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-10-07T21:21:55.954Z,1633641715.954 [CTD_Seabird] No Fault, FailCount= 1
2021-10-07T21:21:55.975Z,1633641715.975 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-07T21:21:59.439Z,1633641719.439 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:21:59.859Z,1633641719.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:00.263Z,1633641720.263 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:00.683Z,1633641720.683 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:00.887Z,1633641720.887 [WetLabsBB2FL] Communications Fault, FailCount= 3
2021-10-07T21:22:00.887Z,1633641720.887 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:22:01.095Z,1633641721.095 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:01.145Z,1633641721.145 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:22:01.387Z,1633641721.387 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:22:01.515Z,1633641721.515 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:01.927Z,1633641721.927 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:01.971Z,1633641721.971 [SBIT](IMPORTANT): Beginning Startup BIT
2021-10-07T21:22:01.984Z,1633641721.984 [CBIT](IMPORTANT): Beginning ground fault scan
2021-10-07T21:22:02.363Z,1633641722.363 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:02.461Z,1633641722.461 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-07T21:22:02.461Z,1633641722.461 [WetLabsBB2FL] No Fault, FailCount= 3
2021-10-07T21:22:02.601Z,1633641722.601 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:22:02.819Z,1633641722.819 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:03.251Z,1633641723.251 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:03.687Z,1633641723.687 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:04.287Z,1633641724.287 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:04.787Z,1633641724.787 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:05.247Z,1633641725.247 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:05.831Z,1633641725.831 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:06.387Z,1633641726.387 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:06.807Z,1633641726.807 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:07.359Z,1633641727.359 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:07.875Z,1633641727.875 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:07.891Z,1633641727.891 [WetLabsBB2FL] Communications Fault, FailCount= 4
2021-10-07T21:22:07.891Z,1633641727.891 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:22:07.959Z,1633641727.959 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:22:08.307Z,1633641728.307 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:08.392Z,1633641728.392 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:22:08.803Z,1633641728.803 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:08.803Z,1633641728.803 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:08.804Z,1633641728.804 [AHRS_M2] Communications Fault, FailCount= 2
2021-10-07T21:22:08.804Z,1633641728.804 [AHRS_M2](ERROR): Communications Fault
2021-10-07T21:22:08.896Z,1633641728.896 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-07T21:22:08.934Z,1633641728.934 [AHRS_M2](INFO): Powering down
2021-10-07T21:22:09.027Z,1633641729.027 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:09.027Z,1633641729.027 [CTD_Seabird] Communications Fault, FailCount= 2
2021-10-07T21:22:09.028Z,1633641729.028 [CTD_Seabird](ERROR): Communications Fault
2021-10-07T21:22:09.106Z,1633641729.106 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-07T21:22:09.381Z,1633641729.381 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-07T21:22:09.381Z,1633641729.381 [WetLabsBB2FL] No Fault, FailCount= 4
2021-10-07T21:22:09.432Z,1633641729.432 [CTD_Seabird](INFO): Powering down
2021-10-07T21:22:09.612Z,1633641729.612 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:22:09.780Z,1633641729.780 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-07T21:22:09.780Z,1633641729.780 [AHRS_M2] No Fault, FailCount= 2
2021-10-07T21:22:10.117Z,1633641730.117 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-07T21:22:10.580Z,1633641730.580 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-10-07T21:22:10.580Z,1633641730.580 [CTD_Seabird] No Fault, FailCount= 2
2021-10-07T21:22:10.775Z,1633641730.775 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-07T21:22:10.929Z,1633641730.929 [NAL9602](INFO): Powering up NAL9602
2021-10-07T21:22:13.659Z,1633641733.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:14.091Z,1633641734.091 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:14.583Z,1633641734.583 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:14.630Z,1633641734.630 [CBIT](IMPORTANT): Low side ground fault detected
mA:
CHAN A0 (Batt): 0.887030
CHAN A1 (24V): 1.020426
CHAN A2 (12V): 0.928864
CHAN A3 (5V): 0.951439
CHAN B0 (3.3V): 0.750124
CHAN B1 (3.15aV): 0.981305
CHAN B2 (3.15bV): 0.981711
CHAN B3 (GND): 0.054362
OPEN: 0.028000
Full Scale: +/- 1 mA
2021-10-07T21:22:14.895Z,1633641734.895 [WetLabsBB2FL] Communications Fault, FailCount= 5
2021-10-07T21:22:14.895Z,1633641734.895 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:22:15.039Z,1633641735.039 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:15.094Z,1633641735.094 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:22:15.094Z,1633641735.094 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:22:15.395Z,1633641735.395 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:22:15.471Z,1633641735.471 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:15.895Z,1633641735.895 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:16.323Z,1633641736.323 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:16.739Z,1633641736.739 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:17.159Z,1633641737.159 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:17.735Z,1633641737.735 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:18.175Z,1633641738.175 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:18.635Z,1633641738.635 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:19.087Z,1633641739.087 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:19.567Z,1633641739.567 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:20.043Z,1633641740.043 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:20.508Z,1633641740.508 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:20.963Z,1633641740.963 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:21.443Z,1633641741.443 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:21.903Z,1633641741.903 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:21.909Z,1633641741.909 [NAL9602](INFO): NAL9602 initialized
2021-10-07T21:22:22.383Z,1633641742.383 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:22.915Z,1633641742.915 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:23.567Z,1633641743.567 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:23.567Z,1633641743.567 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:23.568Z,1633641743.568 [AHRS_M2] Communications Fault, FailCount= 3
2021-10-07T21:22:23.568Z,1633641743.568 [AHRS_M2](ERROR): Communications Fault
2021-10-07T21:22:23.681Z,1633641743.681 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-07T21:22:23.693Z,1633641743.693 [AHRS_M2](INFO): Powering down
2021-10-07T21:22:23.836Z,1633641743.836 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:23.836Z,1633641743.836 [CTD_Seabird] Communications Fault, FailCount= 3
2021-10-07T21:22:23.836Z,1633641743.836 [CTD_Seabird](ERROR): Communications Fault
2021-10-07T21:22:24.144Z,1633641744.144 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-07T21:22:24.145Z,1633641744.145 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2021-10-07T21:22:24.239Z,1633641744.239 [CTD_Seabird](INFO): Powering down
2021-10-07T21:22:24.558Z,1633641744.558 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-07T21:22:24.558Z,1633641744.558 [AHRS_M2] No Fault, FailCount= 3
2021-10-07T21:22:24.908Z,1633641744.908 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-07T21:22:28.455Z,1633641748.455 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:28.856Z,1633641748.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:29.267Z,1633641749.267 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:29.703Z,1633641749.703 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:30.104Z,1633641750.104 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:30.543Z,1633641750.543 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:30.959Z,1633641750.959 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:31.387Z,1633641751.387 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:31.839Z,1633641751.839 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:32.267Z,1633641752.267 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:32.763Z,1633641752.763 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:33.175Z,1633641753.175 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:33.583Z,1633641753.583 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:34.015Z,1633641754.015 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:34.431Z,1633641754.431 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:34.843Z,1633641754.843 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:35.271Z,1633641755.271 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:35.703Z,1633641755.703 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:36.127Z,1633641756.127 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:36.559Z,1633641756.559 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:36.979Z,1633641756.979 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:37.395Z,1633641757.395 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:37.811Z,1633641757.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:37.811Z,1633641757.811 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:37.812Z,1633641757.812 [AHRS_M2] Communications Fault, FailCount= 4
2021-10-07T21:22:37.812Z,1633641757.812 [AHRS_M2](ERROR): Communications Fault
2021-10-07T21:22:37.837Z,1633641757.837 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-07T21:22:37.913Z,1633641757.913 [AHRS_M2](INFO): Powering down
2021-10-07T21:22:38.674Z,1633641758.674 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-07T21:22:38.674Z,1633641758.674 [AHRS_M2] No Fault, FailCount= 4
2021-10-07T21:22:39.060Z,1633641759.060 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-07T21:22:42.615Z,1633641762.615 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:43.059Z,1633641763.059 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:43.487Z,1633641763.487 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:43.903Z,1633641763.903 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:44.319Z,1633641764.319 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:44.855Z,1633641764.855 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:45.335Z,1633641765.335 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:45.787Z,1633641765.787 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:46.266Z,1633641766.266 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:46.723Z,1633641766.723 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:47.191Z,1633641767.191 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:47.675Z,1633641767.675 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:48.307Z,1633641768.307 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:48.751Z,1633641768.751 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:49.175Z,1633641769.175 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:49.599Z,1633641769.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:50.039Z,1633641770.039 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:50.455Z,1633641770.455 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:50.891Z,1633641770.891 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:51.327Z,1633641771.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:51.771Z,1633641771.771 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:52.195Z,1633641772.195 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-07T21:22:52.195Z,1633641772.195 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-07T21:22:52.195Z,1633641772.195 [AHRS_M2] Communications Fault, FailCount= 5
2021-10-07T21:22:52.196Z,1633641772.196 [AHRS_M2](ERROR): Communications Fault
2021-10-07T21:22:52.330Z,1633641772.330 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-07T21:22:52.330Z,1633641772.330 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2021-10-07T21:22:52.341Z,1633641772.341 [AHRS_M2](INFO): Powering down
2021-10-07T21:22:52.438Z,1633641772.438 [CommandLine](FAULT): Scheduling is paused
2021-10-07T21:22:52.438Z,1633641772.438 [CBIT](INFO): Critical error at 20211007T212252
2021-10-07T21:22:52.439Z,1633641772.439 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-10-07T21:22:56.422Z,1633641776.422 [SBIT](IMPORTANT): SBIT PASSED
2021-10-07T21:22:56.422Z,1633641776.422 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-10-07T21:22:56.423Z,1633641776.423 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=1 bool;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;
2021-10-07T21:22:56.424Z,1633641776.424 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): PAR_Licor.adcCal=8.76539e-06 microampere_per_count;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): PAR_Licor.darkCount=4 count;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): PAR_Licor.multiplier=269.34 micromole_per_second_per_square_meter_per_microampere;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): PAR_Licor.parCal=1.221 none;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): ThrusterHE.loadAtStartup=1 bool;
2021-10-07T21:22:56.425Z,1633641776.425 [SBIT](IMPORTANT): ThrusterHE.simulateHardware=0 bool;
2021-10-07T21:22:56.426Z,1633641776.426 [SBIT](IMPORTANT): ThrusterServo.loadAtStartup=0 bool;
2021-10-07T21:22:56.426Z,1633641776.426 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;
2021-10-07T21:22:56.426Z,1633641776.426 [SBIT](IMPORTANT): VerticalControl.massDefault=0 centimeter;
2021-10-07T21:22:56.426Z,1633641776.426 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-26 millimeter;
2021-10-07T21:22:56.426Z,1633641776.426 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter;
2021-10-07T21:22:56.825Z,1633641776.825 [MissionManager](IMPORTANT): Started mission Startup
2021-10-07T21:22:56.825Z,1633641776.825 [Startup] Running Loop=1
2021-10-07T21:22:56.826Z,1633641776.826 [Startup](DEBUG): Aggregate::initialize Startup
2021-10-07T21:22:56.826Z,1633641776.826 [Startup:A.GoToSurface] Running Loop=1
2021-10-07T21:22:56.826Z,1633641776.826 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-10-07T21:22:56.826Z,1633641776.826 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-10-07T21:22:56.827Z,1633641776.827 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-10-07T21:22:56.827Z,1633641776.827 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-10-07T21:22:56.828Z,1633641776.828 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-10-07T21:22:56.828Z,1633641776.828 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-10-07T21:22:56.830Z,1633641776.830 [Startup:StartupSatComms] Running Loop=1
2021-10-07T21:22:56.830Z,1633641776.830 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-10-07T21:22:56.830Z,1633641776.830 [Startup:StartupSatComms:A] Running Loop=1
2021-10-07T21:22:57.208Z,1633641777.208 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-10-07T21:23:41.239Z,1633641821.239 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-10-07T21:23:41.239Z,1633641821.239 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2021-10-07T21:23:41.239Z,1633641821.239 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-10-07T21:23:41.241Z,1633641821.241 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2021-10-07T21:23:41.241Z,1633641821.241 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2021-10-07T21:23:41.241Z,1633641821.241 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2021-10-07T21:23:41.252Z,1633641821.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-10-07T21:23:41.253Z,1633641821.253 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2021-10-07T21:23:41.665Z,1633641821.665 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-10-07T21:23:41.665Z,1633641821.665 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2021-10-07T21:23:41.665Z,1633641821.665 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2021-10-07T21:23:41.666Z,1633641821.666 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2021-10-07T21:23:42.040Z,1633641822.040 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-10-07T21:23:56.997Z,1633641836.997 [Startup:StartupSatComms:A](INFO): Timed out from 2021-10-07T21:22:56.8Z
2021-10-07T21:23:56.997Z,1633641836.997 [Startup:StartupSatComms:A] Stopped
2021-10-07T21:23:56.997Z,1633641836.997 [Startup:StartupSatComms:B] Running Loop=1
2021-10-07T21:23:57.413Z,1633641837.413 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-10-07T21:24:08.862Z,1633641848.862 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005000
2021-10-07T21:24:17.163Z,1633641857.163 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20211007T210432/Courier0004.lzma
2021-10-07T21:24:18.165Z,1633641858.165 [DataOverHttps](INFO): Moved sent file to Logs/20211007T210432/Courier0004.lzma.bak
2021-10-07T21:24:18.165Z,1633641858.165 [DataOverHttps](INFO): SBD MOMSN=15979131
2021-10-07T21:24:34.495Z,1633641874.495 [DataOverHttps](INFO): Sending 101 bytes from file Logs/20211007T212131/Courier0000.lzma
2021-10-07T21:24:35.497Z,1633641875.497 [DataOverHttps](INFO): Moved sent file to Logs/20211007T212131/Courier0000.lzma.bak
2021-10-07T21:24:35.497Z,1633641875.497 [DataOverHttps](INFO): SBD MOMSN=15979135
2021-10-07T21:24:45.084Z,1633641885.084 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-07T21:24:45.084Z,1633641885.084 [WetLabsBB2FL] No Fault, FailCount= 5
2021-10-07T21:24:45.285Z,1633641885.285 [WetLabsBB2FL](INFO): Powering up
2021-10-07T21:24:49.009Z,1633641889.009 [CommandLine](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml
2021-10-07T21:24:49.009Z,1633641889.009 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/run_backseat_on_surface.xml
2021-10-07T21:24:49.068Z,1633641889.068 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2021-10-07T21:24:49.068Z,1633641889.068 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2021-10-07T21:24:49.660Z,1633641889.660 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2021-10-07T21:24:49.662Z,1633641889.662 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2021-10-07T21:24:49.665Z,1633641889.665 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2021-10-07T21:24:49.668Z,1633641889.668 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2021-10-07T21:24:49.671Z,1633641889.671 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2021-10-07T21:24:49.685Z,1633641889.685 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2021-10-07T21:24:49.688Z,1633641889.688 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool
2021-10-07T21:24:49.691Z,1633641889.691 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2021-10-07T21:24:49.694Z,1633641889.694 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2021-10-07T21:24:49.746Z,1633641889.746 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2021-10-07T21:24:49.753Z,1633641889.753 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2021-10-07T21:24:49.767Z,1633641889.767 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2021-10-07T21:24:49.770Z,1633641889.770 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2021-10-07T21:24:49.773Z,1633641889.773 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2021-10-07T21:24:49.792Z,1633641889.792 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2021-10-07T21:24:49.796Z,1633641889.796 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0.000000 bool
2021-10-07T21:24:49.815Z,1633641889.815 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0.000000 bool
2021-10-07T21:24:49.819Z,1633641889.819 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1.000000 bool
2021-10-07T21:24:49.827Z,1633641889.827 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1.000000 bool
2021-10-07T21:24:49.843Z,1633641889.843 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2021-10-07T21:24:49.850Z,1633641889.850 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0.000000 bool
2021-10-07T21:24:49.853Z,1633641889.853 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2021-10-07T21:24:49.865Z,1633641889.865 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2021-10-07T21:24:49.878Z,1633641889.878 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m
2021-10-07T21:24:49.929Z,1633641889.929 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m
2021-10-07T21:24:49.952Z,1633641889.952 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2021-10-07T21:24:49.956Z,1633641889.956 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = 0.000000 ug/l
2021-10-07T21:24:49.971Z,1633641889.971 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = 0.000000 m
2021-10-07T21:24:49.975Z,1633641889.975 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = 0.000000 degC
2021-10-07T21:24:49.990Z,1633641889.990 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2021-10-07T21:24:50.002Z,1633641890.002 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2021-10-07T21:24:50.005Z,1633641890.005 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = 0.000000 umol/l
2021-10-07T21:24:50.023Z,1633641890.023 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = 0.000000 m
2021-10-07T21:24:50.046Z,1633641890.046 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2021-10-07T21:24:50.058Z,1633641890.058 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2021-10-07T21:24:50.061Z,1633641890.061 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = 0.000000 kg/m3
2021-10-07T21:24:50.076Z,1633641890.076 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = 0.000000 m
2021-10-07T21:24:50.080Z,1633641890.080 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2021-10-07T21:24:50.086Z,1633641890.086 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2021-10-07T21:24:50.091Z,1633641890.091 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = 0.000000 ppb
2021-10-07T21:24:50.103Z,1633641890.103 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = 0.000000 m
2021-10-07T21:24:50.106Z,1633641890.106 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2021-10-07T21:24:50.133Z,1633641890.133 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2021-10-07T21:24:50.136Z,1633641890.136 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2021-10-07T21:24:50.154Z,1633641890.154 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m
2021-10-07T21:24:50.157Z,1633641890.157 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = 0.000000 psu
2021-10-07T21:24:50.188Z,1633641890.188 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = 0.000000 m
2021-10-07T21:24:50.191Z,1633641890.191 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = 0.000000 degC
2021-10-07T21:24:50.194Z,1633641890.194 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2021-10-07T21:24:50.222Z,1633641890.222 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2021-10-07T21:24:50.229Z,1633641890.229 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = 0.000000 ug/l
2021-10-07T21:24:50.242Z,1633641890.242 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = 0.000000 m
2021-10-07T21:24:50.254Z,1633641890.254 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2021-10-07T21:24:50.257Z,1633641890.257 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2021-10-07T21:24:50.284Z,1633641890.284 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2021-10-07T21:24:50.287Z,1633641890.287 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = 0.000000 psu
2021-10-07T21:24:50.291Z,1633641890.291 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = 0.000000 m
2021-10-07T21:24:50.367Z,1633641890.367 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2021-10-07T21:24:50.381Z,1633641890.381 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2021-10-07T21:24:50.401Z,1633641890.401 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2021-10-07T21:24:50.415Z,1633641890.415 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = 0.000000 psu
2021-10-07T21:24:50.430Z,1633641890.430 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = 0.000000 m
2021-10-07T21:24:50.461Z,1633641890.461 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2021-10-07T21:24:50.486Z,1633641890.486 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2021-10-07T21:24:50.518Z,1633641890.518 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2021-10-07T21:24:50.579Z,1633641890.579 [WetLabsBB2FL] Communications Fault, FailCount= 1
2021-10-07T21:24:50.579Z,1633641890.579 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-07T21:24:50.783Z,1633641890.783 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-07T21:24:50.825Z,1633641890.825 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-10-07T21:24:50.882Z,1633641890.882 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-10-07T21:24:50.942Z,1633641890.942 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-10-07T21:24:50.977Z,1633641890.977 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-10-07T21:24:51.025Z,1633641891.025 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-10-07T21:24:51.079Z,1633641891.079 [WetLabsBB2FL](INFO): Powering down
2021-10-07T21:24:51.084Z,1633641891.084 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-10-07T21:24:51.135Z,1633641891.135 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-10-07T21:24:51.200Z,1633641891.200 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-10-07T21:24:51.280Z,1633641891.280 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver.
2021-10-07T21:24:51.300Z,1633641891.300 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface.
2021-10-07T21:24:51.341Z,1633641891.341 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-10-07T21:24:51.343Z,1633641891.343 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-10-07T21:24:51.381Z,1633641891.381 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute.
2021-10-07T21:24:51.446Z,1633641891.446 [MissionManager](DEBUG):
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs