2018-12-31T22:10:38.090Z,1546294238.090 [Supervisor](DEBUG): Initializing supervisor.
2018-12-31T22:10:38.093Z,1546294238.093 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-12-31T22:10:38.093Z,1546294238.093 [SyncHandler](INFO): Protected caller Thread ID is 802
2018-12-31T22:10:38.094Z,1546294238.094 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-12-31T22:10:38.095Z,1546294238.095 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-12-31T22:10:38.095Z,1546294238.095 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 803
2018-12-31T22:10:38.098Z,1546294238.098 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-12-31T22:10:38.109Z,1546294238.109 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-12-31T22:10:38.110Z,1546294238.110 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-12-31T22:10:38.110Z,1546294238.110 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 804
2018-12-31T22:10:38.111Z,1546294238.111 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-12-31T22:10:38.112Z,1546294238.112 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-12-31T22:10:38.113Z,1546294238.113 [logger ThreadHandler](INFO): Protected caller Thread ID is 805
2018-12-31T22:10:38.114Z,1546294238.114 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-12-31T22:10:38.115Z,1546294238.115 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-12-31T22:10:38.119Z,1546294238.119 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-12-31T22:10:38.216Z,1546294238.216 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-12-31T22:10:38.218Z,1546294238.218 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-12-31T22:10:38.319Z,1546294238.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-12-31T22:10:38.321Z,1546294238.321 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-12-31T22:10:38.516Z,1546294238.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-12-31T22:10:38.518Z,1546294238.518 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-12-31T22:10:38.879Z,1546294238.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-12-31T22:10:38.879Z,1546294238.879 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-12-31T22:10:39.205Z,1546294239.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-12-31T22:10:39.205Z,1546294239.205 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-12-31T22:10:39.653Z,1546294239.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-12-31T22:10:39.655Z,1546294239.655 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-12-31T22:10:40.132Z,1546294240.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-12-31T22:10:40.132Z,1546294240.132 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-12-31T22:10:40.583Z,1546294240.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-12-31T22:10:40.585Z,1546294240.585 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-12-31T22:10:40.667Z,1546294240.667 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-12-31T22:10:40.976Z,1546294240.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-12-31T22:10:40.978Z,1546294240.978 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-12-31T22:10:41.144Z,1546294241.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-12-31T22:10:41.485Z,1546294241.485 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-12-31T22:10:41.909Z,1546294241.909 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-12-31T22:10:41.910Z,1546294241.910 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-12-31T22:10:42.114Z,1546294242.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-12-31T22:10:42.115Z,1546294242.115 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-12-31T22:10:42.213Z,1546294242.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-12-31T22:10:42.214Z,1546294242.214 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-12-31T22:10:42.359Z,1546294242.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-12-31T22:10:42.361Z,1546294242.361 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-12-31T22:10:42.363Z,1546294242.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-12-31T22:10:42.593Z,1546294242.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-12-31T22:10:42.595Z,1546294242.595 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-12-31T22:10:42.700Z,1546294242.700 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-12-31T22:10:42.853Z,1546294242.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-12-31T22:10:42.946Z,1546294242.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-12-31T22:10:43.031Z,1546294243.031 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-12-31T22:10:43.191Z,1546294243.191 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-12-31T22:10:43.394Z,1546294243.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-12-31T22:10:43.492Z,1546294243.492 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-12-31T22:10:43.587Z,1546294243.587 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-12-31T22:10:43.685Z,1546294243.685 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-12-31T22:10:43.767Z,1546294243.767 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2018-12-31T22:10:43.770Z,1546294243.770 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-12-31T22:10:43.897Z,1546294243.897 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-12-31T22:10:43.898Z,1546294243.898 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-12-31T22:10:43.922Z,1546294243.922 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-12-31T22:10:43.924Z,1546294243.924 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-12-31T22:10:43.980Z,1546294243.980 [DepthRateCalculator] Loaded
2018-12-31T22:10:43.980Z,1546294243.980 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-12-31T22:10:43.986Z,1546294243.986 [PitchRateCalculator] Loaded
2018-12-31T22:10:43.986Z,1546294243.986 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-12-31T22:10:44.001Z,1546294244.001 [SpeedCalculator] Loaded
2018-12-31T22:10:44.002Z,1546294244.002 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-12-31T22:10:44.022Z,1546294244.022 [TempGradientCalculator] Loaded
2018-12-31T22:10:44.022Z,1546294244.022 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-12-31T22:10:44.028Z,1546294244.028 [YawRateCalculator] Loaded
2018-12-31T22:10:44.028Z,1546294244.028 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-12-31T22:10:44.068Z,1546294244.068 [ElevatorOffsetCalculator] Loaded
2018-12-31T22:10:44.068Z,1546294244.068 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-12-31T22:10:44.068Z,1546294244.068 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-12-31T22:10:44.069Z,1546294244.069 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-12-31T22:10:44.109Z,1546294244.109 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-12-31T22:10:44.110Z,1546294244.110 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-12-31T22:10:55.590Z,1546294255.590 [DataOverHttps] Loaded
2018-12-31T22:10:55.590Z,1546294255.590 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-12-31T22:10:55.629Z,1546294255.629 [Depth_Keller] Loaded
2018-12-31T22:10:55.629Z,1546294255.629 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-12-31T22:10:55.634Z,1546294255.634 [DropWeight] Loaded
2018-12-31T22:10:55.634Z,1546294255.634 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-12-31T22:10:55.643Z,1546294255.643 [GobyModem] Loaded
2018-12-31T22:10:55.643Z,1546294255.643 [ComponentRegistry](DEBUG): SyncComponent "GobyModem" handled in the control thread.
2018-12-31T22:10:55.739Z,1546294255.739 [NAL9602] Loaded
2018-12-31T22:10:55.739Z,1546294255.739 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-12-31T22:10:55.754Z,1546294255.754 [Onboard] Loaded
2018-12-31T22:10:55.755Z,1546294255.755 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-12-31T22:10:55.765Z,1546294255.765 [Radio_Surface] Loaded
2018-12-31T22:10:55.765Z,1546294255.765 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-12-31T22:10:55.766Z,1546294255.766 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 419E04E0
2018-12-31T22:10:55.766Z,1546294255.766 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 885
2018-12-31T22:10:55.919Z,1546294255.919 [PNI_TCM] Loaded
2018-12-31T22:10:55.919Z,1546294255.919 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-12-31T22:10:55.979Z,1546294255.979 [Rowe_600LCM] Loaded
2018-12-31T22:10:55.979Z,1546294255.979 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2018-12-31T22:10:55.980Z,1546294255.980 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 41A104E0
2018-12-31T22:10:55.980Z,1546294255.980 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 886
2018-12-31T22:10:57.757Z,1546294257.757 [BPC1] Loaded
2018-12-31T22:10:57.757Z,1546294257.757 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-12-31T22:10:57.757Z,1546294257.757 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-12-31T22:10:57.758Z,1546294257.758 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-12-31T22:10:57.916Z,1546294257.916 [SBIT](DEBUG): Construct Startup Built In Test.
2018-12-31T22:10:57.939Z,1546294257.939 [SBIT] Loaded
2018-12-31T22:10:57.939Z,1546294257.939 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-12-31T22:10:57.940Z,1546294257.940 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-12-31T22:10:57.951Z,1546294257.951 [IBIT] Loaded
2018-12-31T22:10:57.951Z,1546294257.951 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-12-31T22:10:57.955Z,1546294257.955 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-12-31T22:10:58.092Z,1546294258.092 [CBIT] Loaded
2018-12-31T22:10:58.092Z,1546294258.092 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-12-31T22:10:58.092Z,1546294258.092 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-12-31T22:10:58.093Z,1546294258.093 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-12-31T22:10:58.323Z,1546294258.323 [Aanderaa_O2] Loaded
2018-12-31T22:10:58.323Z,1546294258.323 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-12-31T22:10:58.405Z,1546294258.405 [CTD_Seabird] Loaded
2018-12-31T22:10:58.405Z,1546294258.405 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-12-31T22:10:58.407Z,1546294258.407 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 41AF04E0
2018-12-31T22:10:58.407Z,1546294258.407 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 888
2018-12-31T22:10:58.424Z,1546294258.424 [ESPComponent] Loaded
2018-12-31T22:10:58.424Z,1546294258.424 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-12-31T22:10:58.438Z,1546294258.438 [PAR_Licor] Loaded
2018-12-31T22:10:58.439Z,1546294258.439 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-12-31T22:10:58.486Z,1546294258.486 [WetLabsBB2FL] Loaded
2018-12-31T22:10:58.487Z,1546294258.487 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-12-31T22:10:58.488Z,1546294258.488 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 41B204E0
2018-12-31T22:10:58.488Z,1546294258.488 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 889
2018-12-31T22:10:58.489Z,1546294258.489 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-12-31T22:10:58.490Z,1546294258.490 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-12-31T22:10:58.768Z,1546294258.768 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-12-31T22:10:58.769Z,1546294258.769 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-12-31T22:10:58.856Z,1546294258.856 [VerticalControl](DEBUG): Construct VerticalControl.
2018-12-31T22:10:58.949Z,1546294258.949 [VerticalControl] Loaded
2018-12-31T22:10:58.949Z,1546294258.949 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-12-31T22:10:58.950Z,1546294258.950 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-12-31T22:10:59.010Z,1546294259.010 [HorizontalControl] Loaded
2018-12-31T22:10:59.010Z,1546294259.010 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-12-31T22:10:59.011Z,1546294259.011 [SpeedControl](DEBUG): Construct SpeedControl.
2018-12-31T22:10:59.016Z,1546294259.016 [SpeedControl] Loaded
2018-12-31T22:10:59.016Z,1546294259.016 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-12-31T22:10:59.017Z,1546294259.017 [LoopControl](DEBUG): Construct LoopControl.
2018-12-31T22:10:59.017Z,1546294259.017 [LoopControl] Loaded
2018-12-31T22:10:59.018Z,1546294259.018 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-12-31T22:10:59.018Z,1546294259.018 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-12-31T22:10:59.019Z,1546294259.019 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-12-31T22:10:59.121Z,1546294259.121 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-12-31T22:10:59.122Z,1546294259.122 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-12-31T22:10:59.239Z,1546294259.239 [BuoyancyServo] Loaded
2018-12-31T22:10:59.240Z,1546294259.240 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-12-31T22:10:59.251Z,1546294259.251 [ElevatorServo] Loaded
2018-12-31T22:10:59.252Z,1546294259.252 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-12-31T22:10:59.262Z,1546294259.262 [MassServo] Loaded
2018-12-31T22:10:59.263Z,1546294259.263 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-12-31T22:10:59.273Z,1546294259.273 [RudderServo] Loaded
2018-12-31T22:10:59.274Z,1546294259.274 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-12-31T22:10:59.284Z,1546294259.284 [ThrusterServo] Loaded
2018-12-31T22:10:59.285Z,1546294259.285 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-12-31T22:10:59.285Z,1546294259.285 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-12-31T22:10:59.286Z,1546294259.286 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-12-31T22:10:59.400Z,1546294259.400 [DeadReckonUsingSpeedCalculator] Loaded
2018-12-31T22:10:59.401Z,1546294259.401 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-12-31T22:10:59.417Z,1546294259.417 [NavChart] Loaded
2018-12-31T22:10:59.417Z,1546294259.417 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-12-31T22:10:59.421Z,1546294259.421 [UniversalFixResidualReporter] Loaded
2018-12-31T22:10:59.421Z,1546294259.421 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-12-31T22:10:59.422Z,1546294259.422 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-12-31T22:10:59.425Z,1546294259.425 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-12-31T22:10:59.426Z,1546294259.426 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-12-31T22:10:59.433Z,1546294259.433 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-12-31T22:10:59.434Z,1546294259.434 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 41C7A4E0
2018-12-31T22:10:59.434Z,1546294259.434 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 890
2018-12-31T22:10:59.439Z,1546294259.439 [Supervisor](INFO): Main Thread ID is 798
2018-12-31T22:10:59.439Z,1546294259.439 [Supervisor](DEBUG): Running supervisor.
2018-12-31T22:10:59.440Z,1546294259.440 [CommandLine ThreadHandler](INFO): Handler Thread ID is 891
2018-12-31T22:10:59.442Z,1546294259.442 [controlThread ThreadHandler](INFO): Handler Thread ID is 892
2018-12-31T22:10:59.442Z,1546294259.442 [controlThread](DEBUG): Initializing ControlThread
2018-12-31T22:10:59.443Z,1546294259.443 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-12-31T22:10:59.444Z,1546294259.444 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-12-31T22:10:59.444Z,1546294259.444 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-12-31T22:10:59.444Z,1546294259.444 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-12-31T22:10:59.445Z,1546294259.445 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-12-31T22:10:59.445Z,1546294259.445 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-12-31T22:10:59.467Z,1546294259.467 [logger ThreadHandler](INFO): Handler Thread ID is 893
2018-12-31T22:10:59.495Z,1546294259.495 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 894
2018-12-31T22:10:59.501Z,1546294259.501 [Radio_Surface](INFO): Powering up
2018-12-31T22:10:59.515Z,1546294259.515 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 895
2018-12-31T22:10:59.515Z,1546294259.515 [Rowe_600LCM](INFO): Initializing
2018-12-31T22:10:59.516Z,1546294259.516 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T22:10:59.637Z,1546294259.637 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 896
2018-12-31T22:10:59.639Z,1546294259.639 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T22:10:59.643Z,1546294259.643 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T22:10:59.799Z,1546294259.799 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 898
2018-12-31T22:10:59.803Z,1546294259.803 [WetLabsBB2FL](INFO): Powering down
2018-12-31T22:10:59.835Z,1546294259.835 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 899
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-12-31T22:10:59.843Z,1546294259.843 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-12-31T22:10:59.844Z,1546294259.844 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-12-31T22:10:59.844Z,1546294259.844 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-12-31T22:10:59.844Z,1546294259.844 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-12-31T22:10:59.844Z,1546294259.844 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-12-31T22:10:59.844Z,1546294259.844 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-12-31T22:10:59.845Z,1546294259.845 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-12-31T22:10:59.845Z,1546294259.845 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-12-31T22:10:59.845Z,1546294259.845 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-12-31T22:10:59.845Z,1546294259.845 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-12-31T22:10:59.845Z,1546294259.845 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-12-31T22:11:00.137Z,1546294260.137 [Rowe_600LCM](INFO): LCM OK
2018-12-31T22:11:00.137Z,1546294260.137 [Rowe_600LCM](INFO): Powering up
2018-12-31T22:11:04.052Z,1546294264.052 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T22:11:04.133Z,1546294264.133 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T22:11:04.327Z,1546294264.327 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T22:11:04.327Z,1546294264.327 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T22:11:04.328Z,1546294264.328 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T22:11:13.758Z,1546294273.758 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T22:11:13.758Z,1546294273.758 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T22:11:13.759Z,1546294273.759 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T22:11:14.163Z,1546294274.163 [CTD_Seabird](INFO): Powering down
2018-12-31T22:11:26.648Z,1546294286.648 [CommandLine](IMPORTANT): got command failComponent
2018-12-31T22:11:26.648Z,1546294286.648 [CommandLine](IMPORTANT): Failed components:
2018-12-31T22:11:26.649Z,1546294286.649 [CommandLine](IMPORTANT): CTD_Seabird: Communications Fault
2018-12-31T22:11:29.884Z,1546294289.884 [CommandLine](IMPORTANT): got command restart application
2018-12-31T22:11:30.897Z,1546294290.897 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T22:11:30.897Z,1546294290.897 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-12-31T22:11:30.950Z,1546294290.950 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-12-31T22:11:30.950Z,1546294290.950 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-12-31T22:11:30.951Z,1546294290.951 [CommandLine](INFO): Join timeout helper Thread ID is 908
2018-12-31T22:11:30.957Z,1546294290.957 [ComponentRegistry](INFO): Shutting do