2023-04-20T19:06:50.423Z,1682017610.423 [CommandExec](IMPORTANT): got command restart logs
2023-04-20T19:07:55.460Z,1682017675.460 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-04-20T19:07:55.461Z,1682017675.461 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+11.6,489.0,000
2023-04-20T19:08:25.233Z,1682017705.233 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:08:28.245Z,1682017708.245 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239174
2023-04-20T19:09:39.293Z,1682017779.293 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:09:39.293Z,1682017779.293 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:09:39.294Z,1682017779.294 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:09:39.294Z,1682017779.294 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:09:39.696Z,1682017779.696 [Default:CheckIn:D] Stopped
2023-04-20T19:09:39.696Z,1682017779.696 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:09:40.110Z,1682017780.110 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.439669 min 
2023-04-20T19:09:40.110Z,1682017780.110 [Default:CheckIn:E] Stopped
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn] Stopped
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn](INFO): Running loop #8
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn] Running Loop=8
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:09:40.111Z,1682017780.111 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:09:42.110Z,1682017782.110 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190942.00,A,3648.25487,N,12148.91042,W,1.108,92.62,200423,,,A*4E
2023-04-20T19:09:42.112Z,1682017782.112 [NAL9602](INFO): GPS fix at 20230420T190942: (36.804248, -121.815174)
2023-04-20T19:09:42.140Z,1682017782.140 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:09:42.140Z,1682017782.140 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:10:11.105Z,1682017811.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:10:11.651Z,1682017811.651 [NAL9602](INFO): SBD MO Status=2, MOMSN=16076, MT Status=2, MTMSN=0
2023-04-20T19:10:11.651Z,1682017811.651 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:10:44.441Z,1682017844.441 [NAL9602](INFO): SBD MO Status=2, MOMSN=16076, MT Status=2, MTMSN=0
2023-04-20T19:10:44.441Z,1682017844.441 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:10:46.245Z,1682017846.245 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:11:21.385Z,1682017881.385 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:11:56.541Z,1682017916.541 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:12:15.803Z,1682017935.803 [NAL9602](INFO): SBD MO Status=1, MOMSN=16076, MT Status=0, MTMSN=0
2023-04-20T19:12:15.857Z,1682017935.857 [NAL9602](INFO): Sent 39 bytes from file Logs/20230419T180648/Courier0144.lzma
2023-04-20T19:12:15.858Z,1682017935.858 [NAL9602](INFO): Packets left to send: 0
2023-04-20T19:12:31.689Z,1682017951.689 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:12:33.199Z,1682017953.199 [NAL9602](INFO): SBD MO Status=2, MOMSN=16077, MT Status=2, MTMSN=0
2023-04-20T19:12:33.199Z,1682017953.199 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:12:59.504Z,1682017979.504 [NAL9602](INFO): SBD MO Status=2, MOMSN=16077, MT Status=2, MTMSN=0
2023-04-20T19:12:59.504Z,1682017979.504 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:13:06.829Z,1682017986.829 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-04-20T19:13:25.006Z,1682018005.006 [NAL9602](INFO): SBD MO Status=1, MOMSN=16077, MT Status=0, MTMSN=0
2023-04-20T19:13:25.053Z,1682018005.053 [NAL9602](INFO): Sent 268 bytes from file Logs/20230420T190650/Courier0000.lzma
2023-04-20T19:13:25.053Z,1682018005.053 [NAL9602](INFO): Packets left to send: 0
2023-04-20T19:13:35.296Z,1682018015.296 [NAL9602](INFO): SBD MO Status=1, MOMSN=16078, MT Status=0, MTMSN=0
2023-04-20T19:13:35.349Z,1682018015.349 [NAL9602](INFO): Sent 104 bytes from file Logs/20230419T180648/Express0145.lzma
2023-04-20T19:13:35.349Z,1682018015.349 [NAL9602](INFO): Packets left to send: 0
2023-04-20T19:13:48.179Z,1682018028.179 [NAL9602](INFO): SBD MO Status=1, MOMSN=16079, MT Status=0, MTMSN=0
2023-04-20T19:13:48.229Z,1682018028.229 [NAL9602](INFO): Sent 332 bytes from file Logs/20230420T190650/Express0001.lzma
2023-04-20T19:13:48.229Z,1682018028.229 [NAL9602](INFO): Packets left to send: 1
2023-04-20T19:13:54.717Z,1682018034.717 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003060
2023-04-20T19:14:02.112Z,1682018042.112 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230420T190650/Courier0003.lzma
2023-04-20T19:14:03.114Z,1682018043.114 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0003.lzma.bak
2023-04-20T19:14:03.115Z,1682018043.115 [DataOverHttps](INFO): SBD MOMSN=18242131
2023-04-20T19:14:04.543Z,1682018044.543 [NAL9602](INFO): SBD MO Status=2, MOMSN=16080, MT Status=2, MTMSN=0
2023-04-20T19:14:04.544Z,1682018044.544 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:14:19.141Z,1682018059.141 [DataOverHttps](INFO): Sending 382 bytes from file Logs/20230420T190650/Express0001.lzma
2023-04-20T19:14:27.162Z,1682018067.162 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0001.lzma.bak
2023-04-20T19:14:27.163Z,1682018067.163 [DataOverHttps](INFO): SBD MOMSN=18242135
2023-04-20T19:14:35.250Z,1682018075.250 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:14:43.052Z,1682018083.052 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Express0004.lzma
2023-04-20T19:14:44.054Z,1682018084.054 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0004.lzma.bak
2023-04-20T19:14:44.055Z,1682018084.055 [DataOverHttps](INFO): SBD MOMSN=18242140
2023-04-20T19:14:45.766Z,1682018085.766 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:14:45.766Z,1682018085.766 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:14:45.767Z,1682018085.767 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:15:31.007Z,1682018131.007 [DVL_micro](ERROR): Failed to parse:
:000000000,35.0,+12.1,0000.0,148

