2025-07-03T01:10:33.891Z,1751505033.891 [CommandExec](IMPORTANT): got command restart logs 2025-07-03T01:10:34.322Z,1751505034.322 [DockingStepper](INFO): Resume 2025-07-03T01:10:34.390Z,1751505034.390 [DAT](INFO): Requesting device enable set for address 50. 2025-07-03T01:10:34.642Z,1751505034.642 [DAT](INFO): DAT read: user:1138> 2025-07-03T01:10:34.643Z,1751505034.643 [DAT](INFO): DAT read: Tx time:01:10:34.6331 2025-07-03T01:10:34.644Z,1751505034.644 [DAT](INFO): Ping request sent. 2025-07-03T01:10:34.644Z,1751505034.644 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:10:34.644Z,1751505034.644 [DAT](INFO): publishing transmit ping time 2025-07-03T01:10:34.645Z,1751505034.645 [DAT](INFO): Requesting device enable set for address 50. 2025-07-03T01:10:34.662Z,1751505034.662 [DockingStepper](INFO): Resuming 2025-07-03T01:10:34.894Z,1751505034.894 [DAT](INFO): Requesting device enable set for address 50. 2025-07-03T01:10:35.010Z,1751505035.010 [DockingStepper](INFO): Start 2025-07-03T01:10:35.010Z,1751505035.010 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-07-03T01:10:35.130Z,1751505035.130 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-07-03T01:10:35.374Z,1751505035.374 [CTD_Seabird](ERROR): Failed to parse device response: 2025-07-03T01:10:35.422Z,1751505035.422 [DockingStepper](INFO): Starting 2025-07-03T01:10:35.914Z,1751505035.914 [DockingStepper](INFO): Starting 2025-07-03T01:10:36.223Z,1751505036.223 [DockingStepper](INFO): Starting 2025-07-03T01:10:36.278Z,1751505036.278 [DockingStepper](INFO): Init string: /1z16367aE13561N3m50 2025-07-03T01:10:36.646Z,1751505036.646 [DockingStepper](INFO): Starting 2025-07-03T01:10:36.910Z,1751505036.910 [DAT](INFO): DAT read: Rx Time:01:10:36.5053 2025-07-03T01:10:36.911Z,1751505036.911 [DAT](INFO): Rx dataTimestamp_ set to:1751505036.910326 2025-07-03T01:10:37.017Z,1751505037.017 [DockingStepper](INFO): Starting 2025-07-03T01:10:37.421Z,1751505037.421 [DAT](INFO): DAT read: 01:10:36.5053 LVL= 9856, 11489, 12210, 11763, AGC= 34, IDX= 445, 0.14,-0.147, 0.273,-1.520, 0.436, PHS=-0.495,-0.116,-1.958, RAW= 18.8, 28.3, CAL= 14.1, 33.7, ROT= 135.9, -33.7 2025-07-03T01:10:37.422Z,1751505037.422 [DAT](INFO): got valid direction response: 01:10:36.5053 LVL= 9856, 11489, 12210, 11763, AGC= 34, IDX= 445, 0.14,-0.147, 0.273,-1.520, 0.436, PHS=-0.495,-0.116,-1.958, RAW= 18.8, 28.3, CAL= 14.1, 33.7, ROT= 135.9, -33.7 2025-07-03T01:10:37.423Z,1751505037.423 [DAT](INFO): DAT read: OK 2025-07-03T01:10:37.423Z,1751505037.423 [DAT](INFO): unknown deviceResponse_: OK 2025-07-03T01:10:37.423Z,1751505037.423 [DAT](INFO): DAT read: user:1139> 2025-07-03T01:10:37.424Z,1751505037.424 [DAT](INFO): DAT read: Tx time:01:10:37.5833 2025-07-03T01:10:37.424Z,1751505037.424 [DAT](INFO): Ping request sent. 2025-07-03T01:10:37.424Z,1751505037.424 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:10:37.425Z,1751505037.425 [DAT](INFO): #Rx 3: Read direction message, but no range. 2025-07-03T01:10:37.426Z,1751505037.426 [DAT](INFO): direction in FSK: [-0.597448,0.578968,0.554844] 2025-07-03T01:10:37.426Z,1751505037.426 [DAT](INFO): publishing transmit ping time 2025-07-03T01:10:37.433Z,1751505037.433 [DAT](INFO): publishing transmit ping time 2025-07-03T01:10:37.515Z,1751505037.515 [DockingStepper](INFO): Starting 2025-07-03T01:10:37.851Z,1751505037.851 [DockingStepper](INFO): Starting 2025-07-03T01:10:37.893Z,1751505037.893 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-07-03T01:10:38.374Z,1751505038.374 [DockingStepper](INFO): Starting 2025-07-03T01:10:38.686Z,1751505038.686 [DockingStepper](INFO): Changing to mode: 1 2025-07-03T01:10:38.686Z,1751505038.686 [DockingStepper](INFO): Standby mode. 2025-07-03T01:10:39.934Z,1751505039.934 [DAT](INFO): DAT read: Rx Time:01:10:39.4554 2025-07-03T01:10:39.935Z,1751505039.935 [DAT](INFO): Rx dataTimestamp_ set to:1751505039.934281 2025-07-03T01:10:40.442Z,1751505040.442 [DAT](INFO): DAT read: 01:10:39.4555 LVL= 9808, 11729, 12514, 12707, AGC= 35, IDX= 446, 0.05, 2.959,-3.017, 1.961,-2.729, PHS=-0.507,-0.242,-1.597, RAW= 19.3, 33.7, CAL= 13.4, 38.3, ROT= 136.6, -38.3 2025-07-03T01:10:40.444Z,1751505040.444 [DAT](INFO): got valid direction response: 01:10:39.4555 LVL= 9808, 11729, 12514, 12707, AGC= 35, IDX= 446, 0.05, 2.959,-3.017, 1.961,-2.729, PHS=-0.507,-0.242,-1.597, RAW= 19.3, 33.7, CAL= 13.4, 38.3, ROT= 136.6, -38.3 2025-07-03T01:10:40.444Z,1751505040.444 [DAT](INFO): DAT read: OK 2025-07-03T01:10:40.444Z,1751505040.444 [DAT](INFO): unknown deviceResponse_: OK 2025-07-03T01:10:40.445Z,1751505040.445 [DAT](INFO): DAT read: user:1140> 2025-07-03T01:10:40.446Z,1751505040.446 [DAT](INFO): DAT read: Tx time:01:10:40.5333 2025-07-03T01:10:40.446Z,1751505040.446 [DAT](INFO): Ping request sent. 2025-07-03T01:10:40.446Z,1751505040.446 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:10:40.446Z,1751505040.446 [DAT](INFO): #Rx 4: Read direction message, but no range. 2025-07-03T01:10:40.447Z,1751505040.447 [DAT](INFO): direction in FSK: [-0.570199,0.539210,0.619779] 2025-07-03T01:10:40.448Z,1751505040.448 [DAT](INFO): publishing transmit ping time 2025-07-03T01:10:40.451Z,1751505040.451 [DAT](INFO): publishing transmit ping time 2025-07-03T01:10:42.958Z,1751505042.958 [DAT](INFO): DAT read: Rx Time:01:10:42.4052 2025-07-03T01:10:42.959Z,1751505042.959 [DAT](INFO): Rx dataTimestamp_ set to:1751505042.958296 2025-07-03T01:10:43.462Z,1751505043.462 [DAT](INFO): DAT read: OK 2025-07-03T01:10:43.462Z,1751505043.462 [DAT](INFO): unknown deviceResponse_: OK 2025-07-03T01:10:55.177Z,1751505055.177 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, +4, +6, BE, +4, +6, +0,A 2025-07-03T01:11:07.309Z,1751505067.309 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003138 2025-07-03T01:11:09.133Z,1751505069.133 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:11:12.164Z,1751505072.164 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, +6, +3,A 2025-07-03T01:11:16.229Z,1751505076.229 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20250702T221159/Courier0054.lzma 2025-07-03T01:11:17.231Z,1751505077.231 [DataOverHttps](INFO): Moved sent file to Logs/20250702T221159/Courier0054.lzma.bak 2025-07-03T01:11:17.231Z,1751505077.231 [DataOverHttps](INFO): SBD MOMSN=25308353 2025-07-03T01:11:19.001Z,1751505079.001 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:11:27.509Z,1751505087.509 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:11:34.762Z,1751505094.762 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250703T005219/Courier0000.lzma 2025-07-03T01:11:35.763Z,1751505095.763 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Courier0000.lzma.bak 2025-07-03T01:11:35.763Z,1751505095.763 [DataOverHttps](INFO): SBD MOMSN=25308356 2025-07-03T01:11:38.006Z,1751505098.006 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:11:47.301Z,1751505107.301 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:11:56.381Z,1751505116.381 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T005219/Courier0003.lzma 2025-07-03T01:11:57.383Z,1751505117.383 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Courier0003.lzma.bak 2025-07-03T01:11:57.383Z,1751505117.383 [DataOverHttps](INFO): SBD MOMSN=25308359 2025-07-03T01:11:59.251Z,1751505119.251 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:07.641Z,1751505127.641 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:14.843Z,1751505134.843 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T005219/Courier0006.lzma 2025-07-03T01:12:15.843Z,1751505135.843 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Courier0006.lzma.bak 2025-07-03T01:12:15.843Z,1751505135.843 [DataOverHttps](INFO): SBD MOMSN=25308361 2025-07-03T01:12:17.827Z,1751505137.827 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:21.255Z,1751505141.255 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-327680 2025-07-03T01:12:27.045Z,1751505147.045 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:31.534Z,1751505151.534 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:12:31.658Z,1751505151.658 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:12:31.659Z,1751505151.659 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:12:31.910Z,1751505151.910 [DAT](INFO): DAT read: user:1141> 2025-07-03T01:12:31.911Z,1751505151.911 [DAT](INFO): DAT read: Tx time:01:12:31.9355 2025-07-03T01:12:31.911Z,1751505151.911 [DAT](INFO): Ping request sent. 2025-07-03T01:12:31.911Z,1751505151.911 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:12:31.911Z,1751505151.911 [DAT](INFO): publishing transmit ping time 2025-07-03T01:12:31.912Z,1751505151.912 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000736 2025-07-03T01:12:32.162Z,1751505152.162 [DAT](INFO): DAT read: TxSync time:01:12:31.9347 2025-07-03T01:12:32.163Z,1751505152.163 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251687 2025-07-03T01:12:32.414Z,1751505152.414 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502882 2025-07-03T01:12:32.666Z,1751505152.666 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754627 2025-07-03T01:12:32.918Z,1751505152.918 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006755 2025-07-03T01:12:33.170Z,1751505153.170 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258822 2025-07-03T01:12:33.422Z,1751505153.422 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510815 2025-07-03T01:12:33.675Z,1751505153.675 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763642 2025-07-03T01:12:33.926Z,1751505153.926 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014846 2025-07-03T01:12:34.178Z,1751505154.178 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266719 2025-07-03T01:12:34.431Z,1751505154.431 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519555 2025-07-03T01:12:34.682Z,1751505154.682 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770846 2025-07-03T01:12:34.935Z,1751505154.935 [DAT](INFO): DAT read: Rx Time:01:12:34.3404 2025-07-03T01:12:34.935Z,1751505154.935 [DAT](INFO): Rx dataTimestamp_ set to:1751505154.935179 2025-07-03T01:12:34.936Z,1751505154.936 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.024825 2025-07-03T01:12:35.187Z,1751505155.187 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.275475 2025-07-03T01:12:35.439Z,1751505155.439 [DAT](INFO): DAT read: Range 10 to 50 : 0.5 m (Round-trip 0.7 ms) speed 0.0 m/s 2025-07-03T01:12:35.439Z,1751505155.439 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:12:36.414Z,1751505156.414 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T005219/Courier0009.lzma 2025-07-03T01:12:37.415Z,1751505157.415 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Courier0009.lzma.bak 2025-07-03T01:12:37.416Z,1751505157.416 [DataOverHttps](INFO): SBD MOMSN=25308363 2025-07-03T01:12:40.160Z,1751505160.160 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:49.342Z,1751505169.342 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:12:56.518Z,1751505176.518 [DataOverHttps](INFO): Sending 399 bytes from file Logs/20250702T221159/Express0055.lzma 2025-07-03T01:12:57.519Z,1751505177.519 [DataOverHttps](INFO): Moved sent file to Logs/20250702T221159/Express0055.lzma.bak 2025-07-03T01:12:57.519Z,1751505177.519 [DataOverHttps](INFO): SBD MOMSN=25308365 2025-07-03T01:13:00.338Z,1751505180.338 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:13:09.577Z,1751505189.577 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:13:18.113Z,1751505198.113 [DataOverHttps](INFO): Sending 597 bytes from file Logs/20250703T005219/Express0001.lzma 2025-07-03T01:13:19.012Z,1751505199.012 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Express0001.lzma.bak 2025-07-03T01:13:19.012Z,1751505199.012 [DataOverHttps](INFO): SBD MOMSN=25308391 2025-07-03T01:13:21.792Z,1751505201.792 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:13:30.970Z,1751505210.970 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:13:38.288Z,1751505218.288 [DataOverHttps](INFO): Sending 507 bytes from file Logs/20250703T005219/Express0004.lzma 2025-07-03T01:13:39.291Z,1751505219.291 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Express0004.lzma.bak 2025-07-03T01:13:39.291Z,1751505219.291 [DataOverHttps](INFO): SBD MOMSN=25308509 2025-07-03T01:13:41.976Z,1751505221.976 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:13:51.190Z,1751505231.190 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:00.009Z,1751505240.009 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-07-03T01:14:00.938Z,1751505240.938 [DataOverHttps](INFO): Sending 590 bytes from file Logs/20250703T005219/Express0007.lzma 2025-07-03T01:14:01.939Z,1751505241.939 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Express0007.lzma.bak 2025-07-03T01:14:01.939Z,1751505241.939 [DataOverHttps](INFO): SBD MOMSN=25308514 2025-07-03T01:14:04.664Z,1751505244.664 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:13.893Z,1751505253.893 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:21.126Z,1751505261.126 [DataOverHttps](INFO): Sending 472 bytes from file Logs/20250703T005219/Express0010.lzma 2025-07-03T01:14:22.127Z,1751505262.127 [DataOverHttps](INFO): Moved sent file to Logs/20250703T005219/Express0010.lzma.bak 2025-07-03T01:14:22.127Z,1751505262.127 [DataOverHttps](INFO): SBD MOMSN=25308528 2025-07-03T01:14:24.842Z,1751505264.842 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:25.112Z,1751505265.112 [OnDock:dataRead:A] Stopped 2025-07-03T01:14:25.113Z,1751505265.113 [OnDock:dataRead:B.Wait] Running Loop=1 2025-07-03T01:14:25.137Z,1751505265.137 [OnDock:dataRead:B.Wait](DEBUG): Initialize Wait Component. 2025-07-03T01:14:31.547Z,1751505271.547 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:14:31.742Z,1751505271.742 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:14:31.742Z,1751505271.742 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:14:31.998Z,1751505271.998 [DAT](INFO): DAT read: user:1142> 2025-07-03T01:14:32.001Z,1751505272.001 [DAT](INFO): DAT read: Tx time:01:14:31.9869 2025-07-03T01:14:32.002Z,1751505272.002 [DAT](INFO): Ping request sent. 2025-07-03T01:14:32.003Z,1751505272.003 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:14:32.005Z,1751505272.005 [DAT](INFO): DAT read: TxSync time:01:14:31.9861 2025-07-03T01:14:32.007Z,1751505272.007 [DAT](INFO): publishing transmit ping time 2025-07-03T01:14:32.009Z,1751505272.009 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.006101 2025-07-03T01:14:32.246Z,1751505272.246 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.243628 2025-07-03T01:14:32.498Z,1751505272.498 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.495667 2025-07-03T01:14:32.751Z,1751505272.751 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.748609 2025-07-03T01:14:33.004Z,1751505273.004 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.001583 2025-07-03T01:14:33.254Z,1751505273.254 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.251755 2025-07-03T01:14:33.506Z,1751505273.506 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.503617 2025-07-03T01:14:33.758Z,1751505273.758 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.755918 2025-07-03T01:14:34.012Z,1751505274.012 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.009753 2025-07-03T01:14:34.262Z,1751505274.262 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.260076 2025-07-03T01:14:34.514Z,1751505274.514 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.511695 2025-07-03T01:14:34.766Z,1751505274.766 [DAT](INFO): DAT read: Rx Time:01:14:34.3922 2025-07-03T01:14:34.767Z,1751505274.767 [DAT](INFO): Rx dataTimestamp_ set to:1751505274.766274 2025-07-03T01:14:34.767Z,1751505274.767 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.764863 2025-07-03T01:14:35.018Z,1751505275.018 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.015909 2025-07-03T01:14:35.272Z,1751505275.272 [DAT](INFO): DAT read: Range 10 to 50 : 0.9 m (Round-trip 1.2 ms) speed 0.0 m/s 2025-07-03T01:14:35.273Z,1751505275.273 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:14:40.721Z,1751505280.721 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:49.825Z,1751505289.825 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:14:52.543Z,1751505292.543 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 74.97, 72.65, 70.61 2025-07-03T01:14:59.061Z,1751505299.061 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:08.253Z,1751505308.253 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:17.541Z,1751505317.541 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:26.861Z,1751505326.861 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:36.122Z,1751505336.122 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:45.409Z,1751505345.409 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:15:54.677Z,1751505354.677 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:02.435Z,1751505362.435 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 72.98, 73.32, 71.29 2025-07-03T01:16:04.021Z,1751505364.021 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:13.318Z,1751505373.318 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:22.647Z,1751505382.647 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:31.959Z,1751505391.959 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:16:31.987Z,1751505391.987 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:16:31.987Z,1751505391.987 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:16:31.990Z,1751505391.990 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:32.238Z,1751505392.238 [DAT](INFO): DAT read: user:1143> 2025-07-03T01:16:32.239Z,1751505392.239 [DAT](INFO): DAT read: Tx time:01:16:32.2382 2025-07-03T01:16:32.239Z,1751505392.239 [DAT](INFO): Ping request sent. 2025-07-03T01:16:32.239Z,1751505392.239 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:16:32.240Z,1751505392.240 [DAT](INFO): publishing transmit ping time 2025-07-03T01:16:32.247Z,1751505392.247 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.007556 2025-07-03T01:16:32.490Z,1751505392.490 [DAT](INFO): DAT read: TxSync time:01:16:32.2375 2025-07-03T01:16:32.491Z,1751505392.491 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251749 2025-07-03T01:16:32.744Z,1751505392.744 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.504744 2025-07-03T01:16:32.994Z,1751505392.994 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754673 2025-07-03T01:16:33.246Z,1751505393.246 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006783 2025-07-03T01:16:33.498Z,1751505393.498 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258822 2025-07-03T01:16:33.750Z,1751505393.750 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510872 2025-07-03T01:16:34.002Z,1751505394.002 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762975 2025-07-03T01:16:34.254Z,1751505394.254 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014865 2025-07-03T01:16:34.506Z,1751505394.506 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266795 2025-07-03T01:16:34.758Z,1751505394.758 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518931 2025-07-03T01:16:35.010Z,1751505395.010 [DAT](INFO): DAT read: Rx Time:01:16:34.6436 2025-07-03T01:16:35.011Z,1751505395.011 [DAT](INFO): Rx dataTimestamp_ set to:1751505395.010241 2025-07-03T01:16:35.011Z,1751505395.011 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771946 2025-07-03T01:16:35.269Z,1751505395.269 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.029624 2025-07-03T01:16:35.523Z,1751505395.523 [DAT](INFO): DAT read: Range 10 to 50 : 0.9 m (Round-trip 1.2 ms) speed 0.0 m/s 2025-07-03T01:16:35.524Z,1751505395.524 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:16:46.313Z,1751505406.313 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:16:55.497Z,1751505415.497 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:04.653Z,1751505424.653 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:13.929Z,1751505433.929 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:17.572Z,1751505437.572 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 73.32, 72.97, 73.32 2025-07-03T01:17:23.290Z,1751505443.290 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:32.514Z,1751505452.514 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:41.827Z,1751505461.827 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:17:51.143Z,1751505471.143 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:00.333Z,1751505480.333 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:09.661Z,1751505489.661 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:18.945Z,1751505498.945 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:28.191Z,1751505508.191 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:31.977Z,1751505511.977 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:18:32.062Z,1751505512.062 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:18:32.062Z,1751505512.062 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:18:32.314Z,1751505512.314 [DAT](INFO): DAT read: user:1144> 2025-07-03T01:18:32.315Z,1751505512.315 [DAT](INFO): DAT read: Tx time:01:18:32.3395 2025-07-03T01:18:32.315Z,1751505512.315 [DAT](INFO): Ping request sent. 2025-07-03T01:18:32.315Z,1751505512.315 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:18:32.315Z,1751505512.315 [DAT](INFO): publishing transmit ping time 2025-07-03T01:18:32.316Z,1751505512.316 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000754 2025-07-03T01:18:32.568Z,1751505512.568 [DAT](INFO): DAT read: TxSync time:01:18:32.3388 2025-07-03T01:18:32.583Z,1751505512.583 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.267616 2025-07-03T01:18:32.819Z,1751505512.819 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503724 2025-07-03T01:18:33.070Z,1751505513.070 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754883 2025-07-03T01:18:33.322Z,1751505513.322 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006883 2025-07-03T01:18:33.577Z,1751505513.577 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.260820 2025-07-03T01:18:33.826Z,1751505513.826 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510913 2025-07-03T01:18:34.078Z,1751505514.078 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762955 2025-07-03T01:18:34.330Z,1751505514.330 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014713 2025-07-03T01:18:34.585Z,1751505514.585 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.269142 2025-07-03T01:18:34.835Z,1751505514.835 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519541 2025-07-03T01:18:35.086Z,1751505515.086 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770808 2025-07-03T01:18:35.338Z,1751505515.338 [DAT](INFO): DAT read: Rx Time:01:18:34.7446 2025-07-03T01:18:35.339Z,1751505515.339 [DAT](INFO): Rx dataTimestamp_ set to:1751505515.338246 2025-07-03T01:18:35.339Z,1751505515.339 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023968 2025-07-03T01:18:35.592Z,1751505515.592 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.277001 2025-07-03T01:18:35.843Z,1751505515.843 [DAT](INFO): DAT read: Range 10 to 50 : 0.6 m (Round-trip 0.8 ms) speed 0.0 m/s 2025-07-03T01:18:35.843Z,1751505515.843 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:18:37.659Z,1751505517.659 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:46.845Z,1751505526.845 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:18:58.321Z,1751505538.321 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:07.589Z,1751505547.589 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:16.921Z,1751505556.921 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:25.825Z,1751505565.825 [OnDock:dataRead:B.Wait](INFO): Done Waiting. 2025-07-03T01:19:25.825Z,1751505565.825 [OnDock:dataRead:B.Wait] Stopped 2025-07-03T01:19:25.825Z,1751505565.825 [OnDock:dataRead:B.Wait](DEBUG): Uninitialize Wait Component. 2025-07-03T01:19:25.826Z,1751505565.826 [OnDock:dataRead](INFO): Completed OnDock:dataRead 2025-07-03T01:19:26.166Z,1751505566.166 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:26.195Z,1751505566.195 [OnDock:dataRead] Running Loop=1 2025-07-03T01:19:26.195Z,1751505566.195 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-07-03T01:19:26.195Z,1751505566.195 [OnDock:dataRead:A] Running Loop=1 2025-07-03T01:19:34.372Z,1751505574.372 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250703T011033/Courier0000.lzma 2025-07-03T01:19:35.374Z,1751505575.374 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Courier0000.lzma.bak 2025-07-03T01:19:35.375Z,1751505575.375 [DataOverHttps](INFO): SBD MOMSN=25308539 2025-07-03T01:19:38.115Z,1751505578.115 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:44.811Z,1751505584.811 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, +0.00, + +0.00,1481.79 2025-07-03T01:19:47.373Z,1751505587.373 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:19:56.469Z,1751505596.469 [DataOverHttps](INFO): Sending 436 bytes from file Logs/20250703T011033/Express0001.lzma 2025-07-03T01:19:57.471Z,1751505597.471 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Express0001.lzma.bak 2025-07-03T01:19:57.471Z,1751505597.471 [DataOverHttps](INFO): SBD MOMSN=25308542 2025-07-03T01:20:00.282Z,1751505600.282 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:00.567Z,1751505600.567 [OnDock:dataRead:A] Stopped 2025-07-03T01:20:00.567Z,1751505600.567 [OnDock:dataRead:B.Wait] Running Loop=1 2025-07-03T01:20:00.567Z,1751505600.567 [OnDock:dataRead:B.Wait](DEBUG): Initialize Wait Component. 2025-07-03T01:20:10.485Z,1751505610.485 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:19.817Z,1751505619.817 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:29.097Z,1751505629.097 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:32.082Z,1751505632.082 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:20:32.233Z,1751505632.233 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:20:32.234Z,1751505632.234 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:20:32.487Z,1751505632.487 [DAT](INFO): DAT read: user:1145> 2025-07-03T01:20:32.488Z,1751505632.488 [DAT](INFO): DAT read: Tx time:01:20:30.3408 2025-07-03T01:20:32.489Z,1751505632.489 [DAT](INFO): Ping request sent. 2025-07-03T01:20:32.489Z,1751505632.489 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:20:32.490Z,1751505632.490 [DAT](INFO): DAT read: TxSync time:01:20:30.3400 2025-07-03T01:20:32.490Z,1751505632.490 [DAT](INFO): publishing transmit ping time 2025-07-03T01:20:32.491Z,1751505632.491 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001658 2025-07-03T01:20:32.738Z,1751505632.738 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.248539 2025-07-03T01:20:32.990Z,1751505632.990 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.500605 2025-07-03T01:20:33.241Z,1751505633.241 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.752447 2025-07-03T01:20:33.494Z,1751505633.494 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.004526 2025-07-03T01:20:33.745Z,1751505633.745 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.256423 2025-07-03T01:20:33.998Z,1751505633.998 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.508555 2025-07-03T01:20:34.250Z,1751505634.250 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.760893 2025-07-03T01:20:34.504Z,1751505634.504 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014915 2025-07-03T01:20:34.754Z,1751505634.754 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.264609 2025-07-03T01:20:35.006Z,1751505635.006 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.516920 2025-07-03T01:20:35.258Z,1751505635.258 [DAT](INFO): DAT read: Rx Time:01:20:32.7461 2025-07-03T01:20:35.258Z,1751505635.258 [DAT](INFO): Rx dataTimestamp_ set to:1751505635.257881 2025-07-03T01:20:35.259Z,1751505635.259 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.769703 2025-07-03T01:20:35.510Z,1751505635.510 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021080 2025-07-03T01:20:35.763Z,1751505635.763 [DAT](INFO): DAT read: Range 10 to 50 : 0.9 m (Round-trip 1.2 ms) speed 0.0 m/s 2025-07-03T01:20:35.763Z,1751505635.763 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:20:40.233Z,1751505640.233 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:49.521Z,1751505649.521 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:20:58.677Z,1751505658.677 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:07.978Z,1751505667.978 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:17.269Z,1751505677.269 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:26.554Z,1751505686.554 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:35.877Z,1751505695.877 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:45.177Z,1751505705.177 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:21:54.538Z,1751505714.538 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:03.806Z,1751505723.806 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:10.238Z,1751505730.238 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,3 2025-07-03T01:22:13.037Z,1751505733.037 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:22.333Z,1751505742.333 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:31.613Z,1751505751.613 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:32.497Z,1751505752.497 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:22:32.737Z,1751505752.737 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:22:32.738Z,1751505752.738 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:22:32.989Z,1751505752.989 [DAT](INFO): DAT read: user:1146> 2025-07-03T01:22:32.990Z,1751505752.990 [DAT](INFO): DAT read: Tx time:01:22:30.8420 2025-07-03T01:22:32.991Z,1751505752.991 [DAT](INFO): Ping request sent. 2025-07-03T01:22:32.991Z,1751505752.991 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:22:32.991Z,1751505752.991 [DAT](INFO): DAT read: TxSync time:01:22:30.8413 2025-07-03T01:22:32.992Z,1751505752.992 [DAT](INFO): publishing transmit ping time 2025-07-03T01:22:32.992Z,1751505752.992 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001577 2025-07-03T01:22:33.244Z,1751505753.244 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252515 2025-07-03T01:22:33.494Z,1751505753.494 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502766 2025-07-03T01:22:33.746Z,1751505753.746 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755254 2025-07-03T01:22:33.998Z,1751505753.998 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006815 2025-07-03T01:22:34.254Z,1751505754.254 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.262392 2025-07-03T01:22:34.502Z,1751505754.502 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510802 2025-07-03T01:22:34.754Z,1751505754.754 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762800 2025-07-03T01:22:35.006Z,1751505755.006 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014865 2025-07-03T01:22:35.260Z,1751505755.260 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.268836 2025-07-03T01:22:35.510Z,1751505755.510 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519542 2025-07-03T01:22:35.762Z,1751505755.762 [DAT](INFO): DAT read: Rx Time:01:22:33.2470 2025-07-03T01:22:35.763Z,1751505755.763 [DAT](INFO): Rx dataTimestamp_ set to:1751505755.762590 2025-07-03T01:22:35.764Z,1751505755.764 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.772976 2025-07-03T01:22:36.014Z,1751505756.014 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022793 2025-07-03T01:22:36.271Z,1751505756.271 [DAT](INFO): DAT read: Range 10 to 50 : 0.6 m (Round-trip 0.8 ms) speed 0.0 m/s 2025-07-03T01:22:36.273Z,1751505756.273 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:22:41.049Z,1751505761.049 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:50.257Z,1751505770.257 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:22:59.453Z,1751505779.453 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:08.841Z,1751505788.841 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:18.029Z,1751505798.029 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:27.365Z,1751505807.365 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:36.670Z,1751505816.670 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:45.921Z,1751505825.921 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:23:55.190Z,1751505835.190 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:00.120Z,1751505840.120 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-07-03T01:24:04.521Z,1751505844.521 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:13.921Z,1751505853.921 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:26.685Z,1751505866.685 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:32.860Z,1751505872.860 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:24:33.053Z,1751505873.053 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:24:33.054Z,1751505873.054 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:24:33.306Z,1751505873.306 [DAT](INFO): DAT read: user:1147> 2025-07-03T01:24:33.307Z,1751505873.307 [DAT](INFO): DAT read: Tx time:01:24:31.1932 2025-07-03T01:24:33.308Z,1751505873.308 [DAT](INFO): Ping request sent. 2025-07-03T01:24:33.308Z,1751505873.308 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:24:33.309Z,1751505873.309 [DAT](INFO): publishing transmit ping time 2025-07-03T01:24:33.309Z,1751505873.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001531 2025-07-03T01:24:33.558Z,1751505873.558 [DAT](INFO): DAT read: TxSync time:01:24:31.1924 2025-07-03T01:24:33.559Z,1751505873.559 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250649 2025-07-03T01:24:33.810Z,1751505873.810 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501712 2025-07-03T01:24:34.062Z,1751505874.062 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.753696 2025-07-03T01:24:34.314Z,1751505874.314 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005949 2025-07-03T01:24:34.566Z,1751505874.566 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257768 2025-07-03T01:24:34.818Z,1751505874.818 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509652 2025-07-03T01:24:35.070Z,1751505875.070 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761561 2025-07-03T01:24:35.324Z,1751505875.324 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.016063 2025-07-03T01:24:35.574Z,1751505875.574 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265564 2025-07-03T01:24:35.826Z,1751505875.826 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517550 2025-07-03T01:24:36.080Z,1751505876.080 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771798 2025-07-03T01:24:36.330Z,1751505876.330 [DAT](INFO): DAT read: Rx Time:01:24:33.5988 2025-07-03T01:24:36.331Z,1751505876.331 [DAT](INFO): Rx dataTimestamp_ set to:1751505876.330583 2025-07-03T01:24:36.332Z,1751505876.332 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023653 2025-07-03T01:24:36.581Z,1751505876.581 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.273498 2025-07-03T01:24:36.834Z,1751505876.834 [DAT](INFO): DAT read: Range 10 to 50 : 1.0 m (Round-trip 1.4 ms) speed 0.0 m/s 2025-07-03T01:24:36.835Z,1751505876.835 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:24:40.849Z,1751505880.849 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:50.089Z,1751505890.089 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:24:59.537Z,1751505899.537 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:25:01.132Z,1751505901.132 [OnDock:dataRead:B.Wait](INFO): Done Waiting. 2025-07-03T01:25:01.132Z,1751505901.132 [OnDock:dataRead:B.Wait] Stopped 2025-07-03T01:25:01.132Z,1751505901.132 [OnDock:dataRead:B.Wait](DEBUG): Uninitialize Wait Component. 2025-07-03T01:25:01.132Z,1751505901.132 [OnDock:dataRead](INFO): Completed OnDock:dataRead 2025-07-03T01:25:01.610Z,1751505901.610 [OnDock:dataRead] Running Loop=1 2025-07-03T01:25:01.610Z,1751505901.610 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-07-03T01:25:01.610Z,1751505901.610 [OnDock:dataRead:A] Running Loop=1 2025-07-03T01:25:07.015Z,1751505907.015 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T011033/Courier0003.lzma 2025-07-03T01:25:08.022Z,1751505908.022 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Courier0003.lzma.bak 2025-07-03T01:25:08.022Z,1751505908.022 [DataOverHttps](INFO): SBD MOMSN=25308694 2025-07-03T01:25:10.806Z,1751505910.806 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:25:20.001Z,1751505920.001 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:25:27.190Z,1751505927.190 [DataOverHttps](INFO): Sending 89 bytes from file Logs/20250703T011033/Express0004.lzma 2025-07-03T01:25:28.190Z,1751505928.190 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Express0004.lzma.bak 2025-07-03T01:25:28.191Z,1751505928.191 [DataOverHttps](INFO): SBD MOMSN=25308696 2025-07-03T01:25:31.010Z,1751505931.010 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:25:31.224Z,1751505931.224 [OnDock:dataRead:A] Stopped 2025-07-03T01:25:31.224Z,1751505931.224 [OnDock:dataRead:B.Wait] Running Loop=1 2025-07-03T01:25:31.224Z,1751505931.224 [OnDock:dataRead:B.Wait](DEBUG): Initialize Wait Component. 2025-07-03T01:25:41.002Z,1751505941.002 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:25:45.313Z,1751505945.313 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 73.66, 71.97, 73.32, 2025-07-03T01:25:51.749Z,1751505951.749 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:01.077Z,1751505961.077 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:10.241Z,1751505970.241 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:19.591Z,1751505979.591 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:28.917Z,1751505988.917 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:33.031Z,1751505993.031 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:26:33.081Z,1751505993.081 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:26:33.082Z,1751505993.082 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:26:33.334Z,1751505993.334 [DAT](INFO): DAT read: user:1148> 2025-07-03T01:26:33.335Z,1751505993.335 [DAT](INFO): DAT read: Tx time:01:26:31.1944 2025-07-03T01:26:33.336Z,1751505993.336 [DAT](INFO): Ping request sent. 2025-07-03T01:26:33.336Z,1751505993.336 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:26:33.337Z,1751505993.337 [DAT](INFO): DAT read: TxSync time:01:26:31.1936 2025-07-03T01:26:33.337Z,1751505993.337 [DAT](INFO): publishing transmit ping time 2025-07-03T01:26:33.338Z,1751505993.338 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.002622 2025-07-03T01:26:33.586Z,1751505993.586 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250304 2025-07-03T01:26:33.838Z,1751505993.838 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501992 2025-07-03T01:26:34.090Z,1751505994.090 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.753914 2025-07-03T01:26:34.342Z,1751505994.342 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006414 2025-07-03T01:26:34.594Z,1751505994.594 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257970 2025-07-03T01:26:34.846Z,1751505994.846 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509892 2025-07-03T01:26:35.099Z,1751505995.099 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762880 2025-07-03T01:26:35.350Z,1751505995.350 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014015 2025-07-03T01:26:35.606Z,1751505995.606 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.270000 2025-07-03T01:26:35.854Z,1751505995.854 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518365 2025-07-03T01:26:36.106Z,1751505996.106 [DAT](INFO): DAT read: Rx Time:01:26:33.5992 2025-07-03T01:26:36.106Z,1751505996.106 [DAT](INFO): Rx dataTimestamp_ set to:1751505996.105799 2025-07-03T01:26:36.107Z,1751505996.107 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770982 2025-07-03T01:26:36.358Z,1751505996.358 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021842 2025-07-03T01:26:36.611Z,1751505996.611 [DAT](INFO): DAT read: Range 10 to 50 : 0.4 m (Round-trip 0.6 ms) speed 0.0 m/s 2025-07-03T01:26:36.612Z,1751505996.612 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:26:38.469Z,1751505998.469 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:47.637Z,1751506007.637 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:26:55.208Z,1751506015.208 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -72.95, +2 -16.57, 7.22, 0.00 2025-07-03T01:26:56.813Z,1751506016.813 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:27:06.137Z,1751506026.137 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:27:27.575Z,1751506047.575 [DockingStepper](ERROR): only read 3 of 4 ADC values. Response is: ÿ/06336,3472,16320 2025-07-03T01:27:27.576Z,1751506047.576 [DockingStepper](FAULT): Unknown EZ Servo Error: 6 2025-07-03T01:27:27.576Z,1751506047.576 [DockingStepper] Hardware Fault, FailCount= 1 2025-07-03T01:27:27.576Z,1751506047.576 [DockingStepper](ERROR): Hardware Fault 2025-07-03T01:27:27.577Z,1751506047.577 [DockingStepper](FAULT): Docking arm not reporting position 2025-07-03T01:27:27.577Z,1751506047.577 [DockingStepper] Communications Fault, FailCount= 1 2025-07-03T01:27:27.577Z,1751506047.577 [DockingStepper](ERROR): Communications Fault 2025-07-03T01:27:27.591Z,1751506047.591 [CBIT](ERROR): Communications Fault in component: DockingStepper 2025-07-03T01:27:27.957Z,1751506047.957 [DockingStepper](INFO): Stop 2025-07-03T01:27:27.957Z,1751506047.957 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2025-07-03T01:27:27.957Z,1751506047.957 [DockingStepper](INFO): Powering down 2025-07-03T01:27:28.369Z,1751506048.369 [DockingStepper](INFO): Stopping 2025-07-03T01:27:28.779Z,1751506048.779 [DockingStepper](INFO): Stopping 2025-07-03T01:27:29.141Z,1751506049.141 [DockingStepper](INFO): Stopping 2025-07-03T01:27:29.357Z,1751506049.357 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:27:29.557Z,1751506049.557 [DockingStepper](INFO): Stopping 2025-07-03T01:27:29.985Z,1751506049.985 [DockingStepper](INFO): Stopping 2025-07-03T01:27:30.386Z,1751506050.386 [DockingStepper](INFO): Stopping 2025-07-03T01:27:30.775Z,1751506050.775 [DockingStepper](INFO): Stopping 2025-07-03T01:27:31.165Z,1751506051.165 [DockingStepper](INFO): Stopping 2025-07-03T01:27:31.595Z,1751506051.595 [DockingStepper](INFO): Stopping 2025-07-03T01:27:32.019Z,1751506052.019 [DockingStepper](INFO): Stopping 2025-07-03T01:27:32.378Z,1751506052.378 [DockingStepper](INFO): Stopping 2025-07-03T01:27:32.803Z,1751506052.803 [DockingStepper](INFO): Stopping 2025-07-03T01:27:33.198Z,1751506053.198 [DockingStepper](INFO): Stopping 2025-07-03T01:27:33.591Z,1751506053.591 [DockingStepper](INFO): Stopping 2025-07-03T01:27:34.029Z,1751506054.029 [DockingStepper](INFO): Stopping 2025-07-03T01:27:34.406Z,1751506054.406 [DockingStepper](INFO): Stopping 2025-07-03T01:27:34.830Z,1751506054.830 [DockingStepper](INFO): Stopping 2025-07-03T01:27:35.208Z,1751506055.208 [DockingStepper](INFO): Stopping 2025-07-03T01:27:35.612Z,1751506055.612 [DockingStepper](INFO): Stopping 2025-07-03T01:27:36.038Z,1751506056.038 [DockingStepper](INFO): Stopping 2025-07-03T01:27:36.439Z,1751506056.439 [DockingStepper](INFO): Stopping 2025-07-03T01:27:36.861Z,1751506056.861 [DockingStepper](INFO): Stopping 2025-07-03T01:27:37.227Z,1751506057.227 [DockingStepper](INFO): Stopping 2025-07-03T01:27:37.643Z,1751506057.643 [DockingStepper](INFO): Stopping 2025-07-03T01:27:38.071Z,1751506058.071 [DockingStepper](INFO): Stopping 2025-07-03T01:27:38.433Z,1751506058.433 [DockingStepper](INFO): Stopping 2025-07-03T01:27:38.862Z,1751506058.862 [DockingStepper](INFO): Stopping 2025-07-03T01:27:39.263Z,1751506059.263 [DockingStepper](INFO): Stopping 2025-07-03T01:27:39.643Z,1751506059.643 [DockingStepper](INFO): Stopping 2025-07-03T01:27:40.067Z,1751506060.067 [DockingStepper](INFO): Stopping 2025-07-03T01:27:40.462Z,1751506060.462 [DockingStepper](INFO): Stopping 2025-07-03T01:27:40.884Z,1751506060.884 [DockingStepper](INFO): Stopping 2025-07-03T01:27:41.263Z,1751506061.263 [DockingStepper](INFO): Stopping 2025-07-03T01:27:41.684Z,1751506061.684 [DockingStepper](INFO): Stopping 2025-07-03T01:27:42.092Z,1751506062.092 [DockingStepper](INFO): Stopping 2025-07-03T01:27:42.489Z,1751506062.489 [DockingStepper](INFO): Stopping 2025-07-03T01:27:42.919Z,1751506062.919 [DockingStepper](INFO): Stopping 2025-07-03T01:27:43.282Z,1751506063.282 [DockingStepper](INFO): Stopping 2025-07-03T01:27:43.696Z,1751506063.696 [DockingStepper](INFO): Stopping 2025-07-03T01:27:44.117Z,1751506064.117 [DockingStepper](INFO): Stopping 2025-07-03T01:27:44.492Z,1751506064.492 [DockingStepper](INFO): Stopping 2025-07-03T01:27:44.924Z,1751506064.924 [DockingStepper](INFO): Stopping 2025-07-03T01:27:45.316Z,1751506065.316 [DockingStepper](INFO): Stopping 2025-07-03T01:27:45.723Z,1751506065.723 [DockingStepper](INFO): Stopping 2025-07-03T01:27:46.165Z,1751506066.165 [DockingStepper](INFO): Stopping 2025-07-03T01:27:46.515Z,1751506066.515 [DockingStepper](INFO): Stopping 2025-07-03T01:27:46.951Z,1751506066.951 [DockingStepper](INFO): Stopping 2025-07-03T01:27:47.354Z,1751506067.354 [DockingStepper](INFO): Stopping 2025-07-03T01:27:47.733Z,1751506067.733 [DockingStepper](INFO): Stopping 2025-07-03T01:27:48.147Z,1751506068.147 [DockingStepper](INFO): Stopping 2025-07-03T01:27:48.543Z,1751506068.543 [DockingStepper](INFO): Stopped 2025-07-03T01:27:48.547Z,1751506068.547 [CBIT](INFO): Clearing failed state for component DockingStepper 2025-07-03T01:27:48.548Z,1751506068.548 [DockingStepper] No Fault, FailCount= 1 2025-07-03T01:27:48.984Z,1751506068.984 [DockingStepper](INFO): Start 2025-07-03T01:27:48.984Z,1751506068.984 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-07-03T01:27:49.102Z,1751506069.102 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-07-03T01:27:49.354Z,1751506069.354 [DockingStepper](INFO): Starting 2025-07-03T01:27:49.750Z,1751506069.750 [DockingStepper](INFO): Starting 2025-07-03T01:27:50.221Z,1751506070.221 [DockingStepper](INFO): Starting 2025-07-03T01:27:50.266Z,1751506070.266 [DockingStepper](INFO): Init string: /1z16352aE13561N3m50 2025-07-03T01:27:50.551Z,1751506070.551 [DockingStepper](INFO): Starting 2025-07-03T01:27:51.019Z,1751506071.019 [DockingStepper](INFO): Starting 2025-07-03T01:27:51.369Z,1751506071.369 [DockingStepper](INFO): Starting 2025-07-03T01:27:51.778Z,1751506071.778 [DockingStepper](INFO): Starting 2025-07-03T01:27:51.821Z,1751506071.821 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-07-03T01:27:52.208Z,1751506072.208 [DockingStepper](INFO): Starting 2025-07-03T01:27:52.580Z,1751506072.580 [DockingStepper](INFO): Changing to mode: 1 2025-07-03T01:27:52.581Z,1751506072.581 [DockingStepper](INFO): Standby mode. 2025-07-03T01:27:59.490Z,1751506079.490 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-03T01:28:00.493Z,1751506080.493 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:28:10.349Z,1751506090.349 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25070217291561,35.0, +10.2, 0.0,10 2025-07-03T01:28:11.665Z,1751506091.665 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:28:26.817Z,1751506106.817 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:28:33.405Z,1751506113.405 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:28:33.613Z,1751506113.613 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:28:33.614Z,1751506113.614 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:28:33.865Z,1751506113.865 [DAT](INFO): DAT read: user:1149> 2025-07-03T01:28:33.866Z,1751506113.866 [DAT](INFO): DAT read: Tx time:01:28:31.7456 2025-07-03T01:28:33.867Z,1751506113.867 [DAT](INFO): Ping request sent. 2025-07-03T01:28:33.867Z,1751506113.867 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:28:33.867Z,1751506113.867 [DAT](INFO): publishing transmit ping time 2025-07-03T01:28:33.867Z,1751506113.867 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000742 2025-07-03T01:28:34.118Z,1751506114.118 [DAT](INFO): DAT read: TxSync time:01:28:31.7448 2025-07-03T01:28:34.118Z,1751506114.118 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251704 2025-07-03T01:28:34.370Z,1751506114.370 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502755 2025-07-03T01:28:34.622Z,1751506114.622 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754898 2025-07-03T01:28:34.874Z,1751506114.874 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006819 2025-07-03T01:28:35.125Z,1751506115.125 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258709 2025-07-03T01:28:35.377Z,1751506115.377 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510751 2025-07-03T01:28:35.630Z,1751506115.630 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762802 2025-07-03T01:28:35.888Z,1751506115.888 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.021387 2025-07-03T01:28:36.142Z,1751506116.142 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.274791 2025-07-03T01:28:36.394Z,1751506116.394 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.526808 2025-07-03T01:28:36.646Z,1751506116.646 [DAT](INFO): DAT read: Rx Time:01:28:34.1504 2025-07-03T01:28:36.646Z,1751506116.646 [DAT](INFO): Rx dataTimestamp_ set to:1751506116.645855 2025-07-03T01:28:36.647Z,1751506116.647 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.779944 2025-07-03T01:28:36.897Z,1751506116.897 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.030718 2025-07-03T01:28:37.154Z,1751506117.154 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.285144 2025-07-03T01:28:37.402Z,1751506117.402 [DAT](INFO): DAT read: Range 10 to 50 : 0.5 m (Round-trip 0.7 ms) speed 0.0 m/s 2025-07-03T01:28:37.403Z,1751506117.403 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:28:58.121Z,1751506138.121 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:29:25.500Z,1751506165.500 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, -90, -5, 2025-07-03T01:29:26.234Z,1751506166.234 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.420113 2025-07-03T01:29:27.237Z,1751506167.237 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:29:59.640Z,1751506199.640 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:30:29.758Z,1751506229.758 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-03T01:30:30.761Z,1751506230.761 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:30:31.754Z,1751506231.754 [OnDock:dataRead:B.Wait](INFO): Done Waiting. 2025-07-03T01:30:31.754Z,1751506231.754 [OnDock:dataRead:B.Wait] Stopped 2025-07-03T01:30:31.754Z,1751506231.754 [OnDock:dataRead:B.Wait](DEBUG): Uninitialize Wait Component. 2025-07-03T01:30:31.754Z,1751506231.754 [OnDock:dataRead](INFO): Completed OnDock:dataRead 2025-07-03T01:30:32.166Z,1751506232.166 [OnDock:dataRead] Running Loop=1 2025-07-03T01:30:32.166Z,1751506232.166 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-07-03T01:30:32.167Z,1751506232.167 [OnDock:dataRead:A] Running Loop=1 2025-07-03T01:30:33.762Z,1751506233.762 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:30:33.977Z,1751506233.977 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:30:33.978Z,1751506233.978 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:30:34.231Z,1751506234.231 [DAT](INFO): DAT read: user:1150> 2025-07-03T01:30:34.232Z,1751506234.232 [DAT](INFO): DAT read: Tx time:01:30:32.0967 2025-07-03T01:30:34.232Z,1751506234.232 [DAT](INFO): Ping request sent. 2025-07-03T01:30:34.232Z,1751506234.232 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:30:34.232Z,1751506234.232 [DAT](INFO): publishing transmit ping time 2025-07-03T01:30:34.233Z,1751506234.233 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000857 2025-07-03T01:30:34.482Z,1751506234.482 [DAT](INFO): DAT read: TxSync time:01:30:32.0959 2025-07-03T01:30:34.483Z,1751506234.483 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250422 2025-07-03T01:30:34.734Z,1751506234.734 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501430 2025-07-03T01:30:34.986Z,1751506234.986 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.753566 2025-07-03T01:30:35.237Z,1751506235.237 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005276 2025-07-03T01:30:35.494Z,1751506235.494 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.261540 2025-07-03T01:30:35.746Z,1751506235.746 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.513336 2025-07-03T01:30:35.997Z,1751506235.997 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.765305 2025-07-03T01:30:36.250Z,1751506236.250 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.017504 2025-07-03T01:30:36.502Z,1751506236.502 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.269344 2025-07-03T01:30:36.754Z,1751506236.754 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.521356 2025-07-03T01:30:37.007Z,1751506237.007 [DAT](INFO): DAT read: Rx Time:01:30:34.5021 2025-07-03T01:30:37.007Z,1751506237.007 [DAT](INFO): Rx dataTimestamp_ set to:1751506237.006943 2025-07-03T01:30:37.008Z,1751506237.008 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.775616 2025-07-03T01:30:37.258Z,1751506237.258 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.025332 2025-07-03T01:30:37.513Z,1751506237.513 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.279847 2025-07-03T01:30:37.767Z,1751506237.767 [DAT](INFO): DAT read: 01:30:34.5021 LVL= 12688, 15697, 23602, 20515, AGC= 38, IDX= 439, 0.19,-3.116,-2.426,-2.419,-0.574, PHS=-2.454,-1.805,-1.849, RAW= 273.4, 73.8, CAL= 277.6, 75.3, ROT= 232.4, -75.3 2025-07-03T01:30:37.768Z,1751506237.768 [DAT](INFO): got valid direction response: 01:30:34.5021 LVL= 12688, 15697, 23602, 20515, AGC= 38, IDX= 439, 0.19,-3.116,-2.426,-2.419,-0.574, PHS=-2.454,-1.805,-1.849, RAW= 273.4, 73.8, CAL= 277.6, 75.3, ROT= 232.4, -75.3 2025-07-03T01:30:37.769Z,1751506237.769 [DAT](INFO): DAT read: Bearing 232.4, -75.3 (Local) 2025-07-03T01:30:37.770Z,1751506237.770 [DAT](INFO): Local bearing/azimuth received: Bearing 232.4, -75.3 (Local) 2025-07-03T01:30:37.771Z,1751506237.771 [DAT](INFO): DAT read: Range 10 to 50 : 0.9 m (Round-trip 1.2 ms) speed 0.0 m/s 2025-07-03T01:30:37.771Z,1751506237.771 [DAT](INFO): #Rx 1: Read range and direction messages. 2025-07-03T01:30:37.781Z,1751506237.781 [DAT](INFO): direction in FSK: [-0.154829,-0.201050,0.967268] 2025-07-03T01:30:37.781Z,1751506237.781 [DAT](INFO): publishing direction and range info 2025-07-03T01:30:50.085Z,1751506250.085 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003116 2025-07-03T01:30:51.938Z,1751506251.938 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:30:58.356Z,1751506258.356 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T011033/Courier0006.lzma 2025-07-03T01:30:59.358Z,1751506259.358 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Courier0006.lzma.bak 2025-07-03T01:30:59.359Z,1751506259.359 [DataOverHttps](INFO): SBD MOMSN=25308704 2025-07-03T01:31:02.097Z,1751506262.097 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:31:11.273Z,1751506271.273 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:31:23.825Z,1751506283.825 [DataOverHttps](INFO): Sending 197 bytes from file Logs/20250703T011033/Express0007.lzma 2025-07-03T01:31:24.827Z,1751506284.827 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Express0007.lzma.bak 2025-07-03T01:31:24.828Z,1751506284.828 [DataOverHttps](INFO): SBD MOMSN=25308706 2025-07-03T01:31:27.695Z,1751506287.695 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:31:28.051Z,1751506288.051 [OnDock:dataRead:A] Stopped 2025-07-03T01:31:28.052Z,1751506288.052 [OnDock:dataRead:B.Wait] Running Loop=1 2025-07-03T01:31:28.052Z,1751506288.052 [OnDock:dataRead:B.Wait](DEBUG): Initialize Wait Component. 2025-07-03T01:31:37.789Z,1751506297.789 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:07.045Z,1751506327.045 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:16.173Z,1751506336.173 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:25.517Z,1751506345.517 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:33.906Z,1751506353.906 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:32:34.053Z,1751506354.053 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:32:34.054Z,1751506354.054 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:32:34.306Z,1751506354.306 [DAT](INFO): DAT read: user:1151> 2025-07-03T01:32:34.307Z,1751506354.307 [DAT](INFO): DAT read: Tx time:01:32:32.1978 2025-07-03T01:32:34.307Z,1751506354.307 [DAT](INFO): Ping request sent. 2025-07-03T01:32:34.307Z,1751506354.307 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:32:34.308Z,1751506354.308 [DAT](INFO): publishing transmit ping time 2025-07-03T01:32:34.309Z,1751506354.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001179 2025-07-03T01:32:34.558Z,1751506354.558 [DAT](INFO): DAT read: TxSync time:01:32:32.1970 2025-07-03T01:32:34.559Z,1751506354.559 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251216 2025-07-03T01:32:34.669Z,1751506354.669 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:34.810Z,1751506354.810 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502138 2025-07-03T01:32:35.061Z,1751506355.061 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754013 2025-07-03T01:32:35.314Z,1751506355.314 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006598 2025-07-03T01:32:35.569Z,1751506355.569 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.260394 2025-07-03T01:32:35.817Z,1751506355.817 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510022 2025-07-03T01:32:36.069Z,1751506356.069 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761995 2025-07-03T01:32:36.322Z,1751506356.322 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014834 2025-07-03T01:32:36.574Z,1751506356.574 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266045 2025-07-03T01:32:36.826Z,1751506356.826 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518727 2025-07-03T01:32:37.078Z,1751506357.078 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770161 2025-07-03T01:32:37.330Z,1751506357.330 [DAT](INFO): DAT read: Rx Time:01:32:34.6031 2025-07-03T01:32:37.331Z,1751506357.331 [DAT](INFO): Rx dataTimestamp_ set to:1751506357.330490 2025-07-03T01:32:37.332Z,1751506357.332 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.024162 2025-07-03T01:32:37.582Z,1751506357.582 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274143 2025-07-03T01:32:37.834Z,1751506357.834 [DAT](INFO): DAT read: Range 10 to 50 : 0.8 m (Round-trip 1.1 ms) speed 0.0 m/s 2025-07-03T01:32:37.835Z,1751506357.835 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:32:44.035Z,1751506364.035 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:32:53.253Z,1751506373.253 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:33:02.417Z,1751506382.417 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:33:11.631Z,1751506391.631 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:33:20.901Z,1751506400.901 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:33:30.129Z,1751506410.129 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:33:59.429Z,1751506439.429 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:00.385Z,1751506440.385 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-07-03T01:34:05.643Z,1751506445.643 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -72.+2639.21, -16.80, 7.24, 0.00 2025-07-03T01:34:08.645Z,1751506448.645 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:17.833Z,1751506457.833 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:27.045Z,1751506467.045 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:33.949Z,1751506473.949 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:34:34.085Z,1751506474.085 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:34:34.086Z,1751506474.086 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:34:34.343Z,1751506474.343 [DAT](INFO): DAT read: user:1152> 2025-07-03T01:34:34.344Z,1751506474.344 [DAT](INFO): DAT read: Tx time:01:34:32.1990 2025-07-03T01:34:34.344Z,1751506474.344 [DAT](INFO): Ping request sent. 2025-07-03T01:34:34.345Z,1751506474.345 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:34:34.346Z,1751506474.346 [DAT](INFO): DAT read: TxSync time:01:34:32.1982 2025-07-03T01:34:34.346Z,1751506474.346 [DAT](INFO): publishing transmit ping time 2025-07-03T01:34:34.347Z,1751506474.347 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.002655 2025-07-03T01:34:34.594Z,1751506474.594 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.249464 2025-07-03T01:34:34.848Z,1751506474.848 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503172 2025-07-03T01:34:35.097Z,1751506475.097 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.753161 2025-07-03T01:34:35.349Z,1751506475.349 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005134 2025-07-03T01:34:35.602Z,1751506475.602 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257965 2025-07-03T01:34:35.854Z,1751506475.854 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509230 2025-07-03T01:34:36.106Z,1751506476.106 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761211 2025-07-03T01:34:36.277Z,1751506476.277 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:36.358Z,1751506476.358 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.013343 2025-07-03T01:34:36.610Z,1751506476.610 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265271 2025-07-03T01:34:36.861Z,1751506476.861 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517165 2025-07-03T01:34:37.114Z,1751506477.114 [DAT](INFO): DAT read: Rx Time:01:34:34.6044 2025-07-03T01:34:37.114Z,1751506477.114 [DAT](INFO): Rx dataTimestamp_ set to:1751506477.113815 2025-07-03T01:34:37.115Z,1751506477.115 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770335 2025-07-03T01:34:37.366Z,1751506477.366 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021570 2025-07-03T01:34:37.618Z,1751506477.618 [DAT](INFO): DAT read: Range 10 to 50 : 0.9 m (Round-trip 1.3 ms) speed 0.0 m/s 2025-07-03T01:34:37.619Z,1751506477.619 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:34:45.581Z,1751506485.581 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:34:54.885Z,1751506494.885 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:04.209Z,1751506504.209 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:13.454Z,1751506513.454 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:20.795Z,1751506520.795 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD,+0.00, +0.00, 20.49 2025-07-03T01:35:22.785Z,1751506522.785 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:32.081Z,1751506532.081 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:41.333Z,1751506541.333 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:50.657Z,1751506550.657 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:35:59.917Z,1751506559.917 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:09.321Z,1751506569.321 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:18.517Z,1751506578.517 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:27.782Z,1751506587.782 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:28.664Z,1751506588.664 [OnDock:dataRead:B.Wait](INFO): Done Waiting. 2025-07-03T01:36:28.664Z,1751506588.664 [OnDock:dataRead:B.Wait] Stopped 2025-07-03T01:36:28.664Z,1751506588.664 [OnDock:dataRead:B.Wait](DEBUG): Uninitialize Wait Component. 2025-07-03T01:36:28.681Z,1751506588.681 [OnDock:dataRead](INFO): Completed OnDock:dataRead 2025-07-03T01:36:29.053Z,1751506589.053 [OnDock:dataRead] Running Loop=1 2025-07-03T01:36:29.053Z,1751506589.053 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-07-03T01:36:29.053Z,1751506589.053 [OnDock:dataRead:A] Running Loop=1 2025-07-03T01:36:30.686Z,1751506590.686 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, , +0.00, +0.00, 20.52 2025-07-03T01:36:33.970Z,1751506593.970 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:36:34.133Z,1751506594.133 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:36:34.134Z,1751506594.134 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:36:34.387Z,1751506594.387 [DAT](INFO): DAT read: user:1153> 2025-07-03T01:36:34.388Z,1751506594.388 [DAT](INFO): DAT read: Tx time:01:36:32.2500 2025-07-03T01:36:34.388Z,1751506594.388 [DAT](INFO): Ping request sent. 2025-07-03T01:36:34.389Z,1751506594.389 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:36:34.390Z,1751506594.390 [DAT](INFO): DAT read: TxSync time:01:36:32.2493 2025-07-03T01:36:34.390Z,1751506594.390 [DAT](INFO): publishing transmit ping time 2025-07-03T01:36:34.391Z,1751506594.391 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.002805 2025-07-03T01:36:34.641Z,1751506594.641 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252130 2025-07-03T01:36:34.890Z,1751506594.890 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501464 2025-07-03T01:36:35.143Z,1751506595.143 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754819 2025-07-03T01:36:35.394Z,1751506595.394 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005436 2025-07-03T01:36:35.648Z,1751506595.648 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259118 2025-07-03T01:36:35.898Z,1751506595.898 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509393 2025-07-03T01:36:36.150Z,1751506596.150 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761461 2025-07-03T01:36:36.403Z,1751506596.403 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014352 2025-07-03T01:36:36.654Z,1751506596.654 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265361 2025-07-03T01:36:36.906Z,1751506596.906 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517422 2025-07-03T01:36:37.160Z,1751506597.160 [DAT](INFO): DAT read: Rx Time:01:36:34.6549 2025-07-03T01:36:37.160Z,1751506597.160 [DAT](INFO): Rx dataTimestamp_ set to:1751506597.159760 2025-07-03T01:36:37.161Z,1751506597.161 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.772572 2025-07-03T01:36:37.268Z,1751506597.268 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250703T011033/Courier0009.lzma 2025-07-03T01:36:37.410Z,1751506597.410 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021381 2025-07-03T01:36:37.667Z,1751506597.667 [DAT](INFO): DAT read: Range 10 to 50 : 0.5 m (Round-trip 0.7 ms) speed 0.0 m/s 2025-07-03T01:36:37.671Z,1751506597.671 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:36:38.270Z,1751506598.270 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Courier0009.lzma.bak 2025-07-03T01:36:38.271Z,1751506598.271 [DataOverHttps](INFO): SBD MOMSN=25308846 2025-07-03T01:36:41.013Z,1751506601.013 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:50.177Z,1751506610.177 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:36:58.392Z,1751506618.392 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20250703T011033/Express0010.lzma 2025-07-03T01:36:59.395Z,1751506619.395 [DataOverHttps](INFO): Moved sent file to Logs/20250703T011033/Express0010.lzma.bak 2025-07-03T01:36:59.395Z,1751506619.395 [DataOverHttps](INFO): SBD MOMSN=25308848 2025-07-03T01:37:03.325Z,1751506623.325 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:37:03.457Z,1751506623.457 [OnDock:dataRead:A] Stopped 2025-07-03T01:37:03.457Z,1751506623.457 [OnDock:dataRead:B.Wait] Running Loop=1 2025-07-03T01:37:03.457Z,1751506623.457 [OnDock:dataRead:B.Wait](DEBUG): Initialize Wait Component. 2025-07-03T01:37:35.141Z,1751506655.141 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:37:41.060Z,1751506661.060 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD,2.93, ,7.04, 7.19, 0.00 2025-07-03T01:38:00.241Z,1751506680.241 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.847172 2025-07-03T01:38:01.245Z,1751506681.245 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:38:31.366Z,1751506711.366 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-03T01:38:32.369Z,1751506712.369 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:38:34.309Z,1751506714.309 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:38:34.447Z,1751506714.447 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:38:34.448Z,1751506714.448 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:38:34.697Z,1751506714.697 [DAT](INFO): DAT read: user:1154> 2025-07-03T01:38:34.698Z,1751506714.698 [DAT](INFO): DAT read: Tx time:01:38:32.6011 2025-07-03T01:38:34.699Z,1751506714.699 [DAT](INFO): Ping request sent. 2025-07-03T01:38:34.699Z,1751506714.699 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:38:34.699Z,1751506714.699 [DAT](INFO): publishing transmit ping time 2025-07-03T01:38:34.699Z,1751506714.699 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000741 2025-07-03T01:38:34.950Z,1751506714.950 [DAT](INFO): DAT read: TxSync time:01:38:32.6003 2025-07-03T01:38:34.950Z,1751506714.950 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251837 2025-07-03T01:38:35.203Z,1751506715.203 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503930 2025-07-03T01:38:35.456Z,1751506715.456 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.756965 2025-07-03T01:38:35.708Z,1751506715.708 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.009058 2025-07-03T01:38:35.958Z,1751506715.958 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259235 2025-07-03T01:38:36.210Z,1751506716.210 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510852 2025-07-03T01:38:36.464Z,1751506716.464 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.764987 2025-07-03T01:38:36.713Z,1751506716.713 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014780 2025-07-03T01:38:36.966Z,1751506716.966 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266860 2025-07-03T01:38:37.218Z,1751506717.218 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518916 2025-07-03T01:38:37.476Z,1751506717.476 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.776409 2025-07-03T01:38:37.722Z,1751506717.722 [DAT](INFO): DAT read: Rx Time:01:38:35.0061 2025-07-03T01:38:37.722Z,1751506717.722 [DAT](INFO): Rx dataTimestamp_ set to:1751506717.721790 2025-07-03T01:38:37.723Z,1751506717.723 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023960 2025-07-03T01:38:37.974Z,1751506717.974 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274962 2025-07-03T01:38:38.226Z,1751506718.226 [DAT](INFO): DAT read: Range 10 to 50 : 0.5 m (Round-trip 0.7 ms) speed 0.0 m/s 2025-07-03T01:38:38.227Z,1751506718.227 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:39:02.489Z,1751506742.489 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-03T01:39:03.493Z,1751506743.493 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:39:33.641Z,1751506773.641 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-03T01:39:34.645Z,1751506774.645 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:40:04.033Z,1751506804.033 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003110 2025-07-03T01:40:05.033Z,1751506805.033 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:40:16.369Z,1751506816.369 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:40:25.525Z,1751506825.525 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:40:34.379Z,1751506834.379 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:40:34.505Z,1751506834.505 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:40:34.506Z,1751506834.506 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:40:34.758Z,1751506834.758 [DAT](INFO): DAT read: user:1155> 2025-07-03T01:40:34.758Z,1751506834.758 [DAT](INFO): DAT read: Tx time:01:40:32.6523 2025-07-03T01:40:34.759Z,1751506834.759 [DAT](INFO): Ping request sent. 2025-07-03T01:40:34.759Z,1751506834.759 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:40:34.759Z,1751506834.759 [DAT](INFO): publishing transmit ping time 2025-07-03T01:40:34.760Z,1751506834.760 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000751 2025-07-03T01:40:35.010Z,1751506835.010 [DAT](INFO): DAT read: TxSync time:01:40:32.6515 2025-07-03T01:40:35.010Z,1751506835.010 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251653 2025-07-03T01:40:35.262Z,1751506835.262 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502788 2025-07-03T01:40:35.514Z,1751506835.514 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754788 2025-07-03T01:40:35.766Z,1751506835.766 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006746 2025-07-03T01:40:36.021Z,1751506836.021 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.262667 2025-07-03T01:40:36.274Z,1751506836.274 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.514786 2025-07-03T01:40:36.526Z,1751506836.526 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.766731 2025-07-03T01:40:36.778Z,1751506836.778 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.018905 2025-07-03T01:40:37.030Z,1751506837.030 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.270706 2025-07-03T01:40:37.282Z,1751506837.282 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.522799 2025-07-03T01:40:37.535Z,1751506837.535 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.775839 2025-07-03T01:40:37.785Z,1751506837.785 [DAT](INFO): DAT read: Rx Time:01:40:35.0572 2025-07-03T01:40:37.786Z,1751506837.786 [DAT](INFO): Rx dataTimestamp_ set to:1751506837.785680 2025-07-03T01:40:37.786Z,1751506837.786 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.027745 2025-07-03T01:40:38.039Z,1751506838.039 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.280198 2025-07-03T01:40:38.294Z,1751506838.294 [DAT](INFO): DAT read: Range 10 to 50 : 0.5 m (Round-trip 0.7 ms) speed 0.0 m/s 2025-07-03T01:40:38.296Z,1751506838.296 [DAT](ERROR): #Rx 1: Read range message, but no direction. 2025-07-03T01:40:56.741Z,1751506856.741 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:41:24.854Z,1751506884.854 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.331787 2025-07-03T01:41:25.859Z,1751506885.859 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:41:57.175Z,1751506917.175 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:42:03.982Z,1751506923.982 [OnDock:dataRead:B.Wait](INFO): Done Waiting. 2025-07-03T01:42:03.982Z,1751506923.982 [OnDock:dataRead:B.Wait] Stopped 2025-07-03T01:42:03.982Z,1751506923.982 [OnDock:dataRead:B.Wait](DEBUG): Uninitialize Wait Component. 2025-07-03T01:42:03.983Z,1751506923.983 [OnDock:dataRead](INFO): Completed OnDock:dataRead 2025-07-03T01:42:04.391Z,1751506924.391 [OnDock:dataRead] Running Loop=1 2025-07-03T01:42:04.391Z,1751506924.391 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-07-03T01:42:04.391Z,1751506924.391 [OnDock:dataRead:A] Running Loop=1 2025-07-03T01:42:28.429Z,1751506948.429 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-07-03T01:42:31.044Z,1751506951.044 [RDI_Pathfinder](ERROR): only read 0 of 4 data items for beam range. Device response is::RA 73.66, 71.63, 72.65, 70.61 2025-07-03T01:42:34.741Z,1751506954.741 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-07-03T01:42:34.853Z,1751506954.853 [DAT](DEBUG): Acoustic response timeout 2025-07-03T01:42:34.854Z,1751506954.854 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-07-03T01:42:35.106Z,1751506955.106 [DAT](INFO): DAT read: user:1156> 2025-07-03T01:42:35.106Z,1751506955.106 [DAT](INFO): DAT read: Tx time:01:42:33.0033 2025-07-03T01:42:35.107Z,1751506955.107 [DAT](INFO): Ping request sent. 2025-07-03T01:42:35.107Z,1751506955.107 [DAT](INFO): transmitted an acoustic signal 2025-07-03T01:42:35.107Z,1751506955.107 [DAT](INFO): publishing transmit ping time 2025-07-03T01:42:35.108Z,1751506955.108 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000761 2025-07-03T01:42:35.358Z,1751506955.358 [DAT](INFO): DAT read: TxSync time:01:42:33.0025 2025-07-03T01:42:35.358Z,1751506955.358 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251593 2025-07-03T01:42:35.610Z,1751506955.610 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503007 2025