2021-11-02T20:27:51.478Z,1635884871.478 [DataOverHttps](INFO): Received command: restart logs
2021-11-02T20:27:51.496Z,1635884871.496 [CommandExec](IMPORTANT): got command restart logs
2021-11-02T20:28:37.082Z,1635884917.082 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2021-11-02T20:28:37.082Z,1635884917.082 [RDI_Pathfinder] Communications Fault, FailCount= 1
2021-11-02T20:28:37.082Z,1635884917.082 [RDI_Pathfinder](ERROR): Communications Fault
2021-11-02T20:28:37.128Z,1635884917.128 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2021-11-02T20:28:37.519Z,1635884917.519 [RDI_Pathfinder](INFO): Powering down
2021-11-02T20:28:38.285Z,1635884918.285 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2021-11-02T20:28:38.285Z,1635884918.285 [RDI_Pathfinder] No Fault, FailCount= 1
2021-11-02T20:29:12.701Z,1635884952.701 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:29:12.701Z,1635884952.701 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:29:12.702Z,1635884952.702 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:29:12.707Z,1635884952.707 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:29:13.052Z,1635884953.052 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:29:13.052Z,1635884953.052 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:29:13.415Z,1635884953.415 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 26.233295 min 
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #5
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=5
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:29:13.416Z,1635884953.416 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:29:15.426Z,1635884955.426 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202914.00,A,4133.50647,N,07041.61446,W,0.641,16.40,021121,,,A*47
2021-11-02T20:29:15.429Z,1635884955.429 [NAL9602](INFO): GPS fix at 20211102T202914: (41.558441, -70.693574)
2021-11-02T20:29:15.477Z,1635884955.477 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:29:15.477Z,1635884955.477 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:29:19.839Z,1635884959.839 [DataOverHttps](INFO): Sending 53 bytes from file Logs/20211102T185435/Courier0030.lzma
2021-11-02T20:29:20.840Z,1635884960.840 [DataOverHttps](INFO): Moved sent file to Logs/20211102T185435/Courier0030.lzma.bak
2021-11-02T20:29:20.840Z,1635884960.840 [DataOverHttps](INFO): SBD MOMSN=595537
2021-11-02T20:29:29.879Z,1635884969.879 [DataOverHttps](INFO): Sending 260 bytes from file Logs/20211102T202751/Courier0000.lzma
2021-11-02T20:29:30.880Z,1635884970.880 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0000.lzma.bak
2021-11-02T20:29:30.880Z,1635884970.880 [DataOverHttps](INFO): SBD MOMSN=595539
2021-11-02T20:29:32.577Z,1635884972.577 [NAL9602](INFO): SBD MO Status=0, MOMSN=28027, MT Status=0, MTMSN=0
2021-11-02T20:29:32.577Z,1635884972.577 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:29:37.049Z,1635884977.049 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2021-11-02T20:29:39.942Z,1635884979.942 [DataOverHttps](INFO): Sending 53 bytes from file Logs/20211102T202751/Courier0003.lzma
2021-11-02T20:29:40.948Z,1635884980.948 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0003.lzma.bak
2021-11-02T20:29:40.948Z,1635884980.948 [DataOverHttps](INFO): SBD MOMSN=595543
2021-11-02T20:29:50.018Z,1635884990.018 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20211102T185435/Express0031.lzma
2021-11-02T20:29:51.020Z,1635884991.020 [DataOverHttps](INFO): Moved sent file to Logs/20211102T185435/Express0031.lzma.bak
2021-11-02T20:29:51.020Z,1635884991.020 [DataOverHttps](INFO): SBD MOMSN=595545
2021-11-02T20:30:00.059Z,1635885000.059 [DataOverHttps](INFO): Sending 398 bytes from file Logs/20211102T202751/Express0001.lzma
2021-11-02T20:30:01.060Z,1635885001.060 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0001.lzma.bak
2021-11-02T20:30:01.060Z,1635885001.060 [DataOverHttps](INFO): SBD MOMSN=595549
2021-11-02T20:30:03.358Z,1635885003.358 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:30:10.099Z,1635885010.099 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20211102T202751/Express0004.lzma
2021-11-02T20:30:11.100Z,1635885011.100 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0004.lzma.bak
2021-11-02T20:30:11.100Z,1635885011.100 [DataOverHttps](INFO): SBD MOMSN=595553
2021-11-02T20:30:12.683Z,1635885012.683 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:30:12.684Z,1635885012.684 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:30:12.684Z,1635885012.684 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:31:07.186Z,1635885067.186 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-11-02T20:31:07.188Z,1635885067.188 [BPC1](INFO): Received data from all battery sticks.
2021-11-02T20:32:12.257Z,1635885132.257 [Micromodem](INFO): Nmea in: $CAMSG,BAD_CRC, Data Header,2*00

