2021-03-29T19:20:43.676Z,1617045643.676 [Supervisor](DEBUG): Initializing supervisor.
2021-03-29T19:20:43.681Z,1617045643.681 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-03-29T19:20:43.682Z,1617045643.682 [SyncHandler](INFO): Protected caller Thread ID is 9612
2021-03-29T19:20:43.682Z,1617045643.682 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-03-29T19:20:43.683Z,1617045643.683 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-03-29T19:20:43.683Z,1617045643.683 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9613
2021-03-29T19:20:43.688Z,1617045643.688 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-03-29T19:20:43.708Z,1617045643.708 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-03-29T19:20:43.709Z,1617045643.709 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-03-29T19:20:43.709Z,1617045643.709 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9614
2021-03-29T19:20:43.711Z,1617045643.711 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-03-29T19:20:43.712Z,1617045643.712 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-03-29T19:20:43.713Z,1617045643.713 [logger ThreadHandler](INFO): Protected caller Thread ID is 9615
2021-03-29T19:20:43.717Z,1617045643.717 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-03-29T19:20:43.717Z,1617045643.717 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-03-29T19:20:43.719Z,1617045643.719 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-03-29T19:20:44.121Z,1617045644.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-03-29T19:20:44.121Z,1617045644.121 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-03-29T19:20:44.331Z,1617045644.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-03-29T19:20:44.332Z,1617045644.332 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-03-29T19:20:44.531Z,1617045644.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-03-29T19:20:44.532Z,1617045644.532 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-03-29T19:20:44.630Z,1617045644.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-03-29T19:20:44.630Z,1617045644.630 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-03-29T19:20:44.986Z,1617045644.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-03-29T19:20:44.986Z,1617045644.986 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-03-29T19:20:45.370Z,1617045645.370 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-03-29T19:20:45.370Z,1617045645.370 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-03-29T19:20:45.499Z,1617045645.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-03-29T19:20:45.499Z,1617045645.499 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-03-29T19:20:45.647Z,1617045645.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-03-29T19:20:45.648Z,1617045645.648 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-03-29T19:20:46.175Z,1617045646.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-03-29T19:20:46.175Z,1617045646.175 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-03-29T19:20:46.533Z,1617045646.533 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-03-29T19:20:46.534Z,1617045646.534 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-03-29T19:20:46.614Z,1617045646.614 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-03-29T19:20:46.820Z,1617045646.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-03-29T19:20:46.820Z,1617045646.820 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-03-29T19:20:46.945Z,1617045646.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-03-29T19:20:46.946Z,1617045646.946 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-03-29T19:20:47.596Z,1617045647.596 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-03-29T19:20:47.597Z,1617045647.597 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-03-29T19:20:47.675Z,1617045647.675 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-03-29T19:20:47.924Z,1617045647.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-03-29T19:20:47.926Z,1617045647.926 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2021-03-29T19:20:47.927Z,1617045647.927 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2021-03-29T19:20:48.097Z,1617045648.097 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2021-03-29T19:20:48.192Z,1617045648.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2021-03-29T19:20:48.301Z,1617045648.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2021-03-29T19:20:48.408Z,1617045648.408 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2021-03-29T19:20:48.679Z,1617045648.679 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2021-03-29T19:20:48.945Z,1617045648.945 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2021-03-29T19:20:49.074Z,1617045649.074 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2021-03-29T19:20:49.175Z,1617045649.175 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2021-03-29T19:20:49.575Z,1617045649.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2021-03-29T19:20:49.871Z,1617045649.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-03-29T19:20:49.872Z,1617045649.872 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2021-03-29T19:20:49.966Z,1617045649.966 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2021-03-29T19:20:49.966Z,1617045649.966 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-03-29T19:20:49.976Z,1617045649.976 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-03-29T19:20:50.309Z,1617045650.309 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-03-29T19:20:50.310Z,1617045650.310 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-03-29T19:20:50.393Z,1617045650.393 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-03-29T19:20:50.393Z,1617045650.393 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-03-29T19:20:50.426Z,1617045650.426 [DeadReckonUsingSpeedCalculator] Loaded
2021-03-29T19:20:50.426Z,1617045650.426 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2021-03-29T19:20:50.439Z,1617045650.439 [NavChart] Loaded
2021-03-29T19:20:50.440Z,1617045650.440 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-03-29T19:20:50.445Z,1617045650.445 [UniversalFixResidualReporter] Loaded
2021-03-29T19:20:50.446Z,1617045650.446 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-03-29T19:20:50.446Z,1617045650.446 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-03-29T19:20:50.447Z,1617045650.447 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-03-29T19:20:50.458Z,1617045650.458 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-03-29T19:20:50.458Z,1617045650.458 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-03-29T19:20:50.580Z,1617045650.580 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-03-29T19:20:50.580Z,1617045650.580 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-03-29T19:20:50.635Z,1617045650.635 [VerticalControl](DEBUG): Construct VerticalControl.
2021-03-29T19:20:50.695Z,1617045650.695 [VerticalControl] Loaded
2021-03-29T19:20:50.695Z,1617045650.695 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-03-29T19:20:50.698Z,1617045650.698 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-03-29T19:20:50.736Z,1617045650.736 [HorizontalControl] Loaded
2021-03-29T19:20:50.736Z,1617045650.736 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-03-29T19:20:50.739Z,1617045650.739 [SpeedControl](DEBUG): Construct SpeedControl.
2021-03-29T19:20:50.742Z,1617045650.742 [SpeedControl] Loaded
2021-03-29T19:20:50.742Z,1617045650.742 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-03-29T19:20:50.745Z,1617045650.745 [LoopControl](DEBUG): Construct LoopControl.
2021-03-29T19:20:50.745Z,1617045650.745 [LoopControl] Loaded
2021-03-29T19:20:50.746Z,1617045650.746 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-03-29T19:20:50.746Z,1617045650.746 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-03-29T19:20:50.746Z,1617045650.746 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-03-29T19:20:50.790Z,1617045650.790 [DepthRateCalculator] Loaded
2021-03-29T19:20:50.790Z,1617045650.790 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-03-29T19:20:50.795Z,1617045650.795 [PitchRateCalculator] Loaded
2021-03-29T19:20:50.795Z,1617045650.795 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-03-29T19:20:50.804Z,1617045650.804 [SpeedCalculator] Loaded
2021-03-29T19:20:50.804Z,1617045650.804 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-03-29T19:20:50.818Z,1617045650.818 [TempGradientCalculator] Loaded
2021-03-29T19:20:50.818Z,1617045650.818 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-03-29T19:20:50.822Z,1617045650.822 [YawRateCalculator] Loaded
2021-03-29T19:20:50.823Z,1617045650.823 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-03-29T19:20:50.840Z,1617045650.840 [ElevatorOffsetCalculator] Loaded
2021-03-29T19:20:50.840Z,1617045650.840 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-03-29T19:20:50.840Z,1617045650.840 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-03-29T19:20:50.841Z,1617045650.841 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-03-29T19:20:50.940Z,1617045650.940 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-03-29T19:20:50.941Z,1617045650.941 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-03-29T19:20:50.999Z,1617045650.999 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-03-29T19:20:50.000Z,1617045651.000 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-03-29T19:20:51.126Z,1617045651.126 [BuoyancyServo] Loaded
2021-03-29T19:20:51.126Z,1617045651.126 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-03-29T19:20:51.145Z,1617045651.145 [ElevatorServo] Loaded
2021-03-29T19:20:51.146Z,1617045651.146 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-03-29T19:20:51.169Z,1617045651.169 [DockingServo] Loaded
2021-03-29T19:20:51.169Z,1617045651.169 [ComponentRegistry](DEBUG): SyncComponent "DockingServo" handled in the control thread.
2021-03-29T19:20:51.188Z,1617045651.188 [RudderServo] Loaded
2021-03-29T19:20:51.188Z,1617045651.188 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-03-29T19:20:51.205Z,1617045651.205 [ThrusterServo] Loaded
2021-03-29T19:20:51.205Z,1617045651.205 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-03-29T19:20:51.206Z,1617045651.206 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-03-29T19:20:51.206Z,1617045651.206 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-03-29T19:20:51.315Z,1617045651.315 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-03-29T19:20:51.316Z,1617045651.316 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-03-29T19:20:51.679Z,1617045651.679 [AHRS_M2] Loaded
2021-03-29T19:20:51.680Z,1617045651.680 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-03-29T19:20:52.486Z,1617045652.486 [BPC1] Loaded
2021-03-29T19:20:52.487Z,1617045652.487 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-03-29T19:20:52.557Z,1617045652.557 [DataOverHttps] Loaded
2021-03-29T19:20:52.557Z,1617045652.557 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-03-29T19:20:52.559Z,1617045652.559 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409AA4E0
2021-03-29T19:20:52.559Z,1617045652.559 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9698
2021-03-29T19:20:52.579Z,1617045652.579 [Depth_Keller] Loaded
2021-03-29T19:20:52.579Z,1617045652.579 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-03-29T19:20:52.638Z,1617045652.638 [NAL9602] Loaded
2021-03-29T19:20:52.639Z,1617045652.639 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-03-29T19:20:52.665Z,1617045652.665 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2021-03-29T19:20:52.665Z,1617045652.665 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2021-03-29T19:20:52.666Z,1617045652.666 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2021-03-29T19:20:52.666Z,1617045652.666 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2021-03-29T19:20:52.667Z,1617045652.667 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2021-03-29T19:20:52.667Z,1617045652.667 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2021-03-29T19:20:52.668Z,1617045652.668 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2021-03-29T19:20:52.669Z,1617045652.669 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2021-03-29T19:20:52.669Z,1617045652.669 [Onboard] Loaded
2021-03-29T19:20:52.669Z,1617045652.669 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-03-29T19:20:52.670Z,1617045652.670 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409DA4E0
2021-03-29T19:20:52.670Z,1617045652.670 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9699
2021-03-29T19:20:52.683Z,1617045652.683 [Radio_Surface] Loaded
2021-03-29T19:20:52.684Z,1617045652.684 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-03-29T19:20:52.685Z,1617045652.685 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A0A4E0
2021-03-29T19:20:52.685Z,1617045652.685 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9700
2021-03-29T19:20:52.686Z,1617045652.686 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-03-29T19:20:52.687Z,1617045652.687 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-03-29T19:20:52.838Z,1617045652.838 [SBIT](DEBUG): Construct Startup Built In Test.
2021-03-29T19:20:52.847Z,1617045652.847 [SBIT] Loaded
2021-03-29T19:20:52.847Z,1617045652.847 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-03-29T19:20:52.850Z,1617045652.850 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-03-29T19:20:52.863Z,1617045652.863 [IBIT] Loaded
2021-03-29T19:20:52.863Z,1617045652.863 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-03-29T19:20:52.869Z,1617045652.869 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-03-29T19:20:52.969Z,1617045652.969 [CBIT] Loaded
2021-03-29T19:20:52.969Z,1617045652.969 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-03-29T19:20:52.970Z,1617045652.970 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-03-29T19:20:52.970Z,1617045652.970 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-03-29T19:20:52.999Z,1617045652.999 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-03-29T19:20:53.005Z,1617045653.005 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-03-29T19:20:53.008Z,1617045653.008 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-03-29T19:20:53.019Z,1617045653.019 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-03-29T19:20:53.020Z,1617045653.020 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A954E0
2021-03-29T19:20:53.021Z,1617045653.021 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9701
2021-03-29T19:20:53.026Z,1617045653.026 [Supervisor](INFO): Main Thread ID is 9611
2021-03-29T19:20:53.026Z,1617045653.026 [Supervisor](DEBUG): Running supervisor.
2021-03-29T19:20:53.026Z,1617045653.026 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9702
2021-03-29T19:20:53.029Z,1617045653.029 [controlThread ThreadHandler](INFO): Handler Thread ID is 9703
2021-03-29T19:20:53.029Z,1617045653.029 [controlThread](DEBUG): Initializing ControlThread
2021-03-29T19:20:53.031Z,1617045653.031 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-03-29T19:20:53.031Z,1617045653.031 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-03-29T19:20:53.032Z,1617045653.032 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-03-29T19:20:53.033Z,1617045653.033 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-03-29T19:20:53.034Z,1617045653.034 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-03-29T19:20:53.035Z,1617045653.035 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-03-29T19:20:53.035Z,1617045653.035 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-03-29T19:20:53.036Z,1617045653.036 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-03-29T19:20:53.036Z,1617045653.036 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-03-29T19:20:53.037Z,1617045653.037 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-03-29T19:20:53.037Z,1617045653.037 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-03-29T19:20:53.038Z,1617045653.038 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-03-29T19:20:53.038Z,1617045653.038 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-03-29T19:20:53.044Z,1617045653.044 [SBIT](INFO): Initialize SBIT Component.
2021-03-29T19:20:53.045Z,1617045653.045 [SBIT](IMPORTANT): git: 2021-02-15-23-g3a852c62c
2021-03-29T19:20:53.045Z,1617045653.045 [SBIT](INFO): git hash: 3a852c62cd7a39cad2b788ae0015bb0a43866a82
2021-03-29T19:20:53.045Z,1617045653.045 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-03-29T19:20:53.047Z,1617045653.047 [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-03-29T19:20:53.048Z,1617045653.048 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2021-03-29T19:20:53.048Z,1617045653.048 [IBIT](INFO): Initialize IBIT Component.
2021-03-29T19:20:53.049Z,1617045653.049 [CBIT](DEBUG): Initialize CBIT Component.
2021-03-29T19:20:53.050Z,1617045653.050 [logger ThreadHandler](INFO): Handler Thread ID is 9704
2021-03-29T19:20:53.064Z,1617045653.064 [CBIT](DEBUG): Initialized mux pins.
2021-03-29T19:20:53.064Z,1617045653.064 [CBIT](DEBUG): Initializing the watchdog timer.
2021-03-29T19:20:53.068Z,1617045653.068 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9705
2021-03-29T19:20:53.069Z,1617045653.069 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-03-29T19:20:53.076Z,1617045653.076 [Onboard ThreadHandler](INFO): Handler Thread ID is 9706
2021-03-29T19:20:53.089Z,1617045653.089 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-03-29T19:20:53.089Z,1617045653.089 [CBIT](DEBUG): Initializing heartbeat.
2021-03-29T19:20:53.096Z,1617045653.096 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9707
2021-03-29T19:20:53.112Z,1617045653.112 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9708
2021-03-29T19:20:53.116Z,1617045653.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-03-29T19:20:53.116Z,1617045653.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-03-29T19:20:53.116Z,1617045653.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-03-29T19:20:53.116Z,1617045653.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-03-29T19:20:53.117Z,1617045653.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-03-29T19:20:53.118Z,1617045653.118 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-03-29T19:20:53.160Z,1617045653.160 [CBIT](DEBUG): Deactivating GF circuits.
2021-03-29T19:20:53.160Z,1617045653.160 [CBIT](DEBUG): Deactivating emergency mode.
2021-03-29T19:20:53.196Z,1617045653.196 [CBIT](DEBUG): Backplane powered.
2021-03-29T19:20:53.197Z,1617045653.197 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-03-29T19:20:53.210Z,1617045653.210 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-03-29T19:20:53.237Z,1617045653.237 [MissionManager](DEBUG):
2021-03-29T19:20:53.238Z,1617045653.238 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-03-29T19:20:53.307Z,1617045653.307 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-03-29T19:20:53.308Z,1617045653.308 [Default:A.Wait](DEBUG): Construct Wait.
2021-03-29T19:20:53.311Z,1617045653.311 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-03-29T19:20:53.355Z,1617045653.355 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-03-29T19:20:53.357Z,1617045653.357 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-03-29T19:20:53.375Z,1617045653.375 [Default:E.Execute](DEBUG): Construct Execute.
2021-03-29T19:20:53.378Z,1617045653.378 [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-03-29T19:20:53.406Z,1617045653.406 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-03-29T19:20:53.424Z,1617045653.424 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-03-29T19:20:53.490Z,1617045653.490 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2021-03-29T19:20:53.491Z,1617045653.491 [DepthRateCalculator](ERROR): Depth measurement is not active
2021-03-29T19:20:53.500Z,1617045653.500 [Radio_Surface](INFO): Powering up
2021-03-29T19:20:53.581Z,1617045653.581 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:53.638Z,1617045653.638 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-03-29T19:20:53.639Z,1617045653.639 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:53.714Z,1617045653.714 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-03-29T19:20:53.715Z,1617045653.715 [DockingServo](INFO): Start
2021-03-29T19:20:53.715Z,1617045653.715 [DockingServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:53.728Z,1617045653.728 [DockingServo](DEBUG): Initializing DockingServo.
2021-03-29T19:20:53.729Z,1617045653.729 [RudderServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:53.736Z,1617045653.736 [RudderServo](DEBUG): Initializing RudderServo.
2021-03-29T19:20:53.737Z,1617045653.737 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:53.744Z,1617045653.744 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-03-29T19:20:53.882Z,1617045653.882 [DockingServo](INFO): Starting
2021-03-29T19:20:54.232Z,1617045654.232 [DockingServo](INFO): Starting
2021-03-29T19:20:54.544Z,1617045654.544 [DockingServo](ERROR): Docking arm initialization uart error serial timeout
2021-03-29T19:20:54.544Z,1617045654.544 [DockingServo](FAULT): Failed to initialize
2021-03-29T19:20:54.544Z,1617045654.544 [DockingServo] Communications Fault, FailCount= 1
2021-03-29T19:20:54.544Z,1617045654.544 [DockingServo](ERROR): Communications Fault
2021-03-29T19:20:54.692Z,1617045654.692 [CBIT](ERROR): Communications Fault in component: DockingServo
2021-03-29T19:20:54.856Z,1617045654.856 [DockingServo](INFO): Stop
2021-03-29T19:20:54.856Z,1617045654.856 [DockingServo](DEBUG): Uninitialize Docking Servo.
2021-03-29T19:20:54.857Z,1617045654.857 [DockingServo](INFO): Powering down
2021-03-29T19:20:55.115Z,1617045655.115 [DockingServo](INFO): Stopping
2021-03-29T19:20:55.519Z,1617045655.519 [DockingServo](INFO): Stopped
2021-03-29T19:20:55.519Z,1617045655.519 [DockingServo](INFO): Is needed returning:1
2021-03-29T19:20:55.519Z,1617045655.519 [DockingServo](INFO): Start
2021-03-29T19:20:55.519Z,1617045655.519 [DockingServo](DEBUG): Initializing EZServoServo.
2021-03-29T19:20:55.641Z,1617045655.641 [DockingServo](DEBUG): Initializing DockingServo.
2021-03-29T19:20:55.645Z,1617045655.645 [CBIT](INFO): Clearing failed state for component DockingServo
2021-03-29T19:20:55.645Z,1617045655.645 [DockingServo] No Fault, FailCount= 1
2021-03-29T19:20:55.923Z,1617045655.923 [DockingServo](INFO): Starting
2021-03-29T19:20:56.376Z,1617045656.376 [DockingServo](INFO): Starting
2021-03-29T19:20:56.808Z,1617045656.808 [DockingServo](INFO): Starting
2021-03-29T19:20:57.230Z,1617045657.230 [DockingServo](INFO): Starting
2021-03-29T19:20:57.585Z,1617045657.585 [DockingServo](INFO): Starting
2021-03-29T19:20:58.025Z,1617045658.025 [DockingServo](INFO): Starting
2021-03-29T19:20:58.388Z,1617045658.388 [DockingServo](INFO): Starting
2021-03-29T19:20:58.777Z,1617045658.777 [DockingServo](INFO): Runnable
2021-03-29T19:20:59.309Z,1617045659.309 [DockingServo](INFO): Pause
2021-03-29T19:20:59.593Z,1617045659.593 [DockingServo](INFO): Paused
2021-03-29T19:20:59.996Z,1617045659.996 [DockingServo](INFO): Paused
2021-03-29T19:21:00.397Z,1617045660.397 [DockingServo](INFO): Paused
2021-03-29T19:21:00.825Z,1617045660.825 [DockingServo](INFO): Paused
2021-03-29T19:21:01.201Z,1617045661.201 [DockingServo](INFO): Paused
2021-03-29T19:21:01.609Z,1617045661.609 [DockingServo](INFO): Paused
2021-03-29T19:21:02.022Z,1617045662.022 [DockingServo](INFO): Paused
2021-03-29T19:21:02.398Z,1617045662.398 [DockingServo](INFO): Paused
2021-03-29T19:21:02.798Z,1617045662.798 [DockingServo](INFO): Paused
2021-03-29T19:21:03.198Z,1617045663.198 [DockingServo](INFO): Paused
2021-03-29T19:21:03.602Z,1617045663.602 [DockingServo](INFO): Paused
2021-03-29T19:21:04.005Z,1617045664.005 [DockingServo](INFO): Paused
2021-03-29T19:21:04.410Z,1617045664.410 [DockingServo](INFO): Paused
2021-03-29T19:21:04.813Z,1617045664.813 [DockingServo](INFO): Paused
2021-03-29T19:21:05.217Z,1617045665.217 [DockingServo](INFO): Paused
2021-03-29T19:21:05.622Z,1617045665.622 [DockingServo](INFO): Paused
2021-03-29T19:21:06.025Z,1617045666.025 [DockingServo](INFO): Paused
2021-03-29T19:21:06.429Z,1617045666.429 [DockingServo](INFO): Paused
2021-03-29T19:21:06.839Z,1617045666.839 [DockingServo](INFO): Paused
2021-03-29T19:21:07.238Z,1617045667.238 [DockingServo](INFO): Paused
2021-03-29T19:21:07.642Z,1617045667.642 [DockingServo](INFO): Paused
2021-03-29T19:21:08.046Z,1617045668.046 [DockingServo](INFO): Paused
2021-03-29T19:21:08.450Z,1617045668.450 [DockingServo](INFO): Paused
2021-03-29T19:21:08.858Z,1617045668.858 [DockingServo](INFO): Paused
2021-03-29T19:21:09.263Z,1617045669.263 [DockingServo](INFO): Paused
2021-03-29T19:21:09.666Z,1617045669.666 [DockingServo](INFO): Paused
2021-03-29T19:21:10.065Z,1617045670.065 [DockingServo](INFO): Paused
2021-03-29T19:21:10.470Z,1617045670.470 [DockingServo](INFO): Paused
2021-03-29T19:21:10.886Z,1617045670.886 [DockingServo](INFO): Paused
2021-03-29T19:21:11.277Z,1617045671.277 [DockingServo](INFO): Paused
2021-03-29T19:21:11.690Z,1617045671.690 [DockingServo](INFO): Paused
2021-03-29T19:21:12.104Z,1617045672.104 [DockingServo](INFO): Paused
2021-03-29T19:21:12.498Z,1617045672.498 [DockingServo](INFO): Paused
2021-03-29T19:21:12.893Z,1617045672.893 [DockingServo](INFO): Paused
2021-03-29T19:21:13.301Z,1617045673.301 [DockingServo](INFO): Paused
2021-03-29T19:21:13.722Z,1617045673.722 [DockingServo](INFO): Paused
2021-03-29T19:21:14.110Z,1617045674.110 [DockingServo](INFO): Paused
2021-03-29T19:21:14.518Z,1617045674.518 [DockingServo](INFO): Paused
2021-03-29T19:21:14.917Z,1617045674.917 [DockingServo](INFO): Paused
2021-03-29T19:21:15.339Z,1617045675.339 [DockingServo](INFO): Paused
2021-03-29T19:21:15.730Z,1617045675.730 [DockingServo](INFO): Paused
2021-03-29T19:21:16.134Z,1617045676.134 [DockingServo](INFO): Paused
2021-03-29T19:21:16.534Z,1617045676.534 [DockingServo](INFO): Paused
2021-03-29T19:21:16.961Z,1617045676.961 [DockingServo](INFO): Paused
2021-03-29T19:21:17.346Z,1617045677.346 [DockingServo](INFO): Paused
2021-03-29T19:21:17.741Z,1617045677.741 [DockingServo](INFO): Paused
2021-03-29T19:21:17.742Z,1617045677.742 [SBIT](IMPORTANT): Beginning Startup BIT
2021-03-29T19:21:17.746Z,1617045677.746 [CBIT](IMPORTANT): Beginning ground fault scan
2021-03-29T19:21:18.217Z,1617045678.217 [DockingServo](INFO): Paused
2021-03-29T19:21:18.597Z,1617045678.597 [DockingServo](INFO): Paused
2021-03-29T19:21:18.989Z,1617045678.989 [DockingServo](INFO): Paused
2021-03-29T19:21:19.381Z,1617045679.381 [DockingServo](INFO): Paused
2021-03-29T19:21:19.814Z,1617045679.814 [DockingServo](INFO): Paused
2021-03-29T19:21:20.205Z,1617045680.205 [DockingServo](INFO): Paused
2021-03-29T19:21:20.609Z,1617045680.609 [DockingServo](INFO): Paused
2021-03-29T19:21:21.049Z,1617045681.049 [DockingServo](INFO): Paused
2021-03-29T19:21:21.496Z,1617045681.496 [DockingServo](INFO): Paused
2021-03-29T19:21:21.812Z,1617045681.812 [DockingServo](INFO): Paused
2021-03-29T19:21:22.194Z,1617045682.194 [DockingServo](INFO): Paused
2021-03-29T19:21:22.589Z,1617045682.589 [DockingServo](INFO): Paused
2021-03-29T19:21:22.986Z,1617045682.986 [NAL9602](INFO): Powering up NAL9602
2021-03-29T19:21:22.998Z,1617045682.998 [DockingServo](INFO): Paused
2021-03-29T19:21:23.422Z,1617045683.422 [DockingServo](INFO): Paused
2021-03-29T19:21:23.801Z,1617045683.801 [DockingServo](INFO): Paused
2021-03-29T19:21:24.205Z,1617045684.205 [DockingServo](INFO): Paused
2021-03-29T19:21:24.614Z,1617045684.614 [DockingServo](INFO): Paused
2021-03-29T19:21:25.031Z,1617045685.031 [DockingServo](INFO): Paused
2021-03-29T19:21:25.426Z,1617045685.426 [DockingServo](INFO): Paused
2021-03-29T19:21:25.830Z,1617045685.830 [DockingServo](INFO): Paused
2021-03-29T19:21:26.234Z,1617045686.234 [DockingServo](INFO): Paused
2021-03-29T19:21:26.658Z,1617045686.658 [DockingServo](INFO): Paused
2021-03-29T19:21:27.042Z,1617045687.042 [DockingServo](INFO): Paused
2021-03-29T19:21:27.446Z,1617045687.446 [DockingServo](INFO): Paused
2021-03-29T19:21:27.854Z,1617045687.854 [DockingServo](INFO): Paused
2021-03-29T19:21:28.266Z,1617045688.266 [DockingServo](INFO): Paused
2021-03-29T19:21:28.654Z,1617045688.654 [DockingServo](INFO): Paused
2021-03-29T19:21:28.704Z,1617045688.704 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.026928
CHAN A1 (24V): 0.004800
CHAN A2 (12V): -0.005499
CHAN A3 (5V): -0.002634
CHAN B0 (3.3V): -0.000786
CHAN B1 (3.15aV): -0.001400
CHAN B2 (3.15bV): -0.001016
CHAN B3 (GND): -0.000683
OPEN: -0.001389
Full Scale Calc: 4.765 mA, -1.589 mA
2021-03-29T19:21:29.054Z,1617045689.054 [DockingServo](INFO): Paused
2021-03-29T19:21:29.474Z,1617045689.474 [DockingServo](INFO): Paused
2021-03-29T19:21:29.866Z,1617045689.866 [DockingServo](INFO): Paused
2021-03-29T19:21:30.275Z,1617045690.275 [DockingServo](INFO): Paused
2021-03-29T19:21:30.670Z,1617045690.670 [DockingServo](INFO): Paused
2021-03-29T19:21:31.096Z,1617045691.096 [DockingServo](INFO): Paused
2021-03-29T19:21:31.097Z,1617045691.097 [SBIT](ERROR): Could not read massPosReader_.
2021-03-29T19:21:31.510Z,1617045691.510 [DockingServo](INFO): Paused
2021-03-29T19:21:31.894Z,1617045691.894 [DockingServo](INFO): Paused
2021-03-29T19:21:32.333Z,1617045692.333 [DockingServo](INFO): Paused
2021-03-29T19:21:32.718Z,1617045692.718 [DockingServo](INFO): Paused
2021-03-29T19:21:33.185Z,1617045693.185 [DockingServo](INFO): Paused
2021-03-29T19:21:33.557Z,1617045693.557 [DockingServo](INFO): Paused
2021-03-29T19:21:33.889Z,1617045693.889 [NAL9602](INFO): NAL9602 initialized
2021-03-29T19:21:33.933Z,1617045693.933 [DockingServo](INFO): Paused
2021-03-29T19:21:34.341Z,1617045694.341 [DockingServo](INFO): Paused
2021-03-29T19:21:34.772Z,1617045694.772 [DockingServo](INFO): Paused
2021-03-29T19:21:35.173Z,1617045695.173 [DockingServo](INFO): Paused
2021-03-29T19:21:35.561Z,1617045695.561 [DockingServo](INFO): Paused
2021-03-29T19:21:35.969Z,1617045695.969 [DockingServo](INFO): Paused
2021-03-29T19:21:36.389Z,1617045696.389 [DockingServo](INFO): Paused
2021-03-29T19:21:36.769Z,1617045696.769 [DockingServo](INFO): Paused
2021-03-29T19:21:37.177Z,1617045697.177 [DockingServo](INFO): Paused
2021-03-29T19:21:37.592Z,1617045697.592 [DockingServo](INFO): Paused
2021-03-29T19:21:37.989Z,1617045697.989 [DockingServo](INFO): Paused
2021-03-29T19:21:38.413Z,1617045698.413 [DockingServo](INFO): Paused
2021-03-29T19:21:38.864Z,1617045698.864 [DockingServo](INFO): Paused
2021-03-29T19:21:39.161Z,1617045699.161 [DockingServo](INFO): Paused
2021-03-29T19:21:39.584Z,1617045699.584 [DockingServo](INFO): Paused
2021-03-29T19:21:39.962Z,1617045699.962 [DockingServo](INFO): Paused
2021-03-29T19:21:40.374Z,1617045700.374 [DockingServo](INFO): Paused
2021-03-29T19:21:40.786Z,1617045700.786 [DockingServo](INFO): Paused
2021-03-29T19:21:41.197Z,1617045701.197 [DockingServo](INFO): Paused
2021-03-29T19:21:41.578Z,1617045701.578 [DockingServo](INFO): Paused
2021-03-29T19:21:41.998Z,1617045701.998 [DockingServo](INFO): Paused
2021-03-29T19:21:42.410Z,1617045702.410 [DockingServo](INFO): Paused
2021-03-29T19:21:42.811Z,1617045702.811 [DockingServo](INFO): Paused
2021-03-29T19:21:43.224Z,1617045703.224 [DockingServo](INFO): Paused
2021-03-29T19:21:43.601Z,1617045703.601 [DockingServo](INFO): Paused
2021-03-29T19:21:44.011Z,1617045704.011 [DockingServo](INFO): Paused
2021-03-29T19:21:44.425Z,1617045704.425 [DockingServo](INFO): Paused
2021-03-29T19:21:44.814Z,1617045704.814 [DockingServo](INFO): Paused
2021-03-29T19:21:45.217Z,1617045705.217 [DockingServo](INFO): Paused
2021-03-29T19:21:45.630Z,1617045705.630 [DockingServo](INFO): Paused
2021-03-29T19:21:46.041Z,1617045706.041 [DockingServo](INFO): Paused
2021-03-29T19:21:46.429Z,1617045706.429 [DockingServo](INFO): Paused
2021-03-29T19:21:46.834Z,1617045706.834 [DockingServo](INFO): Paused
2021-03-29T19:21:47.258Z,1617045707.258 [DockingServo](INFO): Paused
2021-03-29T19:21:47.658Z,1617045707.658 [DockingServo](INFO): Paused
2021-03-29T19:21:48.074Z,1617045708.074 [DockingServo](INFO): Paused
2021-03-29T19:21:48.463Z,1617045708.463 [DockingServo](INFO): Paused
2021-03-29T19:21:48.858Z,1617045708.858 [DockingServo](INFO): Paused
2021-03-29T19:21:49.271Z,1617045709.271 [DockingServo](INFO): Paused
2021-03-29T19:21:49.656Z,1617045709.656 [DockingServo](INFO): Paused
2021-03-29T19:21:50.059Z,1617045710.059 [DockingServo](INFO): Paused
2021-03-29T19:21:50.483Z,1617045710.483 [DockingServo](INFO): Paused
2021-03-29T19:21:50.887Z,1617045710.887 [DockingServo](INFO): Paused
2021-03-29T19:21:51.271Z,1617045711.271 [DockingServo](INFO): Paused
2021-03-29T19:21:51.682Z,1617045711.682 [DockingServo](INFO): Paused
2021-03-29T19:21:52.091Z,1617045712.091 [DockingServo](INFO): Paused
2021-03-29T19:21:52.507Z,1617045712.507 [DockingServo](INFO): Paused
2021-03-29T19:21:52.921Z,1617045712.921 [DockingServo](INFO): Paused
2021-03-29T19:21:53.311Z,1617045713.311 [DockingServo](INFO): Paused
2021-03-29T19:21:53.718Z,1617045713.718 [DockingServo](INFO): Paused
2021-03-29T19:21:54.132Z,1617045714.132 [DockingServo](INFO): Paused
2021-03-29T19:21:54.535Z,1617045714.535 [DockingServo](INFO): Paused
2021-03-29T19:21:54.928Z,1617045714.928 [DockingServo](INFO): Paused
2021-03-29T19:21:55.327Z,1617045715.327 [DockingServo](INFO): Paused
2021-03-29T19:21:55.738Z,1617045715.738 [DockingServo](INFO): Paused
2021-03-29T19:21:56.127Z,1617045716.127 [DockingServo](INFO): Paused
2021-03-29T19:21:56.534Z,1617045716.534 [DockingServo](INFO): Paused
2021-03-29T19:21:56.942Z,1617045716.942 [DockingServo](INFO): Paused
2021-03-29T19:21:57.351Z,1617045717.351 [DockingServo](INFO): Paused
2021-03-29T19:21:57.774Z,1617045717.774 [DockingServo](INFO): Paused
2021-03-29T19:21:57.776Z,1617045717.776 [SBIT](ERROR): Could not read massPosReader_.
2021-03-29T19:21:57.776Z,1617045717.776 [SBIT](FAULT): Control surface position failure.
2021-03-29T19:21:58.188Z,1617045718.188 [DockingServo](INFO): Paused
2021-03-29T19:21:58.567Z,1617045718.567 [DockingServo](INFO): Paused
2021-03-29T19:21:58.972Z,1617045718.972 [DockingServo](INFO): Paused
2021-03-29T19:21:59.358Z,1617045719.358 [DockingServo](INFO): Paused
2021-03-29T19:21:59.829Z,1617045719.829 [DockingServo](INFO): Paused
2021-03-29T19:22:00.220Z,1617045720.220 [DockingServo](INFO): Paused
2021-03-29T19:22:00.657Z,1617045720.657 [DockingServo](INFO): Paused
2021-03-29T19:22:01.041Z,1617045721.041 [DockingServo](INFO): Paused
2021-03-29T19:22:01.441Z,1617045721.441 [DockingServo](INFO): Paused
2021-03-29T19:22:01.825Z,1617045721.825 [DockingServo](INFO): Paused
2021-03-29T19:22:02.229Z,1617045722.229 [DockingServo](INFO): Paused
2021-03-29T19:22:02.673Z,1617045722.673 [DockingServo](INFO): Paused
2021-03-29T19:22:03.148Z,1617045723.148 [DockingServo](INFO): Paused
2021-03-29T19:22:03.406Z,1617045723.406 [DockingServo](INFO): Paused
2021-03-29T19:22:03.819Z,1617045723.819 [DockingServo](INFO): Paused
2021-03-29T19:22:04.233Z,1617045724.233 [DockingServo](INFO): Paused
2021-03-29T19:22:04.607Z,1617045724.607 [DockingServo](INFO): Paused
2021-03-29T19:22:05.018Z,1617045725.018 [DockingServo](INFO): Paused
2021-03-29T19:22:05.435Z,1617045725.435 [DockingServo](INFO): Paused
2021-03-29T19:22:05.823Z,1617045725.823 [DockingServo](INFO): Paused
2021-03-29T19:22:06.228Z,1617045726.228 [DockingServo](INFO): Paused
2021-03-29T19:22:06.634Z,1617045726.634 [DockingServo](INFO): Paused
2021-03-29T19:22:07.046Z,1617045727.046 [DockingServo](INFO): Paused
2021-03-29T19:22:07.436Z,1617045727.436 [DockingServo](INFO): Paused
2021-03-29T19:22:07.842Z,1617045727.842 [DockingServo](INFO): Paused
2021-03-29T19:22:08.262Z,1617045728.262 [DockingServo](INFO): Paused
2021-03-29T19:22:08.674Z,1617045728.674 [DockingServo](INFO): Paused
2021-03-29T19:22:09.084Z,1617045729.084 [DockingServo](INFO): Paused
2021-03-29T19:22:09.470Z,1617045729.470 [DockingServo](INFO): Paused
2021-03-29T19:22:09.874Z,1617045729.874 [DockingServo](INFO): Paused
2021-03-29T19:22:10.283Z,1617045730.283 [DockingServo](INFO): Paused
2021-03-29T19:22:10.671Z,1617045730.671 [DockingServo](INFO): Paused
2021-03-29T19:22:11.078Z,1617045731.078 [DockingServo](INFO): Paused
2021-03-29T19:22:11.482Z,1617045731.482 [DockingServo](INFO): Paused
2021-03-29T19:22:11.483Z,1617045731.483 [SBIT](ERROR): Could not read massPosReader_.
2021-03-29T19:22:11.484Z,1617045731.484 [SBIT](FAULT): Control surface position failure.
2021-03-29T19:22:11.902Z,1617045731.902 [DockingServo](INFO): Paused
2021-03-29T19:22:11.903Z,1617045731.903 [SBIT](CRITICAL): SBIT FAILED
2021-03-29T19:22:11.903Z,1617045731.903 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-03-29T19:22:11.904Z,1617045731.904 [SBIT](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;
2021-03-29T19:22:11.904Z,1617045731.904 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;
2021-03-29T19:22:11.904Z,1617045731.904 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2021-03-29T19:22:11.904Z,1617045731.904 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;
2021-03-29T19:22:11.904Z,1617045731.904 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=235 cubic_centimeter;
2021-03-29T19:22:11.905Z,1617045731.905 [SBIT](IMPORTANT): VerticalControl.massDefault=-1 millimeter;
2021-03-29T19:22:11.905Z,1617045731.905 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;
2021-03-29T19:22:11.905Z,1617045731.905 [SBIT](IMPORTANT): DockingServo.loadAtStartup=1 bool;
2021-03-29T19:22:11.905Z,1617045731.905 [SBIT](IMPORTANT): DockingServo.simulateHardware=0 bool;
2021-03-29T19:22:11.905Z,1617045731.905 [SBIT](IMPORTANT): MassServo.loadAtStartup=0 bool;
2021-03-29T19:22:11.907Z,1617045731.907 [CommandLine](FAULT): Scheduling is paused
2021-03-29T19:22:11.907Z,1617045731.907 [CBIT](INFO): Critical error at 20210329T192211
2021-03-29T19:22:11.907Z,1617045731.907 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-03-29T19:22:12.290Z,1617045732.290 [MissionManager](IMPORTANT): Started mission Startup
2021-03-29T19:22:12.290Z,1617045732.290 [Startup] Running Loop=1
2021-03-29T19:22:12.290Z,1617045732.290 [Startup](DEBUG): Aggregate::initialize Startup
2021-03-29T19:22:12.290Z,1617045732.290 [Startup:A.GoToSurface] Running Loop=1
2021-03-29T19:22:12.290Z,1617045732.290 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-03-29T19:22:12.291Z,1617045732.291 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-03-29T19:22:12.291Z,1617045732.291 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-03-29T19:22:12.292Z,1617045732.292 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-03-29T19:22:12.292Z,1617045732.292 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-03-29T19:22:12.293Z,1617045732.293 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-03-29T19:22:12.294Z,1617045732.294 [Startup:StartupSatComms] Running Loop=1
2021-03-29T19:22:12.294Z,1617045732.294 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-03-29T19:22:12.294Z,1617045732.294 [Startup:StartupSatComms:A] Running Loop=1
2021-03-29T19:22:12.299Z,1617045732.299 [DockingServo](INFO): Paused
2021-03-29T19:22:12.694Z,1617045732.694 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-03-29T19:22:12.699Z,1617045732.699 [DockingServo](INFO): Paused
2021-03-29T19:22:13.114Z,1617045733.114 [DockingServo](INFO): Paused
2021-03-29T19:22:13.575Z,1617045733.575 [DockingServo](INFO): Paused
2021-03-29T19:22:13.959Z,1617045733.959 [DockingServo](INFO): Paused
2021-03-29T19:22:14.407Z,1617045734.407 [DockingServo](INFO): Paused
2021-03-29T19:22:14.770Z,1617045734.770 [DockingServo](INFO): Paused
2021-03-29T19:22:15.049Z,1617045735.049 [CommandLine](IMPORTANT): got command quit
2021-03-29T19:22:15.142Z,1617045735.142 [DockingServo](INFO): Paused
2021-03-29T19:22:15.533Z,1617045735.533 [DockingServo](INFO): Paused
2021-03-29T19:22:15.927Z,1617045735.927 [DockingServo](INFO): Paused
2021-03-29T19:22:16.052Z,1617045736.052 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:16.052Z,1617045736.052 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.088Z,1617045736.088 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2021-03-29T19:22:16.088Z,1617045736.088 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.089Z,1617045736.089 [CommandLine](INFO): Join timeout helper Thread ID is 9723
2021-03-29T19:22:16.089Z,1617045736.089 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-03-29T19:22:16.089Z,1617045736.089 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.090Z,1617045736.090 [NavChartDb](INFO): Join timeout helper Thread ID is 9724
2021-03-29T19:22:16.252Z,1617045736.252 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:16.252Z,1617045736.252 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.268Z,1617045736.268 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-03-29T19:22:16.268Z,1617045736.268 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.268Z,1617045736.268 [Radio_Surface](INFO): Join timeout helper Thread ID is 9725
2021-03-29T19:22:16.340Z,1617045736.340 [Radio_Surface](INFO): Powering down
2021-03-29T19:22:16.341Z,1617045736.341 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:16.341Z,1617045736.341 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.345Z,1617045736.345 [DockingServo](INFO): Paused
2021-03-29T19:22:16.356Z,1617045736.356 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-03-29T19:22:16.356Z,1617045736.356 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:16.356Z,1617045736.356 [Onboard](INFO): Join timeout helper Thread ID is 9726
2021-03-29T19:22:16.738Z,1617045736.738 [DockingServo](INFO): Paused
2021-03-29T19:22:17.133Z,1617045737.133 [DockingServo](INFO): Paused
2021-03-29T19:22:17.546Z,1617045737.546 [DockingServo](INFO): Paused
2021-03-29T19:22:17.961Z,1617045737.961 [DockingServo](INFO): Paused
2021-03-29T19:22:18.144Z,1617045738.144 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:18.144Z,1617045738.144 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.152Z,1617045738.152 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-03-29T19:22:18.152Z,1617045738.152 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.152Z,1617045738.152 [DataOverHttps](INFO): Join timeout helper Thread ID is 9727
2021-03-29T19:22:18.341Z,1617045738.341 [DockingServo](INFO): Paused
2021-03-29T19:22:18.416Z,1617045738.416 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:18.416Z,1617045738.416 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.433Z,1617045738.433 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-03-29T19:22:18.433Z,1617045738.433 [logger ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.433Z,1617045738.433 [logger](INFO): Join timeout helper Thread ID is 9728
2021-03-29T19:22:18.460Z,1617045738.460 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:18.460Z,1617045738.460 [logger ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.473Z,1617045738.473 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-03-29T19:22:18.473Z,1617045738.473 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.473Z,1617045738.473 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-03-29T19:22:18.473Z,1617045738.473 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.473Z,1617045738.473 [controlThread](INFO): Join timeout helper Thread ID is 9729
2021-03-29T19:22:18.724Z,1617045738.724 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-03-29T19:22:18.724Z,1617045738.724 [controlThread](DEBUG): Uninitializing ControlThread
2021-03-29T19:22:18.725Z,1617045738.725 [AHRS_M2](INFO): Powering down
2021-03-29T19:22:18.797Z,1617045738.797 [NAL9602](INFO): Powering down
2021-03-29T19:22:18.798Z,1617045738.798 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-03-29T19:22:18.799Z,1617045738.799 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-03-29T19:22:18.800Z,1617045738.800 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-03-29T19:22:18.801Z,1617045738.801 [MissionManager](INFO): Uninitializing Mission Default
2021-03-29T19:22:18.803Z,1617045738.803 [MissionManager](INFO): Uninitializing Mission Startup
2021-03-29T19:22:18.803Z,1617045738.803 [Startup] Stopped
2021-03-29T19:22:18.803Z,1617045738.803 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-03-29T19:22:18.804Z,1617045738.804 [Startup:A.GoToSurface] Stopped
2021-03-29T19:22:18.804Z,1617045738.804 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-03-29T19:22:18.804Z,1617045738.804 [Startup:StartupSatComms] Stopped
2021-03-29T19:22:18.804Z,1617045738.804 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-03-29T19:22:18.804Z,1617045738.804 [Startup:StartupSatComms:A] Stopped
2021-03-29T19:22:18.806Z,1617045738.806 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-03-29T19:22:18.806Z,1617045738.806 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-03-29T19:22:18.806Z,1617045738.806 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-03-29T19:22:18.806Z,1617045738.806 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-03-29T19:22:18.807Z,1617045738.807 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-03-29T19:22:18.807Z,1617045738.807 [BuoyancyServo](INFO): Powering down
2021-03-29T19:22:18.820Z,1617045738.820 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-03-29T19:22:18.820Z,1617045738.820 [ElevatorServo](INFO): Powering down
2021-03-29T19:22:18.821Z,1617045738.821 [DockingServo](DEBUG): Uninitialize Docking Servo.
2021-03-29T19:22:18.821Z,1617045738.821 [DockingServo](INFO): Powering down
2021-03-29T19:22:18.822Z,1617045738.822 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-03-29T19:22:18.822Z,1617045738.822 [RudderServo](INFO): Powering down
2021-03-29T19:22:18.823Z,1617045738.823 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-03-29T19:22:18.823Z,1617045738.823 [ThrusterServo](INFO): Powering down
2021-03-29T19:22:18.824Z,1617045738.824 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-03-29T19:22:18.824Z,1617045738.824 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-03-29T19:22:18.824Z,1617045738.824 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-03-29T19:22:18.824Z,1617045738.824 [CBIT](DEBUG): Powering off loads.
2021-03-29T19:22:18.836Z,1617045738.836 [CBIT](DEBUG): Disabling WDT.
2021-03-29T19:22:18.848Z,1617045738.848 [CBIT](DEBUG): Opening all GF detection circuits.
2021-03-29T19:22:18.849Z,1617045738.849 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.911Z,1617045738.911 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.914Z,1617045738.914 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.919Z,1617045738.919 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:18.997Z,1617045738.997 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-03-29T19:22:19.055Z,1617045739.055 [logger ThreadHandler](INFO): Thread cancelled.