2023-04-20T19:17:20.895Z,1682018240.895 [DVL_micro](ERROR): only read 3 of 4 data items
2023-04-20T19:17:20.895Z,1682018240.895 [DVL_micro](ERROR): Failed to parse:
:BI,+00040,+00088,-00193,+00BD,+0000000000000.00,+000,9999.99,:RD,+9999.99,+9999.99,+9999.99,+9999.99
2023-04-20T19:19:18.874Z,1682018358.874 [DVL_micro](ERROR): Failed to parse:
:R99,+9999.99,+9999.99,+9999.99
2023-04-20T19:19:46.337Z,1682018386.337 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:19:46.337Z,1682018386.337 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:19:46.338Z,1682018386.338 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:19:46.338Z,1682018386.338 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:19:46.800Z,1682018386.800 [Default:CheckIn:D] Stopped
2023-04-20T19:19:46.800Z,1682018386.800 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.558073 min 
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn:E] Stopped
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn] Stopped
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn](INFO): Running loop #9
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn] Running Loop=9
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:19:47.154Z,1682018387.154 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:19:49.154Z,1682018389.154 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191949.00,A,3648.19666,N,12147.16747,W,4.004,212.82,200423,,,A*78
2023-04-20T19:19:49.157Z,1682018389.157 [NAL9602](INFO): GPS fix at 20230420T191949: (36.803278, -121.786124)
2023-04-20T19:19:49.168Z,1682018389.168 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:19:49.168Z,1682018389.168 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:19:59.360Z,1682018399.360 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Courier0006.lzma
2023-04-20T19:20:00.363Z,1682018400.363 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0006.lzma.bak
2023-04-20T19:20:00.363Z,1682018400.363 [DataOverHttps](INFO): SBD MOMSN=18242151
2023-04-20T19:20:01.679Z,1682018401.679 [NAL9602](INFO): SBD MO Status=1, MOMSN=16080, MT Status=0, MTMSN=0
2023-04-20T19:20:01.680Z,1682018401.680 [NAL9602](INFO): No messages in MT queue
2023-04-20T19:20:16.245Z,1682018416.245 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20230420T190650/Express0007.lzma
2023-04-20T19:20:17.246Z,1682018417.246 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0007.lzma.bak
2023-04-20T19:20:17.247Z,1682018417.247 [DataOverHttps](INFO): SBD MOMSN=18242154
2023-04-20T19:20:18.662Z,1682018418.662 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:20:18.662Z,1682018418.662 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:20:18.662Z,1682018418.662 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:20:32.381Z,1682018432.381 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:22:46.524Z,1682018566.524 [DVL_micro](ERROR): only read 3 of 4 data items
2023-04-20T19:22:46.524Z,1682018566.524 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+