2021-11-02T20:32:12.262Z,1635885132.262 [Micromodem](INFO): Nmea in: $CACST,6,1,20211102203209.012762,06,1168,24,0137,0150,149,02,02,01,02,3,-01,-01,2,3,1,0,150,4.3,6.99,13,-3.99,-01,-2.81,57,14500,4000*70

2021-11-02T20:35:13.279Z,1635885313.279 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:35:13.279Z,1635885313.279 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:35:13.279Z,1635885313.279 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:35:13.279Z,1635885313.279 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:35:13.687Z,1635885313.687 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:35:13.687Z,1635885313.687 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:35:14.107Z,1635885314.107 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 32.243882 min 
2021-11-02T20:35:14.107Z,1635885314.107 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:35:14.107Z,1635885314.107 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #6
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=6
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:35:14.108Z,1635885314.108 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:35:16.102Z,1635885316.102 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203515.00,A,4133.54211,N,07041.61532,W,0.389,149.49,021121,,,A*79
2021-11-02T20:35:16.105Z,1635885316.105 [NAL9602](INFO): GPS fix at 20211102T203515: (41.559035, -70.693589)
2021-11-02T20:35:16.136Z,1635885316.136 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:35:16.136Z,1635885316.136 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:35:20.359Z,1635885320.359 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20211102T202751/Courier0006.lzma
2021-11-02T20:35:21.360Z,1635885321.360 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0006.lzma.bak
2021-11-02T20:35:21.360Z,1635885321.360 [DataOverHttps](INFO): SBD MOMSN=595555
2021-11-02T20:35:30.398Z,1635885330.398 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20211102T202751/Express0007.lzma
2021-11-02T20:35:30.660Z,1635885330.660 [NAL9602](INFO): SBD MO Status=0, MOMSN=28028, MT Status=0, MTMSN=0
2021-11-02T20:35:30.660Z,1635885330.660 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:35:31.400Z,1635885331.400 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0007.lzma.bak
2021-11-02T20:35:31.400Z,1635885331.400 [DataOverHttps](INFO): SBD MOMSN=595559
2021-11-02T20:35:32.684Z,1635885332.684 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:35:32.684Z,1635885332.684 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:35:32.684Z,1635885332.684 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:35:35.095Z,1635885335.095 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T20:36:01.353Z,1635885361.353 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:36:27.232Z,1635885387.232 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2021-11-02T20:40:33.248Z,1635885633.248 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:40:33.248Z,1635885633.248 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:40:33.248Z,1635885633.248 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:40:33.249Z,1635885633.249 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:40:33.693Z,1635885633.693 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:40:33.693Z,1635885633.693 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:40:34.064Z,1635885634.064 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 37.577319 min 
2021-11-02T20:40:34.064Z,1635885634.064 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #7
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=7
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:40:34.065Z,1635885634.065 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:40:36.084Z,1635885636.084 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204035.00,A,4133.57556,N,07041.61683,W,0.719,6.46,021121,,,A*7F
2021-11-02T20:40:36.086Z,1635885636.086 [NAL9602](INFO): GPS fix at 20211102T204035: (41.559593, -70.693614)
2021-11-02T20:40:36.098Z,1635885636.098 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:40:36.098Z,1635885636.098 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:40:39.666Z,1635885639.666 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211102T202751/Courier0009.lzma
2021-11-02T20:40:40.668Z,1635885640.668 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0009.lzma.bak
2021-11-02T20:40:40.668Z,1635885640.668 [DataOverHttps](INFO): SBD MOMSN=595563
2021-11-02T20:40:49.710Z,1635885649.710 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20211102T202751/Express0010.lzma
2021-11-02T20:40:50.336Z,1635885650.336 [NAL9602](INFO): SBD MO Status=0, MOMSN=28029, MT Status=0, MTMSN=0
2021-11-02T20:40:50.336Z,1635885650.336 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:40:50.712Z,1635885650.712 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0010.lzma.bak
2021-11-02T20:40:50.712Z,1635885650.712 [DataOverHttps](INFO): SBD MOMSN=595566
2021-11-02T20:40:51.970Z,1635885651.970 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:40:51.970Z,1635885651.970 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:40:51.970Z,1635885651.970 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:41:21.028Z,1635885681.028 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:45:52.548Z,1635885952.548 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:45:52.548Z,1635885952.548 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:45:52.548Z,1635885952.548 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:45:52.548Z,1635885952.548 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:45:52.968Z,1635885952.968 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:45:52.968Z,1635885952.968 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:45:53.354Z,1635885953.354 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 42.898572 min 
2021-11-02T20:45:53.354Z,1635885953.354 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #8
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=8
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:45:53.355Z,1635885953.355 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:45:55.363Z,1635885955.363 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204554.00,A,4133.60181,N,07041.61866,W,0.583,323.94,021121,,,A*78
2021-11-02T20:45:55.366Z,1635885955.366 [NAL9602](INFO): GPS fix at 20211102T204554: (41.560030, -70.693644)
2021-11-02T20:45:55.377Z,1635885955.377 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:45:55.377Z,1635885955.377 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:45:58.983Z,1635885958.983 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211102T202751/Courier0012.lzma
2021-11-02T20:45:59.984Z,1635885959.984 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0012.lzma.bak
2021-11-02T20:45:59.984Z,1635885959.984 [DataOverHttps](INFO): SBD MOMSN=595570
2021-11-02T20:46:09.022Z,1635885969.022 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20211102T202751/Express0013.lzma
2021-11-02T20:46:10.024Z,1635885970.024 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0013.lzma.bak
2021-11-02T20:46:10.024Z,1635885970.024 [DataOverHttps](INFO): SBD MOMSN=595573
2021-11-02T20:46:11.179Z,1635885971.179 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:46:11.179Z,1635885971.179 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:46:11.179Z,1635885971.179 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:46:21.623Z,1635885981.623 [NAL9602](INFO): SBD MO Status=0, MOMSN=28030, MT Status=0, MTMSN=0
2021-11-02T20:46:21.623Z,1635885981.623 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:46:52.319Z,1635886012.319 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:47:12.521Z,1635886032.521 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,204712,CO0*79
 expected 7D
