2018-12-12T05:55:58.547Z,1544594158.547 [Supervisor](DEBUG): Initializing supervisor.
2018-12-12T05:55:58.550Z,1544594158.550 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-12-12T05:55:58.550Z,1544594158.550 [SyncHandler](INFO): Protected caller Thread ID is 597
2018-12-12T05:55:58.551Z,1544594158.551 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-12-12T05:55:58.552Z,1544594158.552 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-12-12T05:55:58.552Z,1544594158.552 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 598
2018-12-12T05:55:58.555Z,1544594158.555 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-12-12T05:55:58.566Z,1544594158.566 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-12-12T05:55:58.567Z,1544594158.567 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-12-12T05:55:58.568Z,1544594158.568 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 599
2018-12-12T05:55:58.569Z,1544594158.569 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-12-12T05:55:58.569Z,1544594158.569 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-12-12T05:55:58.570Z,1544594158.570 [logger ThreadHandler](INFO): Protected caller Thread ID is 600
2018-12-12T05:55:58.572Z,1544594158.572 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-12-12T05:55:58.572Z,1544594158.572 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-12-12T05:55:58.576Z,1544594158.576 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-12-12T05:55:58.673Z,1544594158.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-12-12T05:55:58.675Z,1544594158.675 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-12-12T05:55:58.775Z,1544594158.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-12-12T05:55:58.777Z,1544594158.777 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-12-12T05:55:58.985Z,1544594158.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-12-12T05:55:58.986Z,1544594158.986 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-12-12T05:55:59.316Z,1544594159.316 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-12-12T05:55:59.318Z,1544594159.318 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-12-12T05:55:59.656Z,1544594159.656 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-12-12T05:55:59.658Z,1544594159.658 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-12-12T05:56:00.110Z,1544594160.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-12-12T05:56:00.111Z,1544594160.111 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-12-12T05:56:00.568Z,1544594160.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-12-12T05:56:00.570Z,1544594160.570 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-12-12T05:56:01.015Z,1544594161.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-12-12T05:56:01.017Z,1544594161.017 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-12-12T05:56:01.098Z,1544594161.098 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-12-12T05:56:01.416Z,1544594161.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-12-12T05:56:01.418Z,1544594161.418 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-12-12T05:56:01.566Z,1544594161.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-12-12T05:56:01.567Z,1544594161.567 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-12-12T05:56:01.779Z,1544594161.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-12-12T05:56:01.780Z,1544594161.780 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-12-12T05:56:01.988Z,1544594161.988 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-12-12T05:56:01.989Z,1544594161.989 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-12-12T05:56:02.258Z,1544594162.258 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-12-12T05:56:02.259Z,1544594162.259 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-12-12T05:56:02.404Z,1544594162.404 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-12-12T05:56:02.406Z,1544594162.406 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-INSERTREALNAME/
2018-12-12T05:56:02.407Z,1544594162.407 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-12-12T05:56:02.414Z,1544594162.414 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-12-12T05:56:02.609Z,1544594162.609 [InternalSim] Loaded
2018-12-12T05:56:02.609Z,1544594162.609 [ComponentRegistry](DEBUG): SyncComponent "InternalSim" handled in the control thread.
2018-12-12T05:56:02.610Z,1544594162.610 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-12-12T05:56:02.612Z,1544594162.612 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-12-12T05:56:02.636Z,1544594162.636 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-12-12T05:56:02.638Z,1544594162.638 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-12-12T05:56:02.694Z,1544594162.694 [DepthRateCalculator] Loaded
2018-12-12T05:56:02.694Z,1544594162.694 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-12-12T05:56:02.700Z,1544594162.700 [PitchRateCalculator] Loaded
2018-12-12T05:56:02.700Z,1544594162.700 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-12-12T05:56:02.715Z,1544594162.715 [SpeedCalculator] Loaded
2018-12-12T05:56:02.715Z,1544594162.715 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-12-12T05:56:02.736Z,1544594162.736 [TempGradientCalculator] Loaded
2018-12-12T05:56:02.736Z,1544594162.736 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-12-12T05:56:02.741Z,1544594162.741 [YawRateCalculator] Loaded
2018-12-12T05:56:02.742Z,1544594162.742 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-12-12T05:56:02.780Z,1544594162.780 [ElevatorOffsetCalculator] Loaded
2018-12-12T05:56:02.781Z,1544594162.781 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-12-12T05:56:02.781Z,1544594162.781 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-12-12T05:56:02.782Z,1544594162.782 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-12-12T05:56:02.820Z,1544594162.820 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-12-12T05:56:02.820Z,1544594162.820 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-12-12T05:56:03.378Z,1544594163.378 [DataOverHttps] Loaded
2018-12-12T05:56:03.378Z,1544594163.378 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-12-12T05:56:03.391Z,1544594163.391 [Depth_Keller] Loaded
2018-12-12T05:56:03.392Z,1544594163.392 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-12-12T05:56:03.397Z,1544594163.397 [DropWeight] Loaded
2018-12-12T05:56:03.397Z,1544594163.397 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-12-12T05:56:03.525Z,1544594163.525 [DVL_micro] Loaded
2018-12-12T05:56:03.525Z,1544594163.525 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2018-12-12T05:56:03.621Z,1544594163.621 [NAL9602] Loaded
2018-12-12T05:56:03.621Z,1544594163.621 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-12-12T05:56:03.637Z,1544594163.637 [Onboard] Loaded
2018-12-12T05:56:03.637Z,1544594163.637 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-12-12T05:56:03.647Z,1544594163.647 [Radio_Surface] Loaded
2018-12-12T05:56:03.647Z,1544594163.647 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-12-12T05:56:03.648Z,1544594163.648 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C24E0
2018-12-12T05:56:03.648Z,1544594163.648 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 646
2018-12-12T05:56:03.777Z,1544594163.777 [DAT] Loaded
2018-12-12T05:56:03.778Z,1544594163.778 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2018-12-12T05:56:03.822Z,1544594163.822 [PNI_TCM] Loaded
2018-12-12T05:56:03.823Z,1544594163.823 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-12-12T05:56:03.846Z,1544594163.846 [BPC1](CRITICAL): Could not find element Config/Battery.stick1
2018-12-12T05:56:03.847Z,1544594163.847 [BPC1](CRITICAL): Could not find element Config/Battery.stick2
2018-12-12T05:56:03.848Z,1544594163.848 [BPC1](CRITICAL): Could not find element Config/Battery.stick3
2018-12-12T05:56:03.848Z,1544594163.848 [BPC1](CRITICAL): Could not find element Config/Battery.stick4
2018-12-12T05:56:03.849Z,1544594163.849 [BPC1](CRITICAL): Could not find element Config/Battery.stick5
2018-12-12T05:56:03.849Z,1544594163.849 [BPC1](CRITICAL): Could not find element Config/Battery.stick6
2018-12-12T05:56:03.850Z,1544594163.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick7
2018-12-12T05:56:03.850Z,1544594163.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick8
2018-12-12T05:56:03.850Z,1544594163.850 [BPC1](CRITICAL): Could not find element Config/Battery.stick9
2018-12-12T05:56:03.851Z,1544594163.851 [BPC1](CRITICAL): Could not find element Config/Battery.stick10
2018-12-12T05:56:03.852Z,1544594163.852 [BPC1](CRITICAL): Could not find element Config/Battery.stick11
2018-12-12T05:56:03.852Z,1544594163.852 [BPC1](CRITICAL): Could not find element Config/Battery.stick12
2018-12-12T05:56:03.852Z,1544594163.852 [BPC1](CRITICAL): Could not find element Config/Battery.stick13
2018-12-12T05:56:03.853Z,1544594163.853 [BPC1](CRITICAL): Could not find element Config/Battery.stick14
2018-12-12T05:56:03.853Z,1544594163.853 [BPC1](CRITICAL): Could not find element Config/Battery.stick15
2018-12-12T05:56:03.854Z,1544594163.854 [BPC1](CRITICAL): Could not find element Config/Battery.stick16
2018-12-12T05:56:03.854Z,1544594163.854 [BPC1](CRITICAL): Could not find element Config/Battery.stick17
2018-12-12T05:56:03.855Z,1544594163.855 [BPC1](CRITICAL): Could not find element Config/Battery.stick18
2018-12-12T05:56:03.855Z,1544594163.855 [BPC1](CRITICAL): Could not find element Config/Battery.stick19
2018-12-12T05:56:03.856Z,1544594163.856 [BPC1](CRITICAL): Could not find element Config/Battery.stick20
2018-12-12T05:56:03.856Z,1544594163.856 [BPC1](CRITICAL): Could not find element Config/Battery.stick21
2018-12-12T05:56:03.857Z,1544594163.857 [BPC1](CRITICAL): Could not find element Config/Battery.stick22
2018-12-12T05:56:03.857Z,1544594163.857 [BPC1](CRITICAL): Could not find element Config/Battery.stick23
2018-12-12T05:56:03.858Z,1544594163.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick24
2018-12-12T05:56:03.858Z,1544594163.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick25
2018-12-12T05:56:03.858Z,1544594163.858 [BPC1](CRITICAL): Could not find element Config/Battery.stick26
2018-12-12T05:56:03.859Z,1544594163.859 [BPC1](CRITICAL): Could not find element Config/Battery.stick27
2018-12-12T05:56:03.859Z,1544594163.859 [BPC1](CRITICAL): Could not find element Config/Battery.stick28
2018-12-12T05:56:03.860Z,1544594163.860 [BPC1](CRITICAL): Could not find element Config/Battery.stick29
2018-12-12T05:56:03.860Z,1544594163.860 [BPC1](CRITICAL): Could not find element Config/Battery.stick30
2018-12-12T05:56:03.861Z,1544594163.861 [BPC1](CRITICAL): Could not find element Config/Battery.stick31
2018-12-12T05:56:03.862Z,1544594163.862 [BPC1](CRITICAL): Could not find element Config/Battery.stick32
2018-12-12T05:56:03.862Z,1544594163.862 [BPC1](CRITICAL): Could not find element Config/Battery.stick33
2018-12-12T05:56:03.863Z,1544594163.863 [BPC1](CRITICAL): Could not find element Config/Battery.stick34
2018-12-12T05:56:03.863Z,1544594163.863 [BPC1](CRITICAL): Could not find element Config/Battery.stick35
2018-12-12T05:56:03.864Z,1544594163.864 [BPC1](CRITICAL): Could not find element Config/Battery.stick36
2018-12-12T05:56:03.864Z,1544594163.864 [BPC1](CRITICAL): Could not find element Config/Battery.stick37
2018-12-12T05:56:03.865Z,1544594163.865 [BPC1](CRITICAL): Could not find element Config/Battery.stick38
2018-12-12T05:56:03.865Z,1544594163.865 [BPC1](CRITICAL): Could not find element Config/Battery.stick39
2018-12-12T05:56:03.866Z,1544594163.866 [BPC1](CRITICAL): Could not find element Config/Battery.stick40
2018-12-12T05:56:03.866Z,1544594163.866 [BPC1](CRITICAL): Could not find element Config/Battery.stick41
2018-12-12T05:56:03.867Z,1544594163.867 [BPC1](CRITICAL): Could not find element Config/Battery.stick42
2018-12-12T05:56:03.867Z,1544594163.867 [BPC1](CRITICAL): Could not find element Config/Battery.stick43
2018-12-12T05:56:03.868Z,1544594163.868 [BPC1](CRITICAL): Could not find element Config/Battery.stick44
2018-12-12T05:56:03.868Z,1544594163.868 [BPC1](CRITICAL): Could not find element Config/Battery.stick45
2018-12-12T05:56:03.869Z,1544594163.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick46
2018-12-12T05:56:03.869Z,1544594163.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick47
2018-12-12T05:56:03.869Z,1544594163.869 [BPC1](CRITICAL): Could not find element Config/Battery.stick48
2018-12-12T05:56:03.870Z,1544594163.870 [BPC1](CRITICAL): Could not find element Config/Battery.stick49
2018-12-12T05:56:03.870Z,1544594163.870 [BPC1](CRITICAL): Could not find element Config/Battery.stick50
2018-12-12T05:56:03.871Z,1544594163.871 [BPC1](CRITICAL): Could not find element Config/Battery.stick51
2018-12-12T05:56:03.871Z,1544594163.871 [BPC1](CRITICAL): Could not find element Config/Battery.stick52
2018-12-12T05:56:03.872Z,1544594163.872 [BPC1](CRITICAL): Could not find element Config/Battery.stick53
2018-12-12T05:56:03.872Z,1544594163.872 [BPC1](CRITICAL): Could not find element Config/Battery.stick54
2018-12-12T05:56:03.873Z,1544594163.873 [BPC1](CRITICAL): Could not find element Config/Battery.stick55
2018-12-12T05:56:03.873Z,1544594163.873 [BPC1](CRITICAL): Could not find element Config/Battery.stick56
2018-12-12T05:56:03.874Z,1544594163.874 [BPC1](CRITICAL): Could not find element Config/Battery.stick57
2018-12-12T05:56:03.874Z,1544594163.874 [BPC1](CRITICAL): Could not find element Config/Battery.stick58
2018-12-12T05:56:03.874Z,1544594163.874 [BPC1](CRITICAL): Could not find element Config/Battery.stick59
2018-12-12T05:56:03.875Z,1544594163.875 [BPC1](CRITICAL): Could not find element Config/Battery.stick60
2018-12-12T05:56:03.875Z,1544594163.875 [BPC1](CRITICAL): Could not find element Config/Battery.stick61
2018-12-12T05:56:03.876Z,1544594163.876 [BPC1](CRITICAL): Could not find element Config/Battery.stick62
2018-12-12T05:56:05.586Z,1544594165.586 [BPC1] Loaded
2018-12-12T05:56:05.586Z,1544594165.586 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-12-12T05:56:05.587Z,1544594165.587 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-12-12T05:56:05.587Z,1544594165.587 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-12-12T05:56:05.742Z,1544594165.742 [SBIT](DEBUG): Construct Startup Built In Test.
2018-12-12T05:56:05.764Z,1544594165.764 [SBIT] Loaded
2018-12-12T05:56:05.764Z,1544594165.764 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-12-12T05:56:05.765Z,1544594165.765 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-12-12T05:56:05.776Z,1544594165.776 [IBIT] Loaded
2018-12-12T05:56:05.777Z,1544594165.777 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-12-12T05:56:05.779Z,1544594165.779 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-12-12T05:56:05.928Z,1544594165.928 [CBIT] Loaded
2018-12-12T05:56:05.928Z,1544594165.928 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-12-12T05:56:05.928Z,1544594165.928 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-12-12T05:56:05.929Z,1544594165.929 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-12-12T05:56:06.199Z,1544594166.199 [CTD_NeilBrown] Loaded
2018-12-12T05:56:06.199Z,1544594166.199 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-12-12T05:56:06.200Z,1544594166.200 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408974E0
2018-12-12T05:56:06.201Z,1544594166.201 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 647
2018-12-12T05:56:06.215Z,1544594166.215 [PAR_Licor] Loaded
2018-12-12T05:56:06.215Z,1544594166.215 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-12-12T05:56:06.263Z,1544594166.263 [WetLabsBB2FL] Loaded
2018-12-12T05:56:06.264Z,1544594166.264 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-12-12T05:56:06.265Z,1544594166.265 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408C74E0
2018-12-12T05:56:06.265Z,1544594166.265 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 648
2018-12-12T05:56:06.266Z,1544594166.266 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-12-12T05:56:06.268Z,1544594166.268 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-12-12T05:56:06.549Z,1544594166.549 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-12-12T05:56:06.549Z,1544594166.549 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-12-12T05:56:06.638Z,1544594166.638 [VerticalControl](DEBUG): Construct VerticalControl.
2018-12-12T05:56:06.725Z,1544594166.725 [VerticalControl] Loaded
2018-12-12T05:56:06.725Z,1544594166.725 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-12-12T05:56:06.726Z,1544594166.726 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-12-12T05:56:06.782Z,1544594166.782 [HorizontalControl] Loaded
2018-12-12T05:56:06.783Z,1544594166.783 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-12-12T05:56:06.783Z,1544594166.783 [SpeedControl](DEBUG): Construct SpeedControl.
2018-12-12T05:56:06.785Z,1544594166.785 [SpeedControl] Loaded
2018-12-12T05:56:06.785Z,1544594166.785 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-12-12T05:56:06.786Z,1544594166.786 [BackSeatDriver](DEBUG): Construct BackSeatDriver.
2018-12-12T05:56:06.788Z,1544594166.788 [BackSeatDriver] Loaded
2018-12-12T05:56:06.788Z,1544594166.788 [ComponentRegistry](DEBUG): SyncComponent "BackSeatDriver" handled in the control thread.
2018-12-12T05:56:06.789Z,1544594166.789 [LoopControl](DEBUG): Construct LoopControl.
2018-12-12T05:56:06.789Z,1544594166.789 [LoopControl] Loaded
2018-12-12T05:56:06.790Z,1544594166.790 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-12-12T05:56:06.790Z,1544594166.790 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-12-12T05:56:06.792Z,1544594166.792 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-12-12T05:56:06.894Z,1544594166.894 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-12-12T05:56:06.895Z,1544594166.895 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-12-12T05:56:07.062Z,1544594167.062 [BuoyancyServo] Loaded
2018-12-12T05:56:07.062Z,1544594167.062 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-12-12T05:56:07.073Z,1544594167.073 [ElevatorServo] Loaded
2018-12-12T05:56:07.074Z,1544594167.074 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-12-12T05:56:07.087Z,1544594167.087 [MassServo] Loaded
2018-12-12T05:56:07.089Z,1544594167.089 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-12-12T05:56:07.099Z,1544594167.099 [RudderServo] Loaded
2018-12-12T05:56:07.100Z,1544594167.100 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-12-12T05:56:07.110Z,1544594167.110 [ThrusterServo] Loaded
2018-12-12T05:56:07.110Z,1544594167.110 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-12-12T05:56:07.111Z,1544594167.111 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-12-12T05:56:07.112Z,1544594167.112 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-12-12T05:56:07.222Z,1544594167.222 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-12-12T05:56:07.222Z,1544594167.222 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-12-12T05:56:07.276Z,1544594167.276 [DeadReckonUsingSpeedCalculator] Loaded
2018-12-12T05:56:07.277Z,1544594167.277 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-12-12T05:56:07.293Z,1544594167.293 [NavChart] Loaded
2018-12-12T05:56:07.293Z,1544594167.293 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-12-12T05:56:07.297Z,1544594167.297 [UniversalFixResidualReporter] Loaded
2018-12-12T05:56:07.297Z,1544594167.297 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-12-12T05:56:07.297Z,1544594167.297 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-12-12T05:56:07.301Z,1544594167.301 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-12-12T05:56:07.302Z,1544594167.302 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-12-12T05:56:07.308Z,1544594167.308 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-12-12T05:56:07.309Z,1544594167.309 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0
2018-12-12T05:56:07.310Z,1544594167.310 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 649
2018-12-12T05:56:07.314Z,1544594167.314 [Supervisor](INFO): Main Thread ID is 593
2018-12-12T05:56:07.315Z,1544594167.315 [Supervisor](DEBUG): Running supervisor.
2018-12-12T05:56:07.315Z,1544594167.315 [CommandLine ThreadHandler](INFO): Handler Thread ID is 650
2018-12-12T05:56:07.318Z,1544594167.318 [controlThread ThreadHandler](INFO): Handler Thread ID is 651
2018-12-12T05:56:07.318Z,1544594167.318 [controlThread](DEBUG): Initializing ControlThread
2018-12-12T05:56:07.319Z,1544594167.319 [InternalSim](DEBUG):  InternalSim initializing...
2018-12-12T05:56:07.325Z,1544594167.325 [InternalSim](DEBUG): oceanModelVarCount=0
2018-12-12T05:56:07.384Z,1544594167.384 [logger ThreadHandler](INFO): Handler Thread ID is 652
2018-12-12T05:56:07.431Z,1544594167.431 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 653
2018-12-12T05:56:07.434Z,1544594167.434 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-12-12T05:56:07.435Z,1544594167.435 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-12-12T05:56:07.435Z,1544594167.435 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-12-12T05:56:07.435Z,1544594167.435 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-12-12T05:56:07.436Z,1544594167.436 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-12-12T05:56:07.436Z,1544594167.436 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-12-12T05:56:07.441Z,1544594167.441 [SBIT](INFO): Initialize SBIT Component.
2018-12-12T05:56:07.441Z,1544594167.441 [SBIT](IMPORTANT): git: 2018-11-05-3-g424fd37
2018-12-12T05:56:07.441Z,1544594167.441 [SBIT](INFO): git hash: 424fd377e53a63ada65ca308b07209cf4fd40d4d
2018-12-12T05:56:07.442Z,1544594167.442 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.32-45-generic-pae
Kernel Reported: 2.6.27.8
2018-12-12T05:56:07.443Z,1544594167.443 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #102-Ubuntu SMP Wed Jan 2 22:10:16 UTC 2013
Kernel Reported: #1 PREEMPT Mon Dec 10 23:01:14 PST 2018
2018-12-12T05:56:07.444Z,1544594167.444 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2018-12-12T05:56:07.445Z,1544594167.445 [IBIT](INFO): Initialize IBIT Component.
2018-12-12T05:56:07.446Z,1544594167.446 [CBIT](DEBUG): Initialize CBIT Component.
2018-12-12T05:56:07.446Z,1544594167.446 [CBIT](DEBUG): Initialized mux pins.
2018-12-12T05:56:07.446Z,1544594167.446 [CBIT](DEBUG): Initializing the watchdog timer.
2018-12-12T05:56:07.451Z,1544594167.451 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 654
2018-12-12T05:56:07.460Z,1544594167.460 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 655
2018-12-12T05:56:07.471Z,1544594167.471 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-12-12T05:56:07.472Z,1544594167.472 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-12-12T05:56:07.474Z,1544594167.474 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-12-12T05:56:07.475Z,1544594167.475 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-12-12T05:56:07.475Z,1544594167.475 [BackSeatDriver](DEBUG): Initialize BackSeatDriver Component.
2018-12-12T05:56:07.560Z,1544594167.560 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 656
2018-12-12T05:56:07.568Z,1544594167.568 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-12-12T05:56:07.568Z,1544594167.568 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-12-12T05:56:07.568Z,1544594167.568 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-12-12T05:56:07.568Z,1544594167.568 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-12-12T05:56:07.568Z,1544594167.568 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-12-12T05:56:07.569Z,1544594167.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-12-12T05:56:07.569Z,1544594167.569 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-12-12T05:56:07.569Z,1544594167.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-12-12T05:56:07.569Z,1544594167.569 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-12-12T05:56:07.569Z,1544594167.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-12-12T05:56:07.570Z,1544594167.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-12-12T05:56:07.570Z,1544594167.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-12-12T05:56:07.570Z,1544594167.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-12-12T05:56:07.570Z,1544594167.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-12-12T05:56:07.570Z,1544594167.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-12-12T05:56:07.571Z,1544594167.571 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-12-12T05:56:07.950Z,1544594167.950 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-12-12T05:56:07.952Z,1544594167.952 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-12-12T05:56:07.952Z,1544594167.952 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T05:56:07.953Z,1544594167.953 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T05:56:07.953Z,1544594167.953 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T05:56:07.954Z,1544594167.954 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T05:56:07.954Z,1544594167.954 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T05:56:07.954Z,1544594167.954 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-12-12T05:56:07.955Z,1544594167.955 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-12-12T05:56:07.956Z,1544594167.956 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-12-12T05:56:07.991Z,1544594167.991 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-12T05:56:08.051Z,1544594168.051 [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>


2018-12-12T05:56:08.052Z,1544594168.052 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-12-12T05:56:08.125Z,1544594168.125 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-12-12T05:56:08.126Z,1544594168.126 [Default:A.Wait](DEBUG): Construct Wait.
2018-12-12T05:56:08.144Z,1544594168.144 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-12T05:56:08.175Z,1544594168.175 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-12-12T05:56:08.178Z,1544594168.178 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-12-12T05:56:08.199Z,1544594168.199 [Default:E.Execute](DEBUG): Construct Execute.
2018-12-12T05:56:08.203Z,1544594168.203 [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>


2018-12-12T05:56:08.221Z,1544594168.221 [controlThread](DEBUG): Component order: CycleStarter,InternalSim,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,BackSeatDriver,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-12-12T05:56:08.315Z,1544594168.315 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-12-12T05:56:08.388Z,1544594168.388 [DVL_micro](INFO): Initializing
2018-12-12T05:56:08.700Z,1544594168.700 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-12-12T05:56:08.722Z,1544594168.722 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-12-12T05:56:08.740Z,1544594168.740 [MassServo](DEBUG): Initializing MassServo.
2018-12-12T05:56:08.751Z,1544594168.751 [RudderServo](DEBUG): Initializing RudderServo.
2018-12-12T05:56:08.763Z,1544594168.763 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-12-12T05:56:08.797Z,1544594168.797 [CommandLine](FAULT): Scheduling is paused
2018-12-12T05:56:08.797Z,1544594168.797 [CBIT](INFO): Critical error at 20181212T055603
2018-12-12T05:56:08.798Z,1544594168.798 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-12-12T05:56:08.798Z,1544594168.798 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:08.823Z,1544594168.823 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:09.035Z,1544594169.035 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:09.059Z,1544594169.059 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:09.258Z,1544594169.258 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:09.283Z,1544594169.283 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:09.307Z,1544594169.307 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:09.654Z,1544594169.654 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:09.682Z,1544594169.682 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:09.707Z,1544594169.707 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:10.054Z,1544594170.054 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:10.122Z,1544594170.122 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:10.147Z,1544594170.147 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:10.455Z,1544594170.455 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:10.488Z,1544594170.488 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:10.511Z,1544594170.511 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:19.211Z,1544594179.211 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:19.230Z,1544594179.230 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2018-12-12T05:56:19.230Z,1544594179.230 [PNI_TCM] Data Fault, FailCount= 1
2018-12-12T05:56:19.231Z,1544594179.231 [PNI_TCM](ERROR): Data Fault
2018-12-12T05:56:19.277Z,1544594179.277 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:19.299Z,1544594179.299 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:19.300Z,1544594179.300 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T05:56:19.300Z,1544594179.300 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-12T05:56:19.542Z,1544594179.542 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:19.612Z,1544594179.612 [CBIT](INFO): Critical error at 20181212T055619
2018-12-12T05:56:19.613Z,1544594179.613 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:19.635Z,1544594179.635 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:19.720Z,1544594179.720 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:19.748Z,1544594179.748 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:19.771Z,1544594179.771 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:20.120Z,1544594180.120 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003891
2018-12-12T05:56:20.123Z,1544594180.123 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:20.152Z,1544594180.152 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:20.175Z,1544594180.175 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:20.518Z,1544594180.518 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:20.544Z,1544594180.544 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:20.567Z,1544594180.567 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:20.918Z,1544594180.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:20.945Z,1544594180.945 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:20.967Z,1544594180.967 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:21.318Z,1544594181.318 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:21.344Z,1544594181.344 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:21.367Z,1544594181.367 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:21.718Z,1544594181.718 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:21.744Z,1544594181.744 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:21.767Z,1544594181.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:22.119Z,1544594182.119 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:22.153Z,1544594182.153 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:22.175Z,1544594182.175 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:22.518Z,1544594182.518 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:22.563Z,1544594182.563 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:22.587Z,1544594182.587 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:22.918Z,1544594182.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:22.944Z,1544594182.944 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:22.967Z,1544594182.967 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:23.318Z,1544594183.318 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:23.344Z,1544594183.344 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:23.367Z,1544594183.367 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:23.718Z,1544594183.718 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:23.744Z,1544594183.744 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:23.767Z,1544594183.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:24.118Z,1544594184.118 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:24.144Z,1544594184.144 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:24.167Z,1544594184.167 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:24.518Z,1544594184.518 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:24.544Z,1544594184.544 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:24.567Z,1544594184.567 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:24.918Z,1544594184.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:24.944Z,1544594184.944 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:24.967Z,1544594184.967 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:25.318Z,1544594185.318 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:25.344Z,1544594185.344 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:25.367Z,1544594185.367 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:25.718Z,1544594185.718 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:25.744Z,1544594185.744 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:25.767Z,1544594185.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:26.118Z,1544594186.118 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:26.144Z,1544594186.144 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:26.167Z,1544594186.167 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:26.518Z,1544594186.518 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:26.545Z,1544594186.545 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:26.567Z,1544594186.567 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:26.918Z,1544594186.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:26.944Z,1544594186.944 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:26.967Z,1544594186.967 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:27.318Z,1544594187.318 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:27.344Z,1544594187.344 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:27.367Z,1544594187.367 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:27.718Z,1544594187.718 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:27.744Z,1544594187.744 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:27.767Z,1544594187.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:28.118Z,1544594188.118 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:28.143Z,1544594188.143 [SBIT](IMPORTANT): Beginning Startup BIT
2018-12-12T05:56:28.145Z,1544594188.145 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:28.171Z,1544594188.171 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:28.518Z,1544594188.518 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:28.544Z,1544594188.544 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:28.567Z,1544594188.567 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:28.918Z,1544594188.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:28.950Z,1544594188.950 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:28.975Z,1544594188.975 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:29.319Z,1544594189.319 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:29.345Z,1544594189.345 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:29.367Z,1544594189.367 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:29.719Z,1544594189.719 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:29.744Z,1544594189.744 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:29.767Z,1544594189.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:30.118Z,1544594190.118 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:30.145Z,1544594190.145 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:30.167Z,1544594190.167 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:30.519Z,1544594190.519 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:30.545Z,1544594190.545 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:30.567Z,1544594190.567 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:30.918Z,1544594190.918 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:30.946Z,1544594190.946 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:30.971Z,1544594190.971 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:31.319Z,1544594191.319 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:31.345Z,1544594191.345 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:31.371Z,1544594191.371 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:31.718Z,1544594191.718 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:31.745Z,1544594191.745 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:31.767Z,1544594191.767 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:32.118Z,1544594192.118 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:32.145Z,1544594192.145 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:32.167Z,1544594192.167 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:32.520Z,1544594192.520 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:32.549Z,1544594192.549 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:32.583Z,1544594192.583 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:32.919Z,1544594192.919 [DAT](ERROR): Could not read simulated DAT measurements from SimSlate.
2018-12-12T05:56:32.961Z,1544594192.961 [CBIT](FAULT): Backplane power off. Attempting to restore.
2018-12-12T05:56:32.999Z,1544594192.999 [CBIT](IMPORTANT): Backplane power restored.
2018-12-12T05:56:33.318Z,1544594193.318 [DAT](ERROR): Could not read si