2019-04-22T23:52:55.540Z,1555977175.540 [Supervisor](DEBUG): Initializing supervisor.
2019-04-22T23:52:55.543Z,1555977175.543 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-22T23:52:55.544Z,1555977175.544 [SyncHandler](INFO): Protected caller Thread ID is 810
2019-04-22T23:52:55.544Z,1555977175.544 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-04-22T23:52:55.545Z,1555977175.545 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-04-22T23:52:55.545Z,1555977175.545 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 811
2019-04-22T23:52:55.548Z,1555977175.548 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-04-22T23:52:55.560Z,1555977175.560 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-04-22T23:52:55.561Z,1555977175.561 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-04-22T23:52:55.561Z,1555977175.561 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 812
2019-04-22T23:52:55.562Z,1555977175.562 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-04-22T23:52:55.563Z,1555977175.563 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-04-22T23:52:55.563Z,1555977175.563 [logger ThreadHandler](INFO): Protected caller Thread ID is 813
2019-04-22T23:52:55.565Z,1555977175.565 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-04-22T23:52:55.566Z,1555977175.566 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-04-22T23:52:55.570Z,1555977175.570 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-04-22T23:52:56.003Z,1555977176.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-04-22T23:52:56.005Z,1555977176.005 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-04-22T23:52:56.151Z,1555977176.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-04-22T23:52:56.152Z,1555977176.152 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-04-22T23:52:56.232Z,1555977176.232 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-04-22T23:52:56.332Z,1555977176.332 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-04-22T23:52:56.332Z,1555977176.332 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-04-22T23:52:56.428Z,1555977176.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-04-22T23:52:56.430Z,1555977176.430 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-04-22T23:52:56.822Z,1555977176.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-04-22T23:52:56.823Z,1555977176.823 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-04-22T23:52:56.927Z,1555977176.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-04-22T23:52:56.928Z,1555977176.928 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-04-22T23:52:57.525Z,1555977177.525 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-04-22T23:52:57.526Z,1555977177.526 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-04-22T23:52:57.733Z,1555977177.733 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-04-22T23:52:57.734Z,1555977177.734 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-04-22T23:52:58.045Z,1555977178.045 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-04-22T23:52:58.045Z,1555977178.045 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-04-22T23:52:58.262Z,1555977178.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-04-22T23:52:58.263Z,1555977178.263 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-04-22T23:52:58.407Z,1555977178.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-04-22T23:52:58.408Z,1555977178.408 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-04-22T23:52:58.953Z,1555977178.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-04-22T23:52:59.195Z,1555977179.195 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-04-22T23:52:59.723Z,1555977179.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-04-22T23:52:59.723Z,1555977179.723 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-04-22T23:52:59.933Z,1555977179.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-04-22T23:52:59.935Z,1555977179.935 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2019-04-22T23:52:59.938Z,1555977179.938 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2019-04-22T23:53:00.121Z,1555977180.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2019-04-22T23:53:00.206Z,1555977180.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2019-04-22T23:53:00.323Z,1555977180.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2019-04-22T23:53:00.409Z,1555977180.409 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2019-04-22T23:53:00.637Z,1555977180.637 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-04-22T23:53:00.638Z,1555977180.638 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2019-04-22T23:53:00.734Z,1555977180.734 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2019-04-22T23:53:00.847Z,1555977180.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2019-04-22T23:53:00.942Z,1555977180.942 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2019-04-22T23:53:01.094Z,1555977181.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2019-04-22T23:53:01.195Z,1555977181.195 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2019-04-22T23:53:01.295Z,1555977181.295 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2019-04-22T23:53:01.299Z,1555977181.299 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-04-22T23:53:01.323Z,1555977181.323 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-04-22T23:53:01.325Z,1555977181.325 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-04-22T23:53:01.411Z,1555977181.411 [VerticalControl](DEBUG): Construct VerticalControl.
2019-04-22T23:53:01.528Z,1555977181.528 [VerticalControl] Loaded
2019-04-22T23:53:01.528Z,1555977181.528 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-04-22T23:53:01.529Z,1555977181.529 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-04-22T23:53:01.600Z,1555977181.600 [HorizontalControl] Loaded
2019-04-22T23:53:01.600Z,1555977181.600 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-04-22T23:53:01.601Z,1555977181.601 [SpeedControl](DEBUG): Construct SpeedControl.
2019-04-22T23:53:01.606Z,1555977181.606 [SpeedControl] Loaded
2019-04-22T23:53:01.606Z,1555977181.606 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-04-22T23:53:01.607Z,1555977181.607 [LoopControl](DEBUG): Construct LoopControl.
2019-04-22T23:53:01.608Z,1555977181.608 [LoopControl] Loaded
2019-04-22T23:53:01.608Z,1555977181.608 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-04-22T23:53:01.608Z,1555977181.608 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-04-22T23:53:01.609Z,1555977181.609 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-04-22T23:53:01.751Z,1555977181.751 [BuoyancyServo] Loaded
2019-04-22T23:53:01.752Z,1555977181.752 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-04-22T23:53:01.763Z,1555977181.763 [ElevatorServo] Loaded
2019-04-22T23:53:01.763Z,1555977181.763 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-04-22T23:53:01.774Z,1555977181.774 [MassServo] Loaded
2019-04-22T23:53:01.775Z,1555977181.775 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-04-22T23:53:01.786Z,1555977181.786 [RudderServo] Loaded
2019-04-22T23:53:01.786Z,1555977181.786 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-04-22T23:53:01.797Z,1555977181.797 [ThrusterServo] Loaded
2019-04-22T23:53:01.797Z,1555977181.797 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-04-22T23:53:01.798Z,1555977181.798 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-04-22T23:53:01.798Z,1555977181.798 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-04-22T23:53:01.853Z,1555977181.853 [DepthRateCalculator] Loaded
2019-04-22T23:53:01.853Z,1555977181.853 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-04-22T23:53:01.858Z,1555977181.858 [PitchRateCalculator] Loaded
2019-04-22T23:53:01.858Z,1555977181.858 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-04-22T23:53:01.874Z,1555977181.874 [SpeedCalculator] Loaded
2019-04-22T23:53:01.874Z,1555977181.874 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-04-22T23:53:01.895Z,1555977181.895 [TempGradientCalculator] Loaded
2019-04-22T23:53:01.896Z,1555977181.896 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-04-22T23:53:01.901Z,1555977181.901 [YawRateCalculator] Loaded
2019-04-22T23:53:01.901Z,1555977181.901 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-04-22T23:53:01.931Z,1555977181.931 [ElevatorOffsetCalculator] Loaded
2019-04-22T23:53:01.931Z,1555977181.931 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-04-22T23:53:01.931Z,1555977181.931 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-04-22T23:53:01.932Z,1555977181.932 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-04-22T23:53:02.054Z,1555977182.054 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-04-22T23:53:02.054Z,1555977182.054 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-04-22T23:53:02.075Z,1555977182.075 [NavChart] Loaded
2019-04-22T23:53:02.075Z,1555977182.075 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-04-22T23:53:02.079Z,1555977182.079 [UniversalFixResidualReporter] Loaded
2019-04-22T23:53:02.080Z,1555977182.080 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-04-22T23:53:02.080Z,1555977182.080 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-04-22T23:53:02.081Z,1555977182.081 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-04-22T23:53:02.654Z,1555977182.654 [AHRS_M2] Loaded
2019-04-22T23:53:02.654Z,1555977182.654 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-04-22T23:53:02.799Z,1555977182.799 [DataOverHttps] Loaded
2019-04-22T23:53:02.800Z,1555977182.800 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-04-22T23:53:02.801Z,1555977182.801 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408044E0
2019-04-22T23:53:02.801Z,1555977182.801 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 893
2019-04-22T23:53:02.815Z,1555977182.815 [Depth_Keller] Loaded
2019-04-22T23:53:02.815Z,1555977182.815 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-04-22T23:53:02.820Z,1555977182.820 [DropWeight] Loaded
2019-04-22T23:53:02.820Z,1555977182.820 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-04-22T23:53:02.918Z,1555977182.918 [NAL9602] Loaded
2019-04-22T23:53:02.918Z,1555977182.918 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-04-22T23:53:02.934Z,1555977182.934 [Onboard] Loaded
2019-04-22T23:53:02.934Z,1555977182.934 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-04-22T23:53:02.938Z,1555977182.938 [Radio_Surface] Loaded
2019-04-22T23:53:02.938Z,1555977182.938 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-04-22T23:53:02.939Z,1555977182.939 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408344E0
2019-04-22T23:53:02.939Z,1555977182.939 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 894
2019-04-22T23:53:04.431Z,1555977184.431 [BPC1] Loaded
2019-04-22T23:53:04.432Z,1555977184.432 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-04-22T23:53:04.432Z,1555977184.432 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-04-22T23:53:04.433Z,1555977184.433 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-04-22T23:53:04.646Z,1555977184.646 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-04-22T23:53:04.646Z,1555977184.646 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-04-22T23:53:05.393Z,1555977185.393 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-04-22T23:53:05.394Z,1555977185.394 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-04-22T23:53:05.439Z,1555977185.439 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-04-22T23:53:05.439Z,1555977185.439 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-04-22T23:53:05.759Z,1555977185.759 [CTD_NeilBrown] Loaded
2019-04-22T23:53:05.759Z,1555977185.759 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-04-22T23:53:05.760Z,1555977185.760 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409C04E0
2019-04-22T23:53:05.760Z,1555977185.760 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 895
2019-04-22T23:53:05.770Z,1555977185.770 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-04-22T23:53:05.775Z,1555977185.775 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-04-22T23:53:05.776Z,1555977185.776 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-04-22T23:53:05.781Z,1555977185.781 [CTD_Seabird](INFO): created writer for : depth
2019-04-22T23:53:05.782Z,1555977185.782 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-04-22T23:53:05.787Z,1555977185.787 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-04-22T23:53:05.787Z,1555977185.787 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-04-22T23:53:05.792Z,1555977185.792 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-04-22T23:53:05.793Z,1555977185.793 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-04-22T23:53:05.797Z,1555977185.797 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-04-22T23:53:05.798Z,1555977185.798 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-04-22T23:53:05.803Z,1555977185.803 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-04-22T23:53:05.804Z,1555977185.804 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-04-22T23:53:05.808Z,1555977185.808 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-04-22T23:53:05.836Z,1555977185.836 [CTD_Seabird] Loaded
2019-04-22T23:53:05.836Z,1555977185.836 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-04-22T23:53:05.837Z,1555977185.837 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409F04E0
2019-04-22T23:53:05.837Z,1555977185.837 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 896
2019-04-22T23:53:05.886Z,1555977185.886 [WetLabsBB2FL] Loaded
2019-04-22T23:53:05.886Z,1555977185.886 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-04-22T23:53:05.887Z,1555977185.887 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0
2019-04-22T23:53:05.888Z,1555977185.888 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 897
2019-04-22T23:53:05.888Z,1555977185.888 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-04-22T23:53:05.889Z,1555977185.889 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-04-22T23:53:06.204Z,1555977186.204 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-04-22T23:53:06.206Z,1555977186.206 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-04-22T23:53:06.365Z,1555977186.365 [SBIT](DEBUG): Construct Startup Built In Test.
2019-04-22T23:53:06.376Z,1555977186.376 [SBIT] Loaded
2019-04-22T23:53:06.377Z,1555977186.377 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-04-22T23:53:06.377Z,1555977186.377 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-04-22T23:53:06.389Z,1555977186.389 [IBIT] Loaded
2019-04-22T23:53:06.389Z,1555977186.389 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-04-22T23:53:06.392Z,1555977186.392 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-04-22T23:53:06.536Z,1555977186.536 [CBIT] Loaded
2019-04-22T23:53:06.536Z,1555977186.536 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-04-22T23:53:06.537Z,1555977186.537 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-04-22T23:53:06.540Z,1555977186.540 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-04-22T23:53:06.541Z,1555977186.541 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-04-22T23:53:06.548Z,1555977186.548 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-04-22T23:53:06.549Z,1555977186.549 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AF84E0
2019-04-22T23:53:06.549Z,1555977186.549 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 898
2019-04-22T23:53:06.554Z,1555977186.554 [Supervisor](INFO): Main Thread ID is 806
2019-04-22T23:53:06.554Z,1555977186.554 [Supervisor](DEBUG): Running supervisor.
2019-04-22T23:53:06.555Z,1555977186.555 [CommandLine ThreadHandler](INFO): Handler Thread ID is 899
2019-04-22T23:53:06.557Z,1555977186.557 [controlThread ThreadHandler](INFO): Handler Thread ID is 900
2019-04-22T23:53:06.557Z,1555977186.557 [controlThread](DEBUG): Initializing ControlThread
2019-04-22T23:53:06.558Z,1555977186.558 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-04-22T23:53:06.560Z,1555977186.560 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-04-22T23:53:06.560Z,1555977186.560 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-04-22T23:53:06.561Z,1555977186.561 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-04-22T23:53:06.562Z,1555977186.562 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-04-22T23:53:06.563Z,1555977186.563 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-04-22T23:53:06.563Z,1555977186.563 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-04-22T23:53:06.563Z,1555977186.563 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-04-22T23:53:06.564Z,1555977186.564 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-04-22T23:53:06.564Z,1555977186.564 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-04-22T23:53:06.565Z,1555977186.565 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-04-22T23:53:06.566Z,1555977186.566 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-04-22T23:53:06.571Z,1555977186.571 [SBIT](INFO): Initialize SBIT Component.
2019-04-22T23:53:06.572Z,1555977186.572 [SBIT](IMPORTANT): git: 2019-04-10-1-g18bae04
2019-04-22T23:53:06.572Z,1555977186.572 [SBIT](INFO): git hash: 18bae04951e434e73e54670b57def3d69c769fdd
2019-04-22T23:53:06.572Z,1555977186.572 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-04-22T23:53:06.573Z,1555977186.573 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #2 PREEMPT Mon Apr 22 16:23:42 PDT 2019
2019-04-22T23:53:06.574Z,1555977186.574 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-04-22T23:53:06.575Z,1555977186.575 [IBIT](INFO): Initialize IBIT Component.
2019-04-22T23:53:06.576Z,1555977186.576 [CBIT](DEBUG): Initialize CBIT Component.
2019-04-22T23:53:06.577Z,1555977186.577 [logger ThreadHandler](INFO): Handler Thread ID is 901
2019-04-22T23:53:06.589Z,1555977186.589 [CBIT](DEBUG): Initialized mux pins.
2019-04-22T23:53:06.589Z,1555977186.589 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2019-04-22T23:53:06.589Z,1555977186.589 [CBIT](DEBUG): Initializing the watchdog timer.
2019-04-22T23:53:06.594Z,1555977186.594 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 902
2019-04-22T23:53:06.595Z,1555977186.595 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-04-22T23:53:06.602Z,1555977186.602 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 903
2019-04-22T23:53:06.610Z,1555977186.610 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 904
2019-04-22T23:53:06.613Z,1555977186.613 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-04-22T23:53:06.613Z,1555977186.613 [CBIT](DEBUG): Initializing heartbeat.
2019-04-22T23:53:06.622Z,1555977186.622 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 905
2019-04-22T23:53:06.622Z,1555977186.622 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-22T23:53:06.626Z,1555977186.626 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-22T23:53:06.627Z,1555977186.627 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 907
2019-04-22T23:53:06.628Z,1555977186.628 [WetLabsBB2FL](INFO): Powering down
2019-04-22T23:53:06.665Z,1555977186.665 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 908
2019-04-22T23:53:06.674Z,1555977186.674 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-04-22T23:53:06.674Z,1555977186.674 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-04-22T23:53:06.675Z,1555977186.675 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-04-22T23:53:06.676Z,1555977186.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-04-22T23:53:06.677Z,1555977186.677 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-04-22T23:53:06.677Z,1555977186.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-04-22T23:53:06.685Z,1555977186.685 [CBIT](DEBUG): Deactivating GF circuits.
2019-04-22T23:53:06.685Z,1555977186.685 [CBIT](DEBUG): Deactivating emergency mode.
2019-04-22T23:53:06.721Z,1555977186.721 [CBIT](DEBUG): Backplane powered.
2019-04-22T23:53:06.722Z,1555977186.722 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-04-22T23:53:06.755Z,1555977186.755 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-22T23:53:06.766Z,1555977186.766 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2019-04-22T23:53:06.767Z,1555977186.767 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-04-22T23:53:06.827Z,1555977186.827 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-04-22T23:53:06.829Z,1555977186.829 [Default:A.Wait](DEBUG): Construct Wait.
2019-04-22T23:53:06.846Z,1555977186.846 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-22T23:53:06.878Z,1555977186.878 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-04-22T23:53:06.881Z,1555977186.881 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-04-22T23:53:06.904Z,1555977186.904 [Default:E.Execute](DEBUG): Construct Execute.
2019-04-22T23:53:06.923Z,1555977186.923 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2019-04-22T23:53:06.927Z,1555977186.927 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-04-22T23:53:06.945Z,1555977186.945 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-04-22T23:53:07.005Z,1555977187.005 [Radio_Surface](INFO): Powering up
2019-04-22T23:53:07.175Z,1555977187.175 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:07.181Z,1555977187.181 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-04-22T23:53:07.182Z,1555977187.182 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:07.189Z,1555977187.189 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-04-22T23:53:07.190Z,1555977187.190 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:07.197Z,1555977187.197 [MassServo](DEBUG): Initializing MassServo.
2019-04-22T23:53:07.198Z,1555977187.198 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:07.205Z,1555977187.205 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-22T23:53:07.206Z,1555977187.206 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:07.213Z,1555977187.213 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-04-22T23:53:07.466Z,1555977187.466 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-04-22T23:53:07.466Z,1555977187.466 [DropWeight] Hardware Fault, FailCount= 1
2019-04-22T23:53:07.466Z,1555977187.466 [DropWeight](ERROR): Hardware Fault
2019-04-22T23:53:07.552Z,1555977187.552 [CommandLine](FAULT): Scheduling is paused
2019-04-22T23:53:07.552Z,1555977187.552 [CBIT](INFO): Critical error at 20190422T235307
2019-04-22T23:53:07.553Z,1555977187.553 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-04-22T23:53:07.556Z,1555977187.556 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-04-22T23:53:07.556Z,1555977187.556 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-04-22T23:53:08.077Z,1555977188.077 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-04-22T23:53:08.077Z,1555977188.077 [RudderServo](FAULT): Rudder failed to initialize
2019-04-22T23:53:08.077Z,1555977188.077 [RudderServo] Communications Fault, FailCount= 1
2019-04-22T23:53:08.078Z,1555977188.078 [RudderServo](ERROR): Communications Fault
2019-04-22T23:53:08.222Z,1555977188.222 [CBIT](INFO): Critical error at 20190422T235307
2019-04-22T23:53:08.225Z,1555977188.225 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-04-22T23:53:08.386Z,1555977188.386 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-22T23:53:08.386Z,1555977188.386 [RudderServo](INFO): Powering down
2019-04-22T23:53:09.081Z,1555977189.081 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-22T23:53:09.202Z,1555977189.202 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-22T23:53:09.206Z,1555977189.206 [CBIT](INFO): Clearing failed state for component RudderServo
2019-04-22T23:53:09.206Z,1555977189.206 [RudderServo] No Fault, FailCount= 1
2019-04-22T23:53:10.565Z,1555977190.565 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:10.977Z,1555977190.977 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:11.441Z,1555977191.441 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:12.037Z,1555977192.037 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:12.457Z,1555977192.457 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:12.909Z,1555977192.909 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:13.325Z,1555977193.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:13.961Z,1555977193.961 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:14.397Z,1555977194.397 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:14.817Z,1555977194.817 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:15.293Z,1555977195.293 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:15.737Z,1555977195.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:16.209Z,1555977196.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:16.721Z,1555977196.721 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:16.778Z,1555977196.778 [CBIT](CRITICAL): Environmental Failure. Press:14.845333 PSI. Humidity:43%. Temp:24 C. ABORTING MISSION
2019-04-22T23:53:17.121Z,1555977197.121 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:17.176Z,1555977197.176 [CBIT](INFO): Critical error at 20190422T235316
2019-04-22T23:53:17.517Z,1555977197.517 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:17.929Z,1555977197.929 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:18.139Z,1555977198.139 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004507
2019-04-22T23:53:18.393Z,1555977198.393 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:18.785Z,1555977198.785 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:19.233Z,1555977199.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:19.633Z,1555977199.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:19.681Z,1555977199.681 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:19.681Z,1555977199.681 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-22T23:53:19.681Z,1555977199.681 [CTD_Seabird](ERROR): Communications Fault
2019-04-22T23:53:19.702Z,1555977199.702 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-22T23:53:20.033Z,1555977200.033 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:20.033Z,1555977200.033 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:20.033Z,1555977200.033 [AHRS_M2] Communications Fault, FailCount= 1
2019-04-22T23:53:20.033Z,1555977200.033 [AHRS_M2](ERROR): Communications Fault
2019-04-22T23:53:20.085Z,1555977200.085 [CTD_Seabird](INFO): Powering down
2019-04-22T23:53:20.150Z,1555977200.150 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-04-22T23:53:20.156Z,1555977200.156 [AHRS_M2](INFO): Powering down
2019-04-22T23:53:21.029Z,1555977201.029 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-04-22T23:53:21.030Z,1555977201.030 [AHRS_M2] No Fault, FailCount= 1
2019-04-22T23:53:21.366Z,1555977201.366 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-04-22T23:53:21.525Z,1555977201.525 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-22T23:53:21.526Z,1555977201.526 [CTD_Seabird] No Fault, FailCount= 1
2019-04-22T23:53:21.853Z,1555977201.853 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-22T23:53:21.855Z,1555977201.855 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-22T23:53:24.921Z,1555977204.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:25.325Z,1555977205.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:25.753Z,1555977205.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:26.137Z,1555977206.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:26.545Z,1555977206.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:26.957Z,1555977206.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:27.361Z,1555977207.361 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:27.765Z,1555977207.765 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:28.169Z,1555977208.169 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:28.573Z,1555977208.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:28.969Z,1555977208.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:29.369Z,1555977209.369 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:29.785Z,1555977209.785 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:30.189Z,1555977210.189 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:30.589Z,1555977210.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:30.985Z,1555977210.985 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:31.397Z,1555977211.397 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:31.801Z,1555977211.801 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:32.205Z,1555977212.205 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:32.609Z,1555977212.609 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:33.025Z,1555977213.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:33.030Z,1555977213.030 [NAL9602](INFO): Powering up NAL9602
2019-04-22T23:53:33.429Z,1555977213.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:33.821Z,1555977213.821 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:34.225Z,1555977214.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:34.225Z,1555977214.225 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:34.225Z,1555977214.225 [AHRS_M2] Communications Fault, FailCount= 2
2019-04-22T23:53:34.225Z,1555977214.225 [AHRS_M2](ERROR): Communications Fault
2019-04-22T23:53:34.285Z,1555977214.285 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-04-22T23:53:34.305Z,1555977214.305 [AHRS_M2](INFO): Powering down
2019-04-22T23:53:34.905Z,1555977214.905 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:34.905Z,1555977214.905 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-22T23:53:34.905Z,1555977214.905 [CTD_Seabird](ERROR): Communications Fault
2019-04-22T23:53:35.158Z,1555977215.158 [SBIT](IMPORTANT): Beginning Startup BIT
2019-04-22T23:53:35.162Z,1555977215.162 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-04-22T23:53:35.162Z,1555977215.162 [AHRS_M2] No Fault, FailCount= 2
2019-04-22T23:53:35.163Z,1555977215.163 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-22T23:53:35.163Z,1555977215.163 [CBIT](IMPORTANT): Beginning ground fault scan
2019-04-22T23:53:35.309Z,1555977215.309 [CTD_Seabird](INFO): Powering down
2019-04-22T23:53:35.517Z,1555977215.517 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-04-22T23:53:36.374Z,1555977216.374 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-22T23:53:36.374Z,1555977216.374 [CTD_Seabird] No Fault, FailCount= 2
2019-04-22T23:53:36.658Z,1555977216.658 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-22T23:53:36.659Z,1555977216.659 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-22T23:53:39.205Z,1555977219.205 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:39.729Z,1555977219.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:40.217Z,1555977220.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:40.833Z,1555977220.833 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:41.245Z,1555977221.245 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:41.645Z,1555977221.645 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:42.045Z,1555977222.045 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:42.545Z,1555977222.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:42.973Z,1555977222.973 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:43.385Z,1555977223.385 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:43.905Z,1555977223.905 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:44.321Z,1555977224.321 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:44.725Z,1555977224.725 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:45.241Z,1555977225.241 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:45.665Z,1555977225.665 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:46.081Z,1555977226.081 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:46.685Z,1555977226.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:46.754Z,1555977226.754 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.010299
CHAN A1 (24V): 0.001167
CHAN A2 (12V): -0.067789
CHAN A3 (5V): -0.003113
CHAN B0 (3.3V): -0.001163
CHAN B1 (3.15aV): -0.000764
CHAN B2 (3.15bV): -0.001309
CHAN B3 (GND): -0.000327
OPEN: -0.000991
Full Scale Calc: 4.765 mA, -1.589 mA
2019-04-22T23:53:47.085Z,1555977227.085 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:47.505Z,1555977227.505 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:47.913Z,1555977227.913 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:48.321Z,1555977228.321 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:48.737Z,1555977228.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:48.737Z,1555977228.737 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:48.737Z,1555977228.737 [AHRS_M2] Communications Fault, FailCount= 3
2019-04-22T23:53:48.737Z,1555977228.737 [AHRS_M2](ERROR): Communications Fault
2019-04-22T23:53:48.786Z,1555977228.786 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-04-22T23:53:48.854Z,1555977228.854 [AHRS_M2](INFO): Powering down
2019-04-22T23:53:49.638Z,1555977229.638 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-04-22T23:53:49.638Z,1555977229.638 [AHRS_M2] No Fault, FailCount= 3
2019-04-22T23:53:49.709Z,1555977229.709 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-22T23:53:49.709Z,1555977229.709 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-22T23:53:49.709Z,1555977229.709 [CTD_Seabird](ERROR): Communications Fault
2019-04-22T23:53:50.009Z,1555977230.009 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-04-22T23:53:50.113Z,1555977230.113 [CTD_Seabird](INFO): Powering down
2019-04-22T23:53:50.246Z,1555977230.246 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-22T23:53:50.246Z,1555977230.246 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-22T23:53:53.625Z,1555977233.625 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:54.145Z,1555977234.145 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:54.150Z,1555977234.150 [NAL9602](ERROR): NAL9602 initialization error.
2019-04-22T23:53:54.150Z,1555977234.150 [NAL9602] Communications Fault, FailCount= 1
2019-04-22T23:53:54.151Z,1555977234.151 [NAL9602](ERROR): Communications Fault
2019-04-22T23:53:54.274Z,1555977234.274 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-04-22T23:53:54.597Z,1555977234.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:54.602Z,1555977234.602 [NAL9602](INFO): Powering down
2019-04-22T23:53:55.125Z,1555977235.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:55.131Z,1555977235.131 [NAL9602](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-04-22T23:53:55.131Z,1555977235.131 [NAL9602] Hardware Fault, FailCount= 1
2019-04-22T23:53:55.131Z,1555977235.131 [NAL9602](ERROR): Hardware Fault
2019-04-22T23:53:55.701Z,1555977235.701 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:56.018Z,1555977236.018 [CBIT](INFO): Clearing failed state for component NAL9602
2019-04-22T23:53:56.018Z,1555977236.018 [NAL9602] No Fault, FailCount= 1
2019-04-22T23:53:56.341Z,1555977236.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:56.761Z,1555977236.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:57.185Z,1555977237.185 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:57.593Z,1555977237.593 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:58.013Z,1555977238.013 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:58.429Z,1555977238.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:58.849Z,1555977238.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:59.261Z,1555977239.261 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:53:59.673Z,1555977239.673 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:00.085Z,1555977240.085 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:00.497Z,1555977240.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:00.921Z,1555977240.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:01.333Z,1555977241.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:01.753Z,1555977241.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:02.173Z,1555977242.173 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:02.262Z,1555977242.262 [CommandLine](IMPORTANT): got command quit
2019-04-22T23:54:02.589Z,1555977242.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:02.993Z,1555977242.993 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-04-22T23:54:02.993Z,1555977242.993 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-04-22T23:54:02.993Z,1555977242.993 [AHRS_M2] Communications Fault, FailCount= 4
2019-04-22T23:54:02.993Z,1555977242.993 [AHRS_M2](ERROR): Communications Fault
2019-04-22T23:54:03.066Z,1555977243.066 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-04-22T23:54:03.098Z,1555977243.098 [AHRS_M2](INFO): Powering down
2019-04-22T23:54:03.265Z,1555977243.265 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:03.265Z,1555977243.265 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:03.409Z,1555977243.409 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-04-22T23:54:03.409Z,1555977243.409 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:03.410Z,1555977243.410 [CommandLine](INFO): Join timeout helper Thread ID is 929
2019-04-22T23:54:03.410Z,1555977243.410 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-04-22T23:54:03.410Z,1555977243.410 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:03.411Z,1555977243.411 [NavChartDb](INFO): Join timeout helper Thread ID is 930
2019-04-22T23:54:03.593Z,1555977243.593 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:03.593Z,1555977243.593 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:03.594Z,1555977243.594 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-04-22T23:54:03.594Z,1555977243.594 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:03.594Z,1555977243.594 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 931
2019-04-22T23:54:03.962Z,1555977243.962 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-04-22T23:54:03.962Z,1555977243.962 [AHRS_M2] No Fault, FailCount= 4
2019-04-22T23:54:04.089Z,1555977244.089 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:04.090Z,1555977244.090 [WetLabsBB2FL](INFO): Powering down
2019-04-22T23:54:04.090Z,1555977244.090 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.105Z,1555977244.105 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-04-22T23:54:04.105Z,1555977244.105 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.105Z,1555977244.105 [CTD_Seabird](INFO): Join timeout helper Thread ID is 932
2019-04-22T23:54:04.289Z,1555977244.289 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-04-22T23:54:04.389Z,1555977244.389 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:04.390Z,1555977244.390 [CTD_Seabird](INFO): Powering down
2019-04-22T23:54:04.401Z,1555977244.401 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.405Z,1555977244.405 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-04-22T23:54:04.405Z,1555977244.405 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.406Z,1555977244.406 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 934
2019-04-22T23:54:04.573Z,1555977244.573 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:04.573Z,1555977244.573 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.578Z,1555977244.578 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-04-22T23:54:04.578Z,1555977244.578 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.578Z,1555977244.578 [Radio_Surface](INFO): Join timeout helper Thread ID is 935
2019-04-22T23:54:04.793Z,1555977244.793 [Radio_Surface](INFO): Powering down
2019-04-22T23:54:04.813Z,1555977244.813 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:04.813Z,1555977244.813 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.826Z,1555977244.826 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-04-22T23:54:04.826Z,1555977244.826 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:04.826Z,1555977244.826 [DataOverHttps](INFO): Join timeout helper Thread ID is 936
2019-04-22T23:54:04.997Z,1555977244.997 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:04.998Z,1555977244.998 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.010Z,1555977245.010 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-04-22T23:54:05.010Z,1555977245.010 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.010Z,1555977245.010 [logger](INFO): Join timeout helper Thread ID is 937
2019-04-22T23:54:05.045Z,1555977245.045 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:05.045Z,1555977245.045 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.050Z,1555977245.050 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-04-22T23:54:05.050Z,1555977245.050 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.050Z,1555977245.050 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-04-22T23:54:05.050Z,1555977245.050 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.051Z,1555977245.051 [controlThread](INFO): Join timeout helper Thread ID is 938
2019-04-22T23:54:05.093Z,1555977245.093 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-22T23:54:05.093Z,1555977245.093 [controlThread](DEBUG): Uninitializing ControlThread
2019-04-22T23:54:05.094Z,1555977245.094 [AHRS_M2](INFO): Powering down
2019-04-22T23:54:05.166Z,1555977245.166 [NAL9602](INFO): Powering down
2019-04-22T23:54:05.168Z,1555977245.168 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-04-22T23:54:05.168Z,1555977245.168 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-04-22T23:54:05.169Z,1555977245.169 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-04-22T23:54:05.170Z,1555977245.170 [MissionManager](INFO): Uninitializing Mission Default
2019-04-22T23:54:05.172Z,1555977245.172 [MissionManager](INFO): Uninitializing Mission Startup
2019-04-22T23:54:05.173Z,1555977245.173 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-04-22T23:54:05.173Z,1555977245.173 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-04-22T23:54:05.173Z,1555977245.173 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-04-22T23:54:05.174Z,1555977245.174 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-04-22T23:54:05.174Z,1555977245.174 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-04-22T23:54:05.174Z,1555977245.174 [BuoyancyServo](INFO): Powering down
2019-04-22T23:54:05.185Z,1555977245.185 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-04-22T23:54:05.185Z,1555977245.185 [ElevatorServo](INFO): Powering down
2019-04-22T23:54:05.186Z,1555977245.186 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-22T23:54:05.186Z,1555977245.186 [MassServo](INFO): Powering down
2019-04-22T23:54:05.187Z,1555977245.187 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-22T23:54:05.187Z,1555977245.187 [RudderServo](INFO): Powering down
2019-04-22T23:54:05.188Z,1555977245.188 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-04-22T23:54:05.188Z,1555977245.188 [ThrusterServo](INFO): Powering down
2019-04-22T23:54:05.189Z,1555977245.189 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-04-22T23:54:05.189Z,1555977245.189 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-04-22T23:54:05.189Z,1555977245.189 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-04-22T23:54:05.190Z,1555977245.190 [CBIT](DEBUG): Powering off loads.
2019-04-22T23:54:05.201Z,1555977245.201 [CBIT](DEBUG): Disabling WDT.
2019-04-22T23:54:05.213Z,1555977245.213 [CBIT](DEBUG): Opening all GF detection circuits.
2019-04-22T23:54:05.214Z,1555977245.214 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.413Z,1555977245.413 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.419Z,1555977245.419 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.453Z,1555977245.453 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.455Z,1555977245.455 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.459Z,1555977245.459 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.489Z,1555977245.489 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-22T23:54:05.533Z,1555977245.533 [logger ThreadHandler](INFO): Thread cancelled.