2021-11-02T20:48:13.158Z,1635886093.158 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2021-11-02T20:48:13.158Z,1635886093.158 [RDI_Pathfinder] Communications Fault, FailCount= 1
2021-11-02T20:48:13.158Z,1635886093.158 [RDI_Pathfinder](ERROR): Communications Fault
2021-11-02T20:48:13.212Z,1635886093.212 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2021-11-02T20:48:13.590Z,1635886093.590 [RDI_Pathfinder](INFO): Powering down
2021-11-02T20:48:14.349Z,1635886094.349 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2021-11-02T20:48:14.349Z,1635886094.349 [RDI_Pathfinder] No Fault, FailCount= 1
2021-11-02T20:48:32.931Z,1635886112.931 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2021-11-02T20:50:49.869Z,1635886249.869 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2021-11-02T20:51:11.696Z,1635886271.696 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:51:11.696Z,1635886271.696 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:51:11.697Z,1635886271.697 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:51:11.697Z,1635886271.697 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:51:12.117Z,1635886272.117 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:51:12.117Z,1635886272.117 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:51:12.504Z,1635886272.504 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 48.217712 min 
2021-11-02T20:51:12.504Z,1635886272.504 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #9
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=9
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:51:12.505Z,1635886272.505 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:51:14.511Z,1635886274.511 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205113.00,A,4133.62563,N,07041.62141,W,0.292,17.38,021121,,,A*4E
2021-11-02T20:51:14.513Z,1635886274.513 [NAL9602](INFO): GPS fix at 20211102T205113: (41.560427, -70.693690)
2021-11-02T20:51:14.556Z,1635886274.556 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:51:14.556Z,1635886274.556 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:51:18.298Z,1635886278.298 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20211102T202751/Courier0015.lzma
2021-11-02T20:51:19.300Z,1635886279.300 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0015.lzma.bak
2021-11-02T20:51:19.300Z,1635886279.300 [DataOverHttps](INFO): SBD MOMSN=595577
2021-11-02T20:51:27.060Z,1635886287.060 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T20:51:28.339Z,1635886288.339 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20211102T202751/Express0016.lzma
2021-11-02T20:51:28.659Z,1635886288.659 [NAL9602](INFO): SBD MO Status=0, MOMSN=28031, MT Status=0, MTMSN=0
2021-11-02T20:51:28.660Z,1635886288.660 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:51:29.340Z,1635886289.340 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0016.lzma.bak
2021-11-02T20:51:29.340Z,1635886289.340 [DataOverHttps](INFO): SBD MOMSN=595580
2021-11-02T20:51:30.679Z,1635886290.679 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:51:30.679Z,1635886290.679 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:51:30.679Z,1635886290.679 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:51:59.360Z,1635886319.360 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:54:41.017Z,1635886481.017 [CBIT](IMPORTANT): Beginning ground fault scan
2021-11-02T20:54:51.900Z,1635886491.900 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.141241
CHAN A1 (24V): 0.291411
CHAN A2 (12V): 0.138905
CHAN A3 (5V): 0.042219
CHAN B0 (3.3V): 0.023112
CHAN B1 (3.15aV): 0.015887
CHAN B2 (3.15bV): 0.014014
CHAN B3 (GND): 0.000429
OPEN: 0.007107
Full Scale: +/- 1 mA
2021-11-02T20:55:53.270Z,1635886553.270 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T20:56:31.277Z,1635886591.277 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T20:56:31.278Z,1635886591.278 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T20:56:31.278Z,1635886591.278 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T20:56:31.294Z,1635886591.294 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T20:56:31.663Z,1635886591.663 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T20:56:31.664Z,1635886591.664 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T20:56:32.106Z,1635886592.106 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 53.543490 min 
2021-11-02T20:56:32.106Z,1635886592.106 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T20:56:32.106Z,1635886592.106 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #10
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=10
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T20:56:32.107Z,1635886592.107 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T20:56:34.079Z,1635886594.079 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205633.00,A,4133.64729,N,07041.62658,W,0.680,295.57,021121,,,A*78
2021-11-02T20:56:34.081Z,1635886594.081 [NAL9602](INFO): GPS fix at 20211102T205633: (41.560788, -70.693776)
2021-11-02T20:56:34.092Z,1635886594.092 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T20:56:34.092Z,1635886594.092 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T20:56:37.615Z,1635886597.615 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20211102T202751/Courier0018.lzma
2021-11-02T20:56:38.616Z,1635886598.616 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0018.lzma.bak
2021-11-02T20:56:38.616Z,1635886598.616 [DataOverHttps](INFO): SBD MOMSN=595584
2021-11-02T20:56:43.474Z,1635886603.474 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout
2021-11-02T20:56:43.474Z,1635886603.474 [RDI_PathfinderUp] Communications Fault, FailCount= 1
2021-11-02T20:56:43.474Z,1635886603.474 [RDI_PathfinderUp](ERROR): Communications Fault
2021-11-02T20:56:43.515Z,1635886603.515 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp
2021-11-02T20:56:43.930Z,1635886603.930 [RDI_PathfinderUp](INFO): Powering down
2021-11-02T20:56:44.705Z,1635886604.705 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp
2021-11-02T20:56:44.705Z,1635886604.705 [RDI_PathfinderUp] No Fault, FailCount= 1
2021-11-02T20:56:47.655Z,1635886607.655 [DataOverHttps](INFO): Sending 332 bytes from file Logs/20211102T202751/Express0019.lzma
2021-11-02T20:56:48.660Z,1635886608.660 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0019.lzma.bak
2021-11-02T20:56:48.660Z,1635886608.660 [DataOverHttps](INFO): SBD MOMSN=595587
2021-11-02T20:56:49.927Z,1635886609.927 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T20:56:49.927Z,1635886609.927 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T20:56:49.927Z,1635886609.927 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T20:57:12.142Z,1635886632.142 [NAL9602](INFO): SBD MO Status=0, MOMSN=28032, MT Status=0, MTMSN=0
2021-11-02T20:57:12.142Z,1635886632.142 [NAL9602](INFO): No messages in MT queue
2021-11-02T20:57:42.879Z,1635886662.879 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T20:58:49.111Z,1635886729.111 [Micromodem](INFO): Nmea in: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error