2023-04-20T19:22:54.199Z,1682018574.199 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-04-20T19:22:54.199Z,1682018574.199 [DVL_micro](ERROR): Failed to parse:
:TS,000000000000012.6,0000.0,1489.0,000
2023-04-20T19:25:19.244Z,1682018719.244 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:25:19.245Z,1682018719.245 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:25:19.245Z,1682018719.245 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:25:19.245Z,1682018719.245 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:25:19.648Z,1682018719.648 [Default:CheckIn:D] Stopped
2023-04-20T19:25:19.648Z,1682018719.648 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.105546 min 
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn:E] Stopped
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn] Stopped
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn](INFO): Running loop #10
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn] Running Loop=10
2023-04-20T19:25:20.068Z,1682018720.068 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:25:20.073Z,1682018720.073 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:25:22.059Z,1682018722.059 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192522.00,A,3648.14912,N,12147.22077,W,0.019,244.37,200423,,,D*78
2023-04-20T19:25:22.061Z,1682018722.061 [NAL9602](INFO): GPS fix at 20230420T192522: (36.802485, -121.787013)
2023-04-20T19:25:22.072Z,1682018722.072 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:25:22.073Z,1682018722.073 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:25:30.008Z,1682018730.008 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Courier0009.lzma
2023-04-20T19:25:31.010Z,1682018731.010 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0009.lzma.bak
2023-04-20T19:25:31.011Z,1682018731.011 [DataOverHttps](INFO): SBD MOMSN=18242169
2023-04-20T19:25:47.204Z,1682018747.204 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20230420T190650/Express0010.lzma
2023-04-20T19:25:48.206Z,1682018748.206 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0010.lzma.bak
2023-04-20T19:25:48.207Z,1682018748.207 [DataOverHttps](INFO): SBD MOMSN=18242172
2023-04-20T19:25:49.959Z,1682018749.959 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:25:49.959Z,1682018749.959 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:25:49.959Z,1682018749.959 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:25:53.984Z,1682018753.984 [DVL_micro](ERROR): Failed to parse:
:9,+00146,-00039,+00000,I
2023-04-20T19:26:35.588Z,1682018795.588 [NAL9602](INFO): SBD MO Status=2, MOMSN=16081, MT Status=2, MTMSN=0
2023-04-20T19:26:35.589Z,1682018795.589 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:26:53.771Z,1682018813.771 [NAL9602](INFO): SBD MO Status=1, MOMSN=16081, MT Status=0, MTMSN=0
2023-04-20T19:26:53.771Z,1682018813.771 [NAL9602](INFO): No messages in MT queue
2023-04-20T19:27:24.474Z,1682018844.474 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:30:50.553Z,1682019050.553 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:30:50.553Z,1682019050.553 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:30:50.553Z,1682019050.553 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:30:50.553Z,1682019050.553 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:30:50.944Z,1682019050.944 [Default:CheckIn:D] Stopped
2023-04-20T19:30:50.961Z,1682019050.961 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:30:51.337Z,1682019051.337 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.627144 min 
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn:E] Stopped
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn] Stopped
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn](INFO): Running loop #11
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn] Running Loop=11
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:30:51.338Z,1682019051.338 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:30:53.340Z,1682019053.340 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193053.00,A,3648.14868,N,12147.22189,W,0.058,289.25,200423,,,D*71
2023-04-20T19:30:53.342Z,1682019053.342 [NAL9602](INFO): GPS fix at 20230420T193053: (36.802478, -121.787031)
2023-04-20T19:30:53.353Z,1682019053.353 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:30:53.353Z,1682019053.353 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:31:00.592Z,1682019060.592 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Courier0012.lzma
2023-04-20T19:31:01.594Z,1682019061.594 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0012.lzma.bak
2023-04-20T19:31:01.595Z,1682019061.595 [DataOverHttps](INFO): SBD MOMSN=18242189
2023-04-20T19:31:20.736Z,1682019080.736 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20230420T190650/Express0013.lzma
2023-04-20T19:31:21.738Z,1682019081.738 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0013.lzma.bak
2023-04-20T19:31:21.739Z,1682019081.739 [DataOverHttps](INFO): SBD MOMSN=18242192
2023-04-20T19:31:23.253Z,1682019083.253 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:31:23.253Z,1682019083.253 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:31:23.253Z,1682019083.253 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:31:38.591Z,1682019098.591 [NAL9602](INFO): SBD MO Status=2, MOMSN=16082, MT Status=2, MTMSN=0
2023-04-20T19:31:38.591Z,1682019098.591 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:31:55.959Z,1682019115.959 [NAL9602](INFO): SBD MO Status=2, MOMSN=16082, MT Status=2, MTMSN=0
2023-04-20T19:31:55.959Z,1682019115.959 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:35:14.323Z,1682019314.323 [NAL9602](INFO): SBD MO Status=2, MOMSN=16082, MT Status=2, MTMSN=0
2023-04-20T19:35:14.323Z,1682019314.323 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:35:59.655Z,1682019359.655 [NAL9602](INFO): SBD MO Status=2, MOMSN=16082, MT Status=2, MTMSN=0
2023-04-20T19:35:59.656Z,1682019359.656 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:35:59.980Z,1682019359.980 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-04-20T19:36:23.853Z,1682019383.853 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:36:23.853Z,1682019383.853 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:36:23.853Z,1682019383.853 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:36:23.853Z,1682019383.853 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:36:24.245Z,1682019384.245 [Default:CheckIn:D] Stopped
2023-04-20T19:36:24.245Z,1682019384.245 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:36:24.628Z,1682019384.628 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.182161 min 
2023-04-20T19:36:24.628Z,1682019384.628 [Default:CheckIn:E] Stopped
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn] Stopped
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn](INFO): Running loop #12
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn] Running Loop=12
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:36:24.629Z,1682019384.629 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:36:26.641Z,1682019386.641 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193627.00,A,3648.14920,N,12147.22353,W,0.058,63.94,200423,,,D*40
2023-04-20T19:36:26.644Z,1682019386.644 [NAL9602](INFO): GPS fix at 20230420T193627: (36.802487, -121.787059)
2023-04-20T19:36:26.655Z,1682019386.655 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:36:26.655Z,1682019386.655 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:36:28.328Z,1682019388.328 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-04-20T19:36:34.436Z,1682019394.436 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Courier0015.lzma
2023-04-20T19:36:35.438Z,1682019395.438 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0015.lzma.bak
2023-04-20T19:36:35.439Z,1682019395.439 [DataOverHttps](INFO): SBD MOMSN=18242225
2023-04-20T19:36:51.293Z,1682019411.293 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20230420T190650/Express0016.lzma
2023-04-20T19:36:52.296Z,1682019412.296 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0016.lzma.bak
2023-04-20T19:36:52.296Z,1682019412.296 [DataOverHttps](INFO): SBD MOMSN=18242229
2023-04-20T19:36:53.727Z,1682019413.727 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:36:53.727Z,1682019413.727 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:36:53.727Z,1682019413.727 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:36:59.382Z,1682019419.382 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:37:25.252Z,1682019445.252 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-04-20T19:37:25.259Z,1682019445.259 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 5.
2023-04-20T19:37:25.261Z,1682019445.261 [BPC1](INFO): Received data from all battery sticks.
2023-04-20T19:40:12.103Z,1682019612.103 [DVL_micro](ERROR): only read 3 of 4 data items
2023-04-20T19:40:12.103Z,1682019612.103 [DVL_micro](ERROR): Failed to parse:
:BI,-00303,-00160,+0000,I
2023-04-20T19:41:54.322Z,1682019714.322 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:41:54.322Z,1682019714.322 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:41:54.323Z,1682019714.323 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:41:54.323Z,1682019714.323 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:41:54.751Z,1682019714.751 [Default:CheckIn:D] Stopped
2023-04-20T19:41:54.752Z,1682019714.752 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:41:55.120Z,1682019715.120 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.690601 min 
2023-04-20T19:41:55.120Z,1682019715.120 [Default:CheckIn:E] Stopped
2023-04-20T19:41:55.120Z,1682019715.120 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:41:55.120Z,1682019715.120 [Default:CheckIn] Stopped
2023-04-20T19:41:55.121Z,1682019715.121 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:41:55.121Z,1682019715.121 [Default:CheckIn](INFO): Running loop #13
2023-04-20T19:41:55.121Z,1682019715.121 [Default:CheckIn] Running Loop=13
2023-04-20T19:41:55.121Z,1682019715.121 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:41:55.121Z,1682019715.121 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:41:57.155Z,1682019717.155 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194157.00,A,3648.17418,N,12147.28257,W,0.039,263.08,200423,,,D*7D
2023-04-20T19:41:57.157Z,1682019717.157 [NAL9602](INFO): GPS fix at 20230420T194157: (36.802903, -121.788043)
2023-04-20T19:41:57.168Z,1682019717.168 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:41:57.168Z,1682019717.168 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:42:04.148Z,1682019724.148 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20230420T190650/Courier0018.lzma
2023-04-20T19:42:05.153Z,1682019725.153 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0018.lzma.bak
2023-04-20T19:42:05.153Z,1682019725.153 [DataOverHttps](INFO): SBD MOMSN=18242240
2023-04-20T19:42:20.980Z,1682019740.980 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20230420T190650/Express0019.lzma
2023-04-20T19:42:21.982Z,1682019741.982 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0019.lzma.bak
2023-04-20T19:42:21.983Z,1682019741.983 [DataOverHttps](INFO): SBD MOMSN=18242243
2023-04-20T19:42:23.446Z,1682019743.446 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:42:23.446Z,1682019743.446 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:42:23.447Z,1682019743.447 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:42:30.329Z,1682019750.329 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-04-20T19:42:30.329Z,1682019750.329 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000,+14.1,0000.0,1489.0,000
2023-04-20T19:43:09.484Z,1682019789.484 [NAL9602](INFO): SBD MO Status=2, MOMSN=16082, MT Status=2, MTMSN=0
2023-04-20T19:43:09.484Z,1682019789.484 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-04-20T19:43:36.550Z,1682019816.550 [NAL9602](INFO): SBD MO Status=1, MOMSN=16082, MT Status=0, MTMSN=0
2023-04-20T19:43:36.550Z,1682019816.550 [NAL9602](INFO): No messages in MT queue
2023-04-20T19:44:07.265Z,1682019847.265 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:47:24.023Z,1682020044.023 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:47:24.023Z,1682020044.023 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:47:24.023Z,1682020044.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:47:24.023Z,1682020044.023 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:47:24.416Z,1682020044.416 [Default:CheckIn:D] Stopped
2023-04-20T19:47:24.416Z,1682020044.416 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:47:24.830Z,1682020044.830 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.185002 min 
2023-04-20T19:47:24.830Z,1682020044.830 [Default:CheckIn:E] Stopped
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn] Stopped
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn](INFO): Running loop #14
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn] Running Loop=14
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:47:24.831Z,1682020044.831 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:47:26.836Z,1682020046.836 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194727.00,A,3648.16836,N,12147.28561,W,0.408,11.67,200423,,,A*42
2023-04-20T19:47:26.838Z,1682020046.838 [NAL9602](INFO): GPS fix at 20230420T194727: (36.802806, -121.788094)
2023-04-20T19:47:26.855Z,1682020046.855 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:47:26.855Z,1682020046.855 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:47:34.012Z,1682020054.012 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230420T190650/Courier0021.lzma
2023-04-20T19:47:35.016Z,1682020055.016 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0021.lzma.bak
2023-04-20T19:47:35.017Z,1682020055.017 [DataOverHttps](INFO): SBD MOMSN=18242260
2023-04-20T19:47:51.024Z,1682020071.024 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20230420T190650/Express0022.lzma
2023-04-20T19:47:51.883Z,1682020071.883 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0022.lzma.bak
2023-04-20T19:47:51.883Z,1682020071.883 [DataOverHttps](INFO): SBD MOMSN=18242263
2023-04-20T19:47:53.520Z,1682020073.520 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:47:53.520Z,1682020073.520 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:47:53.520Z,1682020073.520 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:51:02.589Z,1682020262.589 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-04-20T19:51:02.590Z,1682020262.590 [DVL_micro](ERROR): Failed to parse:
:TS,000000,35.0000.0,1489.WI,-00471,-0129,+00000,A
2023-04-20T19:52:29.445Z,1682020349.445 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-04-20T19:52:54.105Z,1682020374.105 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-04-20T19:52:54.105Z,1682020374.105 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:52:54.106Z,1682020374.106 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:52:54.106Z,1682020374.106 [Default:CheckIn:D] Running Loop=1
2023-04-20T19:52:54.504Z,1682020374.504 [Default:CheckIn:D] Stopped
2023-04-20T19:52:54.504Z,1682020374.504 [Default:CheckIn:E] Running Loop=1
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.686475 min 
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn:E] Stopped
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn] Stopped
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn](INFO): Running loop #15
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn] Running Loop=15
2023-04-20T19:52:54.910Z,1682020374.910 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-04-20T19:52:54.911Z,1682020374.911 [Default:CheckIn:Read_GPS] Running Loop=1
2023-04-20T19:52:56.920Z,1682020376.920 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195257.00,A,3648.17329,N,12147.29217,W,0.233,100.05,200423,,,D*7C
2023-04-20T19:52:56.923Z,1682020376.923 [NAL9602](INFO): GPS fix at 20230420T195257: (36.802888, -121.788203)
2023-04-20T19:52:56.954Z,1682020376.954 [Default:CheckIn:Read_GPS] Stopped
2023-04-20T19:52:56.954Z,1682020376.954 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-04-20T19:53:04.488Z,1682020384.488 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230420T190650/Courier0024.lzma
2023-04-20T19:53:05.494Z,1682020385.494 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Courier0024.lzma.bak
2023-04-20T19:53:05.495Z,1682020385.495 [DataOverHttps](INFO): SBD MOMSN=18242268
2023-04-20T19:53:05.814Z,1682020385.814 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+9999.99
2023-04-20T19:53:24.321Z,1682020404.321 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20230420T190650/Express0025.lzma
2023-04-20T19:53:25.323Z,1682020405.323 [DataOverHttps](INFO): Moved sent file to Logs/20230420T190650/Express0025.lzma.bak
2023-04-20T19:53:25.323Z,1682020405.323 [DataOverHttps](INFO): SBD MOMSN=18242271
2023-04-20T19:53:26.851Z,1682020406.851 [Default:CheckIn:Read_Iridium] Stopped
2023-04-20T19:53:26.851Z,1682020406.851 [Default:CheckIn:C.Wait] Running Loop=1
2023-04-20T19:53:26.851Z,1682020406.851 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-04-20T19:53:29.242Z,1682020409.242 [NAL9602](INFO): Not Powering down - fast GPS
2023-04-20T19:56:10.047Z,1682020570.047 [DVL_micro](ERROR): Failed to parse:
:BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00
2023-04-20T19:56:24.805Z,1682020584.805 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239475
2023-04-20T19:56:35.485Z,1682020595.485 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error
2023-04-20T19:56:35.486Z,1682020595.486 [DVL_micro](ERROR): Failed to parse:
:TS,00000000000000,35.0,+15.2,0000.0,00
2023-04-20T19:57:22.777Z,1682020642.777 [CommandExec](IMPORTANT): got command quit
2023-04-20T19:57:23.781Z,1682020643.781 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:23.781Z,1682020643.781 [CommandExec](INFO): Uninitializing the command executive.
2023-04-20T19:57:23.781Z,1682020643.781 [CommandExec](INFO): Uninitializing the command scheduler.
2023-04-20T19:57:23.781Z,1682020643.781 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:23.957Z,1682020643.957 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-04-20T19:57:23.957Z,1682020643.957 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-04-20T19:57:23.957Z,1682020643.957 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:23.958Z,1682020643.958 [NavChartDb](INFO): Join timeout helper Thread ID is 435
2023-04-20T19:57:24.261Z,1682020644.261 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:24.261Z,1682020644.261 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:24.281Z,1682020644.281 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-04-20T19:57:24.281Z,1682020644.281 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:24.282Z,1682020644.282 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 436
2023-04-20T19:57:24.681Z,1682020644.681 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:24.681Z,1682020644.681 [WetLabsBB2FL](INFO): Powering down
2023-04-20T19:57:24.682Z,1682020644.682 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:24.685Z,1682020644.685 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-04-20T19:57:24.685Z,1682020644.685 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:24.685Z,1682020644.685 [CTD_Seabird](INFO): Join timeout helper Thread ID is 437
2023-04-20T19:57:25.133Z,1682020645.133 [CTD_Seabird](INFO): Powering down
2023-04-20T19:57:25.145Z,1682020645.145 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:25.145Z,1682020645.145 [CTD_Seabird](INFO): Powering down
2023-04-20T19:57:25.161Z,1682020645.161 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.173Z,1682020645.173 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-04-20T19:57:25.173Z,1682020645.173 [DAT ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.173Z,1682020645.173 [DAT](INFO): Join timeout helper Thread ID is 438
2023-04-20T19:57:25.225Z,1682020645.225 [DAT](INFO): Powering down
2023-04-20T19:57:25.298Z,1682020645.298 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:25.298Z,1682020645.298 [DAT](INFO): Powering down
2023-04-20T19:57:25.299Z,1682020645.299 [DAT ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.317Z,1682020645.317 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-04-20T19:57:25.317Z,1682020645.317 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.317Z,1682020645.317 [Radio_Surface](INFO): Join timeout helper Thread ID is 439
2023-04-20T19:57:25.333Z,1682020645.333 [Radio_Surface](INFO): Powering down
2023-04-20T19:57:25.334Z,1682020645.334 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:25.334Z,1682020645.334 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.338Z,1682020645.338 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-04-20T19:57:25.338Z,1682020645.338 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:25.338Z,1682020645.338 [Onboard](INFO): Join timeout helper Thread ID is 440
2023-04-20T19:57:27.845Z,1682020647.845 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:27.845Z,1682020647.845 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:27.865Z,1682020647.865 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-04-20T19:57:27.865Z,1682020647.865 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:27.866Z,1682020647.866 [DataOverHttps](INFO): Join timeout helper Thread ID is 441
2023-04-20T19:57:28.069Z,1682020648.069 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:28.069Z,1682020648.069 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.073Z,1682020648.073 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-04-20T19:57:28.074Z,1682020648.074 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.074Z,1682020648.074 [BackseatComponent](INFO): Join timeout helper Thread ID is 442
2023-04-20T19:57:28.153Z,1682020648.153 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:28.153Z,1682020648.153 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.161Z,1682020648.161 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-04-20T19:57:28.162Z,1682020648.162 [logger ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.162Z,1682020648.162 [logger](INFO): Join timeout helper Thread ID is 443
2023-04-20T19:57:28.189Z,1682020648.189 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:28.189Z,1682020648.189 [logger ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.201Z,1682020648.201 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-04-20T19:57:28.202Z,1682020648.202 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.202Z,1682020648.202 [CommandLine](INFO): Join timeout helper Thread ID is 444
2023-04-20T19:57:28.213Z,1682020648.213 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:28.213Z,1682020648.213 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.221Z,1682020648.221 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-04-20T19:57:28.221Z,1682020648.221 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.222Z,1682020648.222 [CommandExec](INFO): Join timeout helper Thread ID is 445
2023-04-20T19:57:28.223Z,1682020648.223 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-04-20T19:57:28.223Z,1682020648.223 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.223Z,1682020648.223 [controlThread](INFO): Join timeout helper Thread ID is 446
2023-04-20T19:57:28.389Z,1682020648.389 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-04-20T19:57:28.389Z,1682020648.389 [controlThread](DEBUG): Uninitializing ControlThread
2023-04-20T19:57:28.389Z,1682020648.389 [AHRS_M2](INFO): Powering down
2023-04-20T19:57:28.533Z,1682020648.533 [DVL_micro](INFO): Powering down
2023-04-20T19:57:28.534Z,1682020648.534 [NAL9602](INFO): Powering down
2023-04-20T19:57:28.537Z,1682020648.537 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-04-20T19:57:28.538Z,1682020648.538 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-04-20T19:57:28.538Z,1682020648.538 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-04-20T19:57:28.539Z,1682020648.539 [MissionManager](INFO): Uninitializing Mission Default
2023-04-20T19:57:28.539Z,1682020648.539 [Default] Stopped
2023-04-20T19:57:28.539Z,1682020648.539 [Default](DEBUG): Aggregate::uninitialize Default
2023-04-20T19:57:28.539Z,1682020648.539 [Default:B.GoToSurface] Stopped
2023-04-20T19:57:28.539Z,1682020648.539 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-04-20T19:57:28.539Z,1682020648.539 [Default:CheckIn] Stopped
2023-04-20T19:57:28.539Z,1682020648.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-04-20T19:57:28.539Z,1682020648.539 [Default:CheckIn:C.Wait] Stopped
2023-04-20T19:57:28.539Z,1682020648.539 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-04-20T19:57:28.542Z,1682020648.542 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-04-20T19:57:28.543Z,1682020648.543 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-04-20T19:57:28.543Z,1682020648.543 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-04-20T19:57:28.543Z,1682020648.543 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-04-20T19:57:28.543Z,1682020648.543 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-04-20T19:57:28.543Z,1682020648.543 [BuoyancyServo](INFO): Powering down
2023-04-20T19:57:28.557Z,1682020648.557 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-04-20T19:57:28.557Z,1682020648.557 [ElevatorServo](INFO): Powering down
2023-04-20T19:57:28.558Z,1682020648.558 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-04-20T19:57:28.558Z,1682020648.558 [MassServo](INFO): Powering down
2023-04-20T19:57:28.559Z,1682020648.559 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-04-20T19:57:28.559Z,1682020648.559 [RudderServo](INFO): Powering down
2023-04-20T19:57:28.559Z,1682020648.559 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-04-20T19:57:28.560Z,1682020648.560 [ThrusterHE](INFO): Powering down
2023-04-20T19:57:28.561Z,1682020648.561 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-04-20T19:57:28.561Z,1682020648.561 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-04-20T19:57:28.561Z,1682020648.561 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-04-20T19:57:28.561Z,1682020648.561 [CBIT](DEBUG): Powering off loads.
2023-04-20T19:57:28.572Z,1682020648.572 [CBIT](DEBUG): Disabling WDT.
2023-04-20T19:57:28.584Z,1682020648.584 [CBIT](DEBUG): Opening all GF detection circuits.
2023-04-20T19:57:28.586Z,1682020648.586 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.641Z,1682020648.641 [DAT ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.646Z,1682020648.646 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.648Z,1682020648.648 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.655Z,1682020648.655 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.698Z,1682020648.698 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.766Z,1682020648.766 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.846Z,1682020648.846 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.869Z,1682020648.869 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-04-20T19:57:28.961Z,1682020648.961 [logger ThreadHandler](INFO): Thread cancelled.