2018-08-01T00:14:20.518Z,1533082460.518 [CommandLine](IMPORTANT): got command restart logs
2018-08-01T00:14:21.564Z,1533082461.564 [NAL9602](INFO): GPS fix at 20180801T001420: (36.803985, -121.815735)
2018-08-01T00:14:21.626Z,1533082461.626 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T00:14:21.626Z,1533082461.626 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-08-01T00:14:40.595Z,1533082480.595 [NAL9602](INFO): SBD MO Status=1, MOMSN=669, MT Status=0, MTMSN=0
2018-08-01T00:14:40.649Z,1533082480.649 [NAL9602](INFO): Sent 25 bytes from file Logs/20180731T204619/Courier0061.lzma
2018-08-01T00:14:40.649Z,1533082480.649 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:14:40.651Z,1533082480.651 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180731T204619/Courier0061.lzma.parts/0000.sbd
2018-08-01T00:14:40.651Z,1533082480.651 [NAL9602](DEBUG): Completed sending Logs/20180731T204619/Courier0061.lzma
2018-08-01T00:14:58.672Z,1533082498.672 [NAL9602](INFO): SBD MO Status=2, MOMSN=670, MT Status=2, MTMSN=0
2018-08-01T00:14:58.672Z,1533082498.672 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T00:15:22.400Z,1533082522.400 [NAL9602](INFO): SBD MO Status=1, MOMSN=670, MT Status=0, MTMSN=0
2018-08-01T00:15:22.463Z,1533082522.463 [NAL9602](INFO): Sent 25 bytes from file Logs/20180801T001420/Courier0000.lzma
2018-08-01T00:15:22.463Z,1533082522.463 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:15:22.464Z,1533082522.464 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180801T001420/Courier0000.lzma.parts/0000.sbd
2018-08-01T00:15:22.465Z,1533082522.465 [NAL9602](DEBUG): Completed sending Logs/20180801T001420/Courier0000.lzma
2018-08-01T00:16:12.951Z,1533082572.951 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2018-08-01T00:16:18.124Z,1533082578.124 [NAL9602](INFO): SBD MO Status=2, MOMSN=671, MT Status=2, MTMSN=0
2018-08-01T00:16:18.124Z,1533082578.124 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T00:16:38.244Z,1533082598.244 [NAL9602](INFO): SBD MO Status=1, MOMSN=671, MT Status=0, MTMSN=0
2018-08-01T00:16:38.293Z,1533082598.293 [NAL9602](INFO): Sent 163 bytes from file Logs/20180731T204619/Express0062.lzma
2018-08-01T00:16:38.293Z,1533082598.293 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:16:38.295Z,1533082598.295 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180731T204619/Express0062.lzma.parts/0000.sbd
2018-08-01T00:16:38.295Z,1533082598.295 [NAL9602](DEBUG): Completed sending Logs/20180731T204619/Express0062.lzma
2018-08-01T00:16:50.392Z,1533082610.392 [NAL9602](INFO): SBD MO Status=1, MOMSN=672, MT Status=0, MTMSN=0
2018-08-01T00:16:50.445Z,1533082610.445 [NAL9602](INFO): Sent 25 bytes from file Logs/20180801T001420/Express0001.lzma
2018-08-01T00:16:50.445Z,1533082610.445 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:16:50.447Z,1533082610.447 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180801T001420/Express0001.lzma.parts/0000.sbd
2018-08-01T00:16:50.447Z,1533082610.447 [NAL9602](DEBUG): Completed sending Logs/20180801T001420/Express0001.lzma
2018-08-01T00:16:59.200Z,1533082619.200 [NAL9602](INFO): SBD MO Status=0, MOMSN=673, MT Status=0, MTMSN=0
2018-08-01T00:17:20.947Z,1533082640.947 [NAL9602](INFO): SBD MO Status=1, MOMSN=674, MT Status=0, MTMSN=0
2018-08-01T00:17:20.997Z,1533082640.997 [NAL9602](INFO): Sent 212 bytes from file Logs/20180801T001420/Courier0003.lzma
2018-08-01T00:17:20.997Z,1533082640.997 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:17:20.999Z,1533082640.999 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180801T001420/Courier0003.lzma.parts/0000.sbd
2018-08-01T00:17:20.999Z,1533082640.999 [NAL9602](DEBUG): Completed sending Logs/20180801T001420/Courier0003.lzma
2018-08-01T00:17:45.091Z,1533082665.091 [NAL9602](INFO): SBD MO Status=1, MOMSN=675, MT Status=0, MTMSN=0
2018-08-01T00:17:45.145Z,1533082665.145 [NAL9602](INFO): Sent 277 bytes from file Logs/20180801T001420/Express0004.lzma
2018-08-01T00:17:45.145Z,1533082665.145 [NAL9602](INFO): Packets left to send: 0
2018-08-01T00:17:45.147Z,1533082665.147 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180801T001420/Express0004.lzma.parts/0000.sbd
2018-08-01T00:17:45.147Z,1533082665.147 [NAL9602](DEBUG): Completed sending Logs/20180801T001420/Express0004.lzma
2018-08-01T00:18:05.491Z,1533082685.491 [NAL9602](INFO): SBD MO Status=0, MOMSN=676, MT Status=0, MTMSN=0
2018-08-01T00:18:05.598Z,1533082685.598 [Default:CheckIn:Read_Iridium] Stopped
2018-08-01T00:18:05.599Z,1533082685.599 [Default:CheckIn:C.Wait] Running Loop=1
2018-08-01T00:18:05.599Z,1533082685.599 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-08-01T00:18:36.290Z,1533082716.290 [NAL9602](INFO): Powering down
2018-08-01T00:23:06.327Z,1533082986.327 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-08-01T00:23:06.327Z,1533082986.327 [Default:CheckIn:C.Wait] Stopped
2018-08-01T00:23:06.328Z,1533082986.328 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-08-01T00:23:06.328Z,1533082986.328 [Default:CheckIn:D] Running Loop=1
2018-08-01T00:23:06.728Z,1533082986.728 [Default:CheckIn:D] Stopped
2018-08-01T00:23:06.729Z,1533082986.729 [Default:CheckIn:E] Running Loop=1
2018-08-01T00:23:07.165Z,1533082987.165 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.323714 min 
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn:E] Stopped
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn] Stopped
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn](INFO): Running loop #4
2018-08-01T00:23:07.166Z,1533082987.166 [Default:CheckIn] Running Loop=4
2018-08-01T00:23:07.167Z,1533082987.167 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-08-01T00:23:07.167Z,1533082987.167 [Default:CheckIn:Read_GPS] Running Loop=1
2018-08-01T00:23:07.886Z,1533082987.886 [NAL9602](INFO): Powering up
2018-08-01T00:23:19.090Z,1533082999.090 [NAL9602](INFO): NAL9602 initialized
2018-08-01T00:23:47.900Z,1533083027.900 [NAL9602](INFO): SBD MO Status=2, MOMSN=677, MT Status=2, MTMSN=0
2018-08-01T00:23:47.900Z,1533083027.900 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-08-01T00:23:56.288Z,1533083036.288 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=677, MT Status=1, MTMSN=29
2018-08-01T00:23:56.288Z,1533083036.288 [NAL9602](INFO): Data available in MT queue
2018-08-01T00:23:56.777Z,1533083036.777 [NAL9602](INFO): Received command:restart app
2018-08-01T00:23:56.853Z,1533083036.853 [CommandLine](IMPORTANT): got command restart application
2018-08-01T00:23:57.860Z,1533083037.860 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-01T00:23:57.868Z,1533083037.868 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:57.889Z,1533083037.889 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-08-01T00:23:57.889Z,1533083037.889 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:57.890Z,1533083037.890 [CommandLine](INFO): Join timeout helper Thread ID is 2303
2018-08-01T00:23:57.895Z,1533083037.895 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-08-01T00:23:57.895Z,1533083037.895 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:57.896Z,1533083037.896 [NavChartDb](INFO): Join timeout helper Thread ID is 2304
2018-08-01T00:23:58.053Z,1533083038.053 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-01T00:23:58.053Z,1533083038.053 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.057Z,1533083038.057 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-08-01T00:23:58.057Z,1533083038.057 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.057Z,1533083038.057 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2305
2018-08-01T00:23:58.197Z,1533083038.197 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-01T00:23:58.197Z,1533083038.197 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.221Z,1533083038.221 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-08-01T00:23:58.221Z,1533083038.221 [logger ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.221Z,1533083038.221 [logger](INFO): Join timeout helper Thread ID is 2306
2018-08-01T00:23:58.227Z,1533083038.227 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-01T00:23:58.227Z,1533083038.227 [logger ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.245Z,1533083038.245 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-08-01T00:23:58.245Z,1533083038.245 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.245Z,1533083038.245 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-08-01T00:23:58.245Z,1533083038.245 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.246Z,1533083038.246 [controlThread](INFO): Join timeout helper Thread ID is 2307
2018-08-01T00:23:58.269Z,1533083038.269 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-08-01T00:23:58.269Z,1533083038.269 [controlThread](DEBUG): Uninitializing ControlThread
2018-08-01T00:23:58.270Z,1533083038.270 [Aanderaa_O2](INFO): Powering down
2018-08-01T00:23:58.271Z,1533083038.271 [AHRS_M2](INFO): Powering down
2018-08-01T00:23:58.342Z,1533083038.342 [NAL9602](INFO): Powering down
2018-08-01T00:23:58.413Z,1533083038.413 [RDI_Pathfinder](INFO): Powering down
2018-08-01T00:23:58.415Z,1533083038.415 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-08-01T00:23:58.416Z,1533083038.416 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-08-01T00:23:58.416Z,1533083038.416 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-08-01T00:23:58.417Z,1533083038.417 [MissionManager](INFO): Uninitializing Mission Default
2018-08-01T00:23:58.417Z,1533083038.417 [Default] Stopped
2018-08-01T00:23:58.417Z,1533083038.417 [Default](DEBUG): Aggregate::uninitialize Default
2018-08-01T00:23:58.418Z,1533083038.418 [Default:B.GoToSurface] Stopped
2018-08-01T00:23:58.418Z,1533083038.418 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-08-01T00:23:58.418Z,1533083038.418 [Default:CheckIn] Stopped
2018-08-01T00:23:58.418Z,1533083038.418 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-08-01T00:23:58.418Z,1533083038.418 [Default:CheckIn:Read_GPS] Stopped
2018-08-01T00:23:58.421Z,1533083038.421 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-08-01T00:23:58.422Z,1533083038.422 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-08-01T00:23:58.422Z,1533083038.422 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-08-01T00:23:58.422Z,1533083038.422 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-08-01T00:23:58.423Z,1533083038.423 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-08-01T00:23:58.423Z,1533083038.423 [BuoyancyServo](INFO): Powering down
2018-08-01T00:23:58.437Z,1533083038.437 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-08-01T00:23:58.437Z,1533083038.437 [ElevatorServo](INFO): Powering down
2018-08-01T00:23:58.438Z,1533083038.438 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-08-01T00:23:58.438Z,1533083038.438 [MassServo](INFO): Powering down
2018-08-01T00:23:58.439Z,1533083038.439 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-08-01T00:23:58.439Z,1533083038.439 [RudderServo](INFO): Powering down
2018-08-01T00:23:58.440Z,1533083038.440 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-08-01T00:23:58.440Z,1533083038.440 [ThrusterServo](INFO): Powering down
2018-08-01T00:23:58.441Z,1533083038.441 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-08-01T00:23:58.441Z,1533083038.441 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-08-01T00:23:58.442Z,1533083038.442 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-08-01T00:23:58.443Z,1533083038.443 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.493Z,1533083038.493 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.590Z,1533083038.590 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-08-01T00:23:58.656Z,1533083038.656 [logger ThreadHandler](INFO): Thread cancelled.