2021-11-02T20:58:49.112Z,1635886729.112 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error
 expected 41
2021-11-02T20:58:49.113Z,1635886729.113 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31

2021-11-02T20:58:49.508Z,1635886729.508 [Micromodem](INFO): Nmea in: $CACST,6,1,20211102205847.043439,06,525,21,0090,0150,156,01,01,01,01,-1,-01,-01,1,3,3,0,150,65.6,5.96,-100,-2.96,-01,2.99,-6,14500,4000*7A

2021-11-02T21:01:50.542Z,1635886910.542 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T21:01:50.542Z,1635886910.542 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T21:01:50.542Z,1635886910.542 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T21:01:50.543Z,1635886910.543 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T21:01:50.946Z,1635886910.946 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T21:01:50.946Z,1635886910.946 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T21:01:51.329Z,1635886911.329 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 58.864872 min 
2021-11-02T21:01:51.329Z,1635886911.329 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T21:01:51.329Z,1635886911.329 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:01:51.329Z,1635886911.329 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T21:01:51.330Z,1635886911.330 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:01:51.330Z,1635886911.330 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #11
2021-11-02T21:01:51.331Z,1635886911.331 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=11
2021-11-02T21:01:51.331Z,1635886911.331 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:01:51.331Z,1635886911.331 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T21:01:53.336Z,1635886913.336 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210152.00,A,4133.66932,N,07041.63080,W,0.952,268.06,021121,,,A*7E
2021-11-02T21:01:53.338Z,1635886913.338 [NAL9602](INFO): GPS fix at 20211102T210152: (41.561155, -70.693847)
2021-11-02T21:01:53.349Z,1635886913.349 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T21:01:53.349Z,1635886913.349 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T21:01:56.966Z,1635886916.966 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20211102T202751/Courier0021.lzma
2021-11-02T21:01:57.968Z,1635886917.968 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0021.lzma.bak
2021-11-02T21:01:57.968Z,1635886917.968 [DataOverHttps](INFO): SBD MOMSN=595593
2021-11-02T21:02:06.707Z,1635886926.707 [NAL9602](INFO): SBD MO Status=0, MOMSN=28033, MT Status=0, MTMSN=0
2021-11-02T21:02:06.707Z,1635886926.707 [NAL9602](INFO): No messages in MT queue
2021-11-02T21:02:07.006Z,1635886927.006 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20211102T202751/Express0022.lzma
2021-11-02T21:02:08.008Z,1635886928.008 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0022.lzma.bak
2021-11-02T21:02:08.008Z,1635886928.008 [DataOverHttps](INFO): SBD MOMSN=595596
2021-11-02T21:02:09.166Z,1635886929.166 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T21:02:09.167Z,1635886929.167 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T21:02:09.167Z,1635886929.167 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T21:02:37.440Z,1635886957.440 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T21:05:38.905Z,1635887138.905 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T21:07:09.720Z,1635887229.720 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T21:07:09.720Z,1635887229.720 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T21:07:09.720Z,1635887229.720 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T21:07:09.721Z,1635887229.721 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T21:07:10.141Z,1635887230.141 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T21:07:10.141Z,1635887230.141 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T21:07:10.531Z,1635887230.531 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 64.184786 min 
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #12
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=12
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:07:10.532Z,1635887230.532 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T21:07:12.531Z,1635887232.531 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210711.00,A,4133.69247,N,07041.63913,W,0.175,315.14,021121,,,A*7F
2021-11-02T21:07:12.533Z,1635887232.533 [NAL9602](INFO): GPS fix at 20211102T210711: (41.561541, -70.693985)
2021-11-02T21:07:12.555Z,1635887232.555 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T21:07:12.555Z,1635887232.555 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T21:07:16.298Z,1635887236.298 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20211102T202751/Courier0024.lzma
2021-11-02T21:07:17.300Z,1635887237.300 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0024.lzma.bak
2021-11-02T21:07:17.300Z,1635887237.300 [DataOverHttps](INFO): SBD MOMSN=595600
2021-11-02T21:07:26.338Z,1635887246.338 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20211102T202751/Express0025.lzma
2021-11-02T21:07:27.340Z,1635887247.340 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0025.lzma.bak
2021-11-02T21:07:27.340Z,1635887247.340 [DataOverHttps](INFO): SBD MOMSN=595603
2021-11-02T21:07:28.691Z,1635887248.691 [NAL9602](INFO): SBD MO Status=0, MOMSN=28034, MT Status=0, MTMSN=0
2021-11-02T21:07:28.691Z,1635887248.691 [NAL9602](INFO): No messages in MT queue
2021-11-02T21:07:28.702Z,1635887248.702 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T21:07:28.702Z,1635887248.702 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T21:07:28.702Z,1635887248.702 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T21:07:48.937Z,1635887268.937 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2021-11-02T21:07:59.046Z,1635887279.046 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2021-11-02T21:07:59.432Z,1635887279.432 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T21:08:02.696Z,1635887282.696 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2021-11-02T21:08:03.882Z,1635887283.882 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T21:08:28.952Z,1635887308.952 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2021-11-02T21:08:49.145Z,1635887329.145 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2021-11-02T21:12:00.256Z,1635887520.256 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-11-02T21:12:07.120Z,1635887527.120 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2021-11-02T21:12:29.337Z,1635887549.337 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-02T21:12:29.337Z,1635887549.337 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T21:12:29.337Z,1635887549.337 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T21:12:29.337Z,1635887549.337 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-11-02T21:12:29.718Z,1635887549.718 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-11-02T21:12:29.719Z,1635887549.719 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-11-02T21:12:30.126Z,1635887550.126 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 69.511076 min 
2021-11-02T21:12:30.126Z,1635887550.126 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #13
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=13
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:12:30.127Z,1635887550.127 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-11-02T21:12:32.135Z,1635887552.135 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211231.00,A,4133.71312,N,07041.64356,W,0.292,338.72,021121,,,A*78
2021-11-02T21:12:32.137Z,1635887552.137 [NAL9602](INFO): GPS fix at 20211102T211231: (41.561885, -70.694059)
2021-11-02T21:12:32.148Z,1635887552.148 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-11-02T21:12:32.148Z,1635887552.148 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-11-02T21:12:35.605Z,1635887555.605 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211102T202751/Courier0027.lzma
2021-11-02T21:12:36.608Z,1635887556.608 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Courier0027.lzma.bak
2021-11-02T21:12:36.608Z,1635887556.608 [DataOverHttps](INFO): SBD MOMSN=595606
2021-11-02T21:12:45.646Z,1635887565.646 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20211102T202751/Express0028.lzma
2021-11-02T21:12:46.648Z,1635887566.648 [DataOverHttps](INFO): Moved sent file to Logs/20211102T202751/Express0028.lzma.bak
2021-11-02T21:12:46.648Z,1635887566.648 [DataOverHttps](INFO): SBD MOMSN=595609
2021-11-02T21:12:46.823Z,1635887566.823 [NAL9602](INFO): SBD MO Status=0, MOMSN=28035, MT Status=0, MTMSN=0
2021-11-02T21:12:46.824Z,1635887566.824 [NAL9602](INFO): No messages in MT queue
2021-11-02T21:12:48.015Z,1635887568.015 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-11-02T21:12:48.015Z,1635887568.015 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-11-02T21:12:48.016Z,1635887568.016 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-02T21:13:17.492Z,1635887597.492 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-02T21:14:01.976Z,1635887641.976 [DataOverHttps](IMPORTANT): SBD MTMSN=20211102T211401
2021-11-02T21:14:05.994Z,1635887645.994 [DataOverHttps](INFO): Received command: restart app
2021-11-02T21:14:06.040Z,1635887646.040 [CommandExec](IMPORTANT): got command restart application
2021-11-02T21:14:07.042Z,1635887647.042 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2021-11-02T21:14:07.043Z,1635887647.043 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:07.043Z,1635887647.043 [CommandExec](INFO): Uninitializing the command executive.
2021-11-02T21:14:07.043Z,1635887647.043 [CommandExec](INFO): Uninitializing the command scheduler.
2021-11-02T21:14:07.043Z,1635887647.043 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.150Z,1635887647.150 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-11-02T21:14:07.151Z,1635887647.151 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-11-02T21:14:07.151Z,1635887647.151 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.153Z,1635887647.153 [NavChartDb](INFO): Join timeout helper Thread ID is 3804
2021-11-02T21:14:07.314Z,1635887647.314 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:07.315Z,1635887647.315 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.322Z,1635887647.322 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2021-11-02T21:14:07.322Z,1635887647.322 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.323Z,1635887647.323 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 3805
2021-11-02T21:14:07.722Z,1635887647.722 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:07.722Z,1635887647.722 [WetLabsSeaOWL_UV_A](INFO): Powering down
2021-11-02T21:14:07.723Z,1635887647.723 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.738Z,1635887647.738 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-11-02T21:14:07.738Z,1635887647.738 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:07.738Z,1635887647.738 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3806
2021-11-02T21:14:08.022Z,1635887648.022 [CTD_Seabird](INFO): Powering down
2021-11-02T21:14:08.034Z,1635887648.034 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:08.034Z,1635887648.034 [CTD_Seabird](INFO): Powering down
2021-11-02T21:14:08.046Z,1635887648.046 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:08.062Z,1635887648.062 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-11-02T21:14:08.062Z,1635887648.062 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:08.063Z,1635887648.063 [Radio_Surface](INFO): Join timeout helper Thread ID is 3807
2021-11-02T21:14:08.126Z,1635887648.126 [Radio_Surface](INFO): Powering down
2021-11-02T21:14:08.127Z,1635887648.127 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:08.127Z,1635887648.127 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:08.138Z,1635887648.138 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-11-02T21:14:08.139Z,1635887648.139 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:08.140Z,1635887648.140 [Onboard](INFO): Join timeout helper Thread ID is 3808
2021-11-02T21:14:09.002Z,1635887649.002 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2021-11-02T21:14:09.074Z,1635887649.074 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:09.074Z,1635887649.074 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:09.091Z,1635887649.091 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-11-02T21:14:09.091Z,1635887649.091 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:09.091Z,1635887649.091 [DataOverHttps](INFO): Join timeout helper Thread ID is 3809
2021-11-02T21:14:10.006Z,1635887650.006 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:10.007Z,1635887650.007 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.015Z,1635887650.015 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2021-11-02T21:14:10.015Z,1635887650.015 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.015Z,1635887650.015 [BackseatComponent](INFO): Join timeout helper Thread ID is 3810
2021-11-02T21:14:10.126Z,1635887650.126 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:10.126Z,1635887650.126 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.135Z,1635887650.135 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-11-02T21:14:10.135Z,1635887650.135 [logger ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.135Z,1635887650.135 [logger](INFO): Join timeout helper Thread ID is 3811
2021-11-02T21:14:10.154Z,1635887650.154 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:10.154Z,1635887650.154 [logger ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.167Z,1635887650.167 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-11-02T21:14:10.167Z,1635887650.167 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.167Z,1635887650.167 [CommandLine](INFO): Join timeout helper Thread ID is 3812
2021-11-02T21:14:10.170Z,1635887650.170 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:10.171Z,1635887650.171 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.187Z,1635887650.187 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2021-11-02T21:14:10.187Z,1635887650.187 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.187Z,1635887650.187 [CommandExec](INFO): Join timeout helper Thread ID is 3813
2021-11-02T21:14:10.188Z,1635887650.188 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-11-02T21:14:10.188Z,1635887650.188 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.189Z,1635887650.189 [controlThread](INFO): Join timeout helper Thread ID is 3814
2021-11-02T21:14:10.367Z,1635887650.367 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-02T21:14:10.368Z,1635887650.368 [controlThread](DEBUG): Uninitializing ControlThread
2021-11-02T21:14:10.370Z,1635887650.370 [AHRS_M2](INFO): Powering down
2021-11-02T21:14:10.443Z,1635887650.443 [DDM](INFO): Powering down
2021-11-02T21:14:10.515Z,1635887650.515 [DUSBL_Hydroid](INFO): Powering down
2021-11-02T21:14:10.586Z,1635887650.586 [Micromodem](INFO): Powering down
2021-11-02T21:14:10.682Z,1635887650.682 [NAL9602](INFO): Powering down
2021-11-02T21:14:10.754Z,1635887650.754 [RDI_Pathfinder](INFO): Powering down
2021-11-02T21:14:10.826Z,1635887650.826 [RDI_PathfinderUp](INFO): Powering down
2021-11-02T21:14:10.827Z,1635887650.827 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-11-02T21:14:10.828Z,1635887650.828 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-11-02T21:14:10.829Z,1635887650.829 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-11-02T21:14:10.830Z,1635887650.830 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock] Stopped
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock:SurfaceDefault] Stopped
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-11-02T21:14:10.830Z,1635887650.830 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-11-02T21:14:10.831Z,1635887650.831 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-11-02T21:14:10.831Z,1635887650.831 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-11-02T21:14:10.831Z,1635887650.831 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-02T21:14:10.839Z,1635887650.839 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-11-02T21:14:10.840Z,1635887650.840 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-11-02T21:14:10.840Z,1635887650.840 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-11-02T21:14:10.840Z,1635887650.840 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-11-02T21:14:10.840Z,1635887650.840 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-11-02T21:14:10.841Z,1635887650.841 [BuoyancyServo](INFO): Powering down
2021-11-02T21:14:10.854Z,1635887650.854 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-11-02T21:14:10.854Z,1635887650.854 [ElevatorServo](INFO): Powering down
2021-11-02T21:14:10.855Z,1635887650.855 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-11-02T21:14:10.855Z,1635887650.855 [MassServo](INFO): Powering down
2021-11-02T21:14:10.856Z,1635887650.856 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-11-02T21:14:10.856Z,1635887650.856 [RudderServo](INFO): Powering down
2021-11-02T21:14:10.857Z,1635887650.857 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2021-11-02T21:14:10.857Z,1635887650.857 [ThrusterHE](INFO): Powering down
2021-11-02T21:14:10.858Z,1635887650.858 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-11-02T21:14:10.859Z,1635887650.859 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-11-02T21:14:10.859Z,1635887650.859 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-11-02T21:14:10.859Z,1635887650.859 [CBIT](DEBUG): Powering off loads.
2021-11-02T21:14:10.870Z,1635887650.870 [CBIT](DEBUG): Disabling WDT.
2021-11-02T21:14:10.882Z,1635887650.882 [CBIT](DEBUG): Opening all GF detection circuits.
2021-11-02T21:14:10.883Z,1635887650.883 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.892Z,1635887650.892 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.896Z,1635887650.896 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.907Z,1635887650.907 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:10.951Z,1635887650.951 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:11.004Z,1635887651.004 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:11.007Z,1635887651.007 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:11.076Z,1635887651.076 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-02T21:14:11.149Z,1635887651.149 [logger ThreadHandler](INFO): Thread cancelled.