2024-05-22T23:25:06.943Z,1716420306.943 [DockingStepper](INFO): Starting 2024-05-22T23:25:06.989Z,1716420306.989 [CommandExec](IMPORTANT): got command restart logs 2024-05-22T23:25:07.380Z,1716420307.380 [OnDock:restartDHCP] Running Loop=1 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP](DEBUG): Aggregate::initialize OnDock:restartDHCP 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP:A] Running Loop=1 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP:A](IMPORTANT): Skipping DHCP restart to test autonetwork 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP:A] Stopped 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP](INFO): Completed OnDock:restartDHCP 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP] Stopped 2024-05-22T23:25:07.381Z,1716420307.381 [OnDock:restartDHCP](DEBUG): Aggregate::uninitialize OnDock:restartDHCP 2024-05-22T23:25:07.429Z,1716420307.429 [DockingStepper](INFO): Starting 2024-05-22T23:25:07.718Z,1716420307.718 [OnDock:M](INFO): Completed OnDock:M 2024-05-22T23:25:07.718Z,1716420307.718 [OnDock:M] Stopped 2024-05-22T23:25:07.718Z,1716420307.718 [OnDock:M](DEBUG): Aggregate::uninitialize OnDock:M 2024-05-22T23:25:07.719Z,1716420307.719 [OnDock:O.Docked] Running Loop=1 2024-05-22T23:25:07.719Z,1716420307.719 [OnDock:O.Docked](DEBUG): Initialize. 2024-05-22T23:25:07.719Z,1716420307.719 [OnDock:O.Docked](DEBUG): Initializing internal variables to default values. 2024-05-22T23:25:07.761Z,1716420307.761 [DockingStepper](INFO): Starting 2024-05-22T23:25:07.808Z,1716420307.808 [DockingStepper](INFO): Init string: /1z16095aE13561N3m50 2024-05-22T23:25:08.119Z,1716420308.119 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:08.125Z,1716420308.125 [CommandExec](INFO): Found local IP address 10.89.10.2 for eth0 2024-05-22T23:25:08.125Z,1716420308.125 [OnDock:O.Docked](IMPORTANT): No IP address on dock subnet, restarting DHCP 2024-05-22T23:25:08.191Z,1716420308.191 [DockingStepper](INFO): Starting 2024-05-22T23:25:08.559Z,1716420308.559 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position 18.51 mm (2 active estimators). 2024-05-22T23:25:08.637Z,1716420308.637 [DockingStepper](INFO): Starting 2024-05-22T23:25:08.969Z,1716420308.969 [DockingStepper](INFO): Starting 2024-05-22T23:25:09.421Z,1716420309.421 [DockingStepper](INFO): Starting 2024-05-22T23:25:09.444Z,1716420309.444 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-22T23:25:09.777Z,1716420309.777 [DockingStepper](INFO): Starting 2024-05-22T23:25:10.173Z,1716420310.173 [DockingStepper](INFO): Deisolating dock charge 2024-05-22T23:25:16.194Z,1716420316.194 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:25:16.919Z,1716420316.919 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC232516_sh 2024-05-22T23:25:31.381Z,1716420331.381 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-05-22T23:25:32.385Z,1716420332.385 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:25:39.287Z,1716420339.287 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@ 2024-05-22T23:25:39.288Z,1716420339.288 [DockingStepper](FAULT): Docking arm not reporting position 2024-05-22T23:25:39.289Z,1716420339.289 [DockingStepper] Communications Fault, FailCount= 1 2024-05-22T23:25:39.289Z,1716420339.289 [DockingStepper](ERROR): Communications Fault 2024-05-22T23:25:39.334Z,1716420339.334 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-05-22T23:25:39.673Z,1716420339.673 [DockingStepper](INFO): Stop 2024-05-22T23:25:39.673Z,1716420339.673 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-05-22T23:25:39.673Z,1716420339.673 [DockingStepper](INFO): Powering down 2024-05-22T23:25:40.074Z,1716420340.074 [DockingStepper](INFO): Stopping 2024-05-22T23:25:40.450Z,1716420340.450 [DockingStepper](INFO): Stopped 2024-05-22T23:25:40.496Z,1716420340.496 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-05-22T23:25:40.496Z,1716420340.496 [DockingStepper] No Fault, FailCount= 1 2024-05-22T23:25:40.849Z,1716420340.849 [DockingStepper](INFO): Start 2024-05-22T23:25:40.850Z,1716420340.850 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-22T23:25:40.850Z,1716420340.850 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-22T23:25:41.246Z,1716420341.246 [DockingStepper](INFO): Starting 2024-05-22T23:25:41.676Z,1716420341.676 [DockingStepper](INFO): Starting 2024-05-22T23:25:42.046Z,1716420342.046 [DockingStepper](INFO): Starting 2024-05-22T23:25:42.093Z,1716420342.093 [DockingStepper](INFO): Init string: /1z16106aE13561N3m50 2024-05-22T23:25:42.451Z,1716420342.451 [DockingStepper](INFO): Starting 2024-05-22T23:25:42.885Z,1716420342.885 [DockingStepper](INFO): Starting 2024-05-22T23:25:43.259Z,1716420343.259 [DockingStepper](INFO): Starting 2024-05-22T23:25:43.720Z,1716420343.720 [DockingStepper](INFO): Starting 2024-05-22T23:25:43.752Z,1716420343.752 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-22T23:25:44.082Z,1716420344.082 [DockingStepper](INFO): Starting 2024-05-22T23:25:44.470Z,1716420344.470 [DockingStepper](INFO): Deisolating dock charge 2024-05-22T23:25:50.963Z,1716420350.963 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:52.566Z,1716420352.566 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:55.390Z,1716420355.390 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:56.604Z,1716420356.604 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:57.834Z,1716420357.834 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:25:59.036Z,1716420359.036 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:00.338Z,1716420360.338 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:01.839Z,1716420361.839 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:03.819Z,1716420363.819 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.007474 2024-05-22T23:26:03.941Z,1716420363.941 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:03.942Z,1716420363.942 [OnDock:H] Running Loop=1 2024-05-22T23:26:03.942Z,1716420363.942 [OnDock:H] Running Loop=1 2024-05-22T23:26:03.943Z,1716420363.943 [OnDock:H](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-22T23:26:07.588Z,1716420367.588 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:08.813Z,1716420368.813 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:10.704Z,1716420370.704 [CommandExec](IMPORTANT): got command failComponent 2024-05-22T23:26:10.705Z,1716420370.705 [CommandExec](IMPORTANT): Failed components: 2024-05-22T23:26:10.705Z,1716420370.705 [CommandExec](IMPORTANT): No failed Components. 2024-05-22T23:26:12.051Z,1716420372.051 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:13.648Z,1716420373.648 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:14.121Z,1716420374.121 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240522T231042/Courier0003.lzma 2024-05-22T23:26:15.122Z,1716420375.122 [DataOverHttps](INFO): Moved sent file to Logs/20240522T231042/Courier0003.lzma.bak 2024-05-22T23:26:15.122Z,1716420375.122 [DataOverHttps](INFO): SBD MOMSN=21073465 2024-05-22T23:26:15.651Z,1716420375.651 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:17.323Z,1716420377.323 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:20.604Z,1716420380.604 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-05-22T23:26:21.333Z,1716420381.333 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:22.238Z,1716420382.238 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:25.572Z,1716420385.572 [CommandExec](IMPORTANT): got command set OnDock.RangeTimeout 10 hour 2024-05-22T23:26:25.786Z,1716420385.786 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:28.171Z,1716420388.171 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:29.843Z,1716420389.843 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:31.814Z,1716420391.814 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:34.679Z,1716420394.679 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:36.643Z,1716420396.643 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:26:37.192Z,1716420397.192 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:38.356Z,1716420398.356 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240522T232506/Courier0000.lzma 2024-05-22T23:26:39.129Z,1716420399.129 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:39.358Z,1716420399.358 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Courier0000.lzma.bak 2024-05-22T23:26:39.358Z,1716420399.358 [DataOverHttps](INFO): SBD MOMSN=21073467 2024-05-22T23:26:41.172Z,1716420401.172 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:43.927Z,1716420403.927 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:45.169Z,1716420405.169 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:46.418Z,1716420406.418 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:47.744Z,1716420407.744 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:49.237Z,1716420409.237 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:51.242Z,1716420411.242 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:53.610Z,1716420413.610 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:26:55.254Z,1716420415.254 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:57.301Z,1716420417.301 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:26:58.889Z,1716420418.889 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:00.139Z,1716420420.139 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:02.970Z,1716420422.970 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:03.394Z,1716420423.394 [CommandExec](IMPORTANT): got command set Depth_Keller.depth 5 meter 2024-05-22T23:27:04.278Z,1716420424.278 [DataOverHttps](INFO): Sending 1793 bytes from file Logs/20240522T231042/Express0004.lzma 2024-05-22T23:27:04.596Z,1716420424.596 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:04.937Z,1716420424.937 [OnDock:I.](INFO): *** querying acoustic contact *** 2024-05-22T23:27:05.160Z,1716420425.160 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:27:05.161Z,1716420425.161 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:27:05.161Z,1716420425.161 [DAT](INFO): setting remote address to 0 2024-05-22T23:27:05.278Z,1716420425.278 [DataOverHttps](INFO): Moved sent file to Logs/20240522T231042/Express0004.lzma.bak 2024-05-22T23:27:05.278Z,1716420425.278 [DataOverHttps](INFO): SBD MOMSN=21073470 2024-05-22T23:27:05.348Z,1716420425.348 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:05.413Z,1716420425.413 [DAT](INFO): DAT read: user:6> 2024-05-22T23:27:05.414Z,1716420425.414 [DAT](INFO): DAT read: RemoteAddr | 0 2024-05-22T23:27:05.414Z,1716420425.414 [DAT](INFO): set remote address to 0 2024-05-22T23:27:05.414Z,1716420425.414 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:27:05.414Z,1716420425.414 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:27:05.415Z,1716420425.415 [DAT](INFO): Querying Benthos address 201 with one ping in standard two-way mode. 2024-05-22T23:27:05.665Z,1716420425.665 [DAT](INFO): DAT read: user:7> 2024-05-22T23:27:05.665Z,1716420425.665 [DAT](INFO): DAT read: Tx time:23:27:04.9732 2024-05-22T23:27:05.666Z,1716420425.666 [DAT](INFO): Ping request sent. 2024-05-22T23:27:05.666Z,1716420425.666 [DAT](INFO): transmitted an acoustic signal 2024-05-22T23:27:05.666Z,1716420425.666 [DAT](INFO): publishing transmit ping time 2024-05-22T23:27:05.667Z,1716420425.667 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000915 2024-05-22T23:27:05.918Z,1716420425.918 [DAT](INFO): DAT read: TxSync time:23:27:04.9724 2024-05-22T23:27:05.918Z,1716420425.918 [DAT](INFO): unknown deviceResponse_: TxSync time:23:27:04.9724 2024-05-22T23:27:05.919Z,1716420425.919 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252918 2024-05-22T23:27:06.169Z,1716420426.169 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502907 2024-05-22T23:27:06.421Z,1716420426.421 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755169 2024-05-22T23:27:06.673Z,1716420426.673 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006890 2024-05-22T23:27:06.925Z,1716420426.925 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259159 2024-05-22T23:27:07.177Z,1716420427.177 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510894 2024-05-22T23:27:07.429Z,1716420427.429 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763419 2024-05-22T23:27:07.681Z,1716420427.681 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015087 2024-05-22T23:27:07.873Z,1716420427.873 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:07.933Z,1716420427.933 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266999 2024-05-22T23:27:08.185Z,1716420428.185 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519167 2024-05-22T23:27:08.261Z,1716420428.261 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:27:08.437Z,1716420428.437 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770822 2024-05-22T23:27:08.692Z,1716420428.692 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.026454 2024-05-22T23:27:08.944Z,1716420428.944 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.277813 2024-05-22T23:27:09.197Z,1716420429.197 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.531560 2024-05-22T23:27:09.449Z,1716420429.449 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.783030 2024-05-22T23:27:09.495Z,1716420429.495 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:09.702Z,1716420429.702 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.035740 2024-05-22T23:27:09.953Z,1716420429.953 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.286962 2024-05-22T23:27:10.205Z,1716420430.205 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.539037 2024-05-22T23:27:10.457Z,1716420430.457 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.790884 2024-05-22T23:27:10.709Z,1716420430.709 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.043512 2024-05-22T23:27:10.789Z,1716420430.789 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:27:10.961Z,1716420430.961 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.294846 2024-05-22T23:27:11.213Z,1716420431.213 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.546992 2024-05-22T23:27:11.217Z,1716420431.217 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:11.465Z,1716420431.465 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.799073 2024-05-22T23:27:11.737Z,1716420431.737 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.070896 2024-05-22T23:27:11.991Z,1716420431.991 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.325133 2024-05-22T23:27:12.241Z,1716420432.241 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.574932 2024-05-22T23:27:12.493Z,1716420432.493 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.827103 2024-05-22T23:27:12.745Z,1716420432.745 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.078900 2024-05-22T23:27:12.829Z,1716420432.829 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:12.997Z,1716420432.997 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.331084 2024-05-22T23:27:13.249Z,1716420433.249 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.583279 2024-05-22T23:27:13.501Z,1716420433.501 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.835012 2024-05-22T23:27:13.753Z,1716420433.753 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.087285 2024-05-22T23:27:14.005Z,1716420434.005 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.338747 2024-05-22T23:27:14.257Z,1716420434.257 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.591187 2024-05-22T23:27:14.509Z,1716420434.509 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.842936 2024-05-22T23:27:14.761Z,1716420434.761 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.094874 2024-05-22T23:27:15.013Z,1716420435.013 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.347141 2024-05-22T23:27:15.223Z,1716420435.223 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 5 meter 2024-05-22T23:27:15.231Z,1716420435.231 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2024-05-22T23:27:15.265Z,1716420435.265 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.598982 2024-05-22T23:27:15.489Z,1716420435.489 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-22T23:27:15.517Z,1716420435.517 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.850927 2024-05-22T23:27:15.751Z,1716420435.751 [OnDock:O.Docked](FAULT): Off dock, range timeout exceeded 2024-05-22T23:27:18.037Z,1716420438.037 [DAT](INFO): DAT read: Response Not Received 2024-05-22T23:27:18.037Z,1716420438.037 [DAT](INFO): response not received 2024-05-22T23:27:18.037Z,1716420438.037 [DAT](ERROR): No response from remote modem. 2024-05-22T23:27:27.065Z,1716420447.065 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:27:29.130Z,1716420449.130 [DataOverHttps](INFO): Sending 674 bytes from file Logs/20240522T232506/Express0001.lzma 2024-05-22T23:27:30.130Z,1716420450.130 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Express0001.lzma.bak 2024-05-22T23:27:30.130Z,1716420450.130 [DataOverHttps](INFO): SBD MOMSN=21073525 2024-05-22T23:27:44.754Z,1716420464.754 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:27:52.283Z,1716420472.283 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240522T232506/Express0004.lzma 2024-05-22T23:27:53.286Z,1716420473.286 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Express0004.lzma.bak 2024-05-22T23:27:53.286Z,1716420473.286 [DataOverHttps](INFO): SBD MOMSN=21073546 2024-05-22T23:28:02.129Z,1716420482.129 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:28:14.187Z,1716420494.187 [DataOverHttps](IMPORTANT): SBD MTMSN=20240522T232812 2024-05-22T23:28:19.105Z,1716420499.105 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:28:32.385Z,1716420512.385 [DataOverHttps](INFO): Received command: get depth 2024-05-22T23:28:32.971Z,1716420512.971 [CommandExec](IMPORTANT): got command get depth 2024-05-22T23:28:32.971Z,1716420512.971 [CommandExec](IMPORTANT): depth 5.000000 m 2024-05-22T23:28:35.254Z,1716420515.254 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:28:41.437Z,1716420521.437 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240522T232506/Courier0006.lzma 2024-05-22T23:28:42.438Z,1716420522.438 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Courier0006.lzma.bak 2024-05-22T23:28:42.438Z,1716420522.438 [DataOverHttps](INFO): SBD MOMSN=21073560 2024-05-22T23:28:51.415Z,1716420531.415 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:29:05.263Z,1716420545.263 [OnDock:I.](INFO): *** querying acoustic contact *** 2024-05-22T23:29:05.436Z,1716420545.436 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:29:05.437Z,1716420545.437 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:29:05.437Z,1716420545.437 [DAT](INFO): Querying Benthos address 201 with one ping in standard two-way mode. 2024-05-22T23:29:05.689Z,1716420545.689 [DAT](INFO): DAT read: user:8> 2024-05-22T23:29:05.689Z,1716420545.689 [DAT](INFO): DAT read: Tx time:23:29:05.0243 2024-05-22T23:29:05.690Z,1716420545.690 [DAT](INFO): Ping request sent. 2024-05-22T23:29:05.690Z,1716420545.690 [DAT](INFO): transmitted an acoustic signal 2024-05-22T23:29:05.690Z,1716420545.690 [DAT](INFO): publishing transmit ping time 2024-05-22T23:29:05.691Z,1716420545.691 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000757 2024-05-22T23:29:05.941Z,1716420545.941 [DAT](INFO): DAT read: TxSync time:23:29:05.0235 2024-05-22T23:29:05.942Z,1716420545.942 [DAT](INFO): unknown deviceResponse_: TxSync time:23:29:05.0235 2024-05-22T23:29:05.942Z,1716420545.942 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252160 2024-05-22T23:29:06.193Z,1716420546.193 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502845 2024-05-22T23:29:06.372Z,1716420546.372 [DataOverHttps](INFO): Sending 462 bytes from file Logs/20240522T232506/Express0007.lzma 2024-05-22T23:29:06.446Z,1716420546.446 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755614 2024-05-22T23:29:06.697Z,1716420546.697 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006782 2024-05-22T23:29:06.950Z,1716420546.950 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259890 2024-05-22T23:29:07.201Z,1716420547.201 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.511253 2024-05-22T23:29:07.374Z,1716420547.374 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Express0007.lzma.bak 2024-05-22T23:29:07.374Z,1716420547.374 [DataOverHttps](INFO): SBD MOMSN=21073568 2024-05-22T23:29:07.453Z,1716420547.453 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762881 2024-05-22T23:29:07.705Z,1716420547.705 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015098 2024-05-22T23:29:07.957Z,1716420547.957 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.267032 2024-05-22T23:29:08.209Z,1716420548.209 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518879 2024-05-22T23:29:08.313Z,1716420548.313 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:29:08.461Z,1716420548.461 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771561 2024-05-22T23:29:08.713Z,1716420548.713 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023400 2024-05-22T23:29:08.965Z,1716420548.965 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274874 2024-05-22T23:29:09.217Z,1716420549.217 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527223 2024-05-22T23:29:09.469Z,1716420549.469 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779138 2024-05-22T23:29:09.721Z,1716420549.721 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030938 2024-05-22T23:29:09.973Z,1716420549.973 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.283352 2024-05-22T23:29:10.225Z,1716420550.225 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534786 2024-05-22T23:29:10.477Z,1716420550.477 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786801 2024-05-22T23:29:10.729Z,1716420550.729 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.038935 2024-05-22T23:29:10.981Z,1716420550.981 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290961 2024-05-22T23:29:11.233Z,1716420551.233 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542788 2024-05-22T23:29:11.485Z,1716420551.485 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794933 2024-05-22T23:29:11.737Z,1716420551.737 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046882 2024-05-22T23:29:11.989Z,1716420551.989 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298761 2024-05-22T23:29:12.241Z,1716420552.241 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.551157 2024-05-22T23:29:12.496Z,1716420552.496 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.806194 2024-05-22T23:29:12.745Z,1716420552.745 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054872 2024-05-22T23:29:12.997Z,1716420552.997 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307045 2024-05-22T23:29:13.254Z,1716420553.254 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.561306 2024-05-22T23:29:13.501Z,1716420553.501 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810857 2024-05-22T23:29:13.753Z,1716420553.753 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.063160 2024-05-22T23:29:14.005Z,1716420554.005 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.315013 2024-05-22T23:29:14.257Z,1716420554.257 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566889 2024-05-22T23:29:14.509Z,1716420554.509 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819575 2024-05-22T23:29:14.761Z,1716420554.761 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.070931 2024-05-22T23:29:15.013Z,1716420555.013 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.322866 2024-05-22T23:29:15.268Z,1716420555.268 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.577586 2024-05-22T23:29:15.517Z,1716420555.517 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.826884 2024-05-22T23:29:15.814Z,1716420555.814 [CommandExec](IMPORTANT): got command set acoustic_contact_range .1 meter 2024-05-22T23:29:18.041Z,1716420558.041 [DAT](INFO): DAT read: Response Not Received 2024-05-22T23:29:18.042Z,1716420558.042 [DAT](INFO): response not received 2024-05-22T23:29:18.042Z,1716420558.042 [DAT](ERROR): No response from remote modem. 2024-05-22T23:29:32.443Z,1716420572.443 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20240522T232506/Express0008.lzma 2024-05-22T23:29:33.442Z,1716420573.442 [DataOverHttps](INFO): Moved sent file to Logs/20240522T232506/Express0008.lzma.bak 2024-05-22T23:29:33.442Z,1716420573.442 [DataOverHttps](INFO): SBD MOMSN=21073611 2024-05-22T23:29:44.284Z,1716420584.284 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-05-22T23:30:05.096Z,1716420605.096 [Radio_Surface](INFO): Stop 2024-05-22T23:30:05.096Z,1716420605.096 [Radio_Surface](INFO): Powering down 2024-05-22T23:30:05.500Z,1716420605.500 [Radio_Surface](INFO): Stopping 2024-05-22T23:30:05.621Z,1716420605.621 [OnDock:PeriodicCheck:CheckIP:B.Wait](INFO): Done Waiting. 2024-05-22T23:30:05.621Z,1716420605.621 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped 2024-05-22T23:30:05.621Z,1716420605.621 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component. 2024-05-22T23:30:05.622Z,1716420605.622 [OnDock:PeriodicCheck:CheckIP](INFO): Completed OnDock:PeriodicCheck:CheckIP 2024-05-22T23:30:05.622Z,1716420605.622 [OnDock:PeriodicCheck:CheckIP] Stopped 2024-05-22T23:30:05.622Z,1716420605.622 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:30:05.622Z,1716420605.622 [OnDock:PeriodicCheck](INFO): Completed OnDock:PeriodicCheck 2024-05-22T23:30:05.904Z,1716420605.904 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck] Running Loop=1 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2024-05-22T23:30:06.105Z,1716420606.105 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2024-05-22T23:30:06.173Z,1716420606.173 [CommandExec](IMPORTANT): got command ! ifconfig 2024-05-22T23:30:06.308Z,1716420606.308 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:06.377Z,1716420606.377 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:134.89.93.61 Bcast:134.89.93.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:9826 errors:0 dropped:0 overruns:0 frame:0 TX packets:10780 errors:0 dropped:0 overruns:0 carrier:0 collisions:19 txqueuelen:1000 RX bytes:3528605 (3.3 Mb) TX bytes:2117467 (2.0 Mb) Interrupt:29 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1 RX packets:382 errors:0 dropped:0 overruns:0 frame:0 TX packets:382 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:31300 (30.5 Kb) TX bytes:31300 (30.5 Kb) 2024-05-22T23:30:06.712Z,1716420606.712 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:07.116Z,1716420607.116 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:07.520Z,1716420607.520 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:07.924Z,1716420607.924 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:08.328Z,1716420608.328 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:08.732Z,1716420608.732 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:09.136Z,1716420609.136 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:09.540Z,1716420609.540 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:09.944Z,1716420609.944 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:10.348Z,1716420610.348 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:10.752Z,1716420610.752 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:11.156Z,1716420611.156 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:11.560Z,1716420611.560 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:11.964Z,1716420611.964 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:12.368Z,1716420612.368 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:12.772Z,1716420612.772 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:13.176Z,1716420613.176 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:13.581Z,1716420613.581 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:13.984Z,1716420613.984 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:14.388Z,1716420614.388 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:14.792Z,1716420614.792 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:15.196Z,1716420615.196 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:15.600Z,1716420615.600 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:16.004Z,1716420616.004 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:16.408Z,1716420616.408 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:16.813Z,1716420616.813 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:17.217Z,1716420617.217 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:17.620Z,1716420617.620 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:18.024Z,1716420618.024 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:18.428Z,1716420618.428 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:18.832Z,1716420618.832 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:19.236Z,1716420619.236 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:19.640Z,1716420619.640 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:19.988Z,1716420619.988 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-05-22T23:30:19.988Z,1716420619.988 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:30:20.044Z,1716420620.044 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:20.448Z,1716420620.448 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:20.852Z,1716420620.852 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:21.256Z,1716420621.256 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:21.660Z,1716420621.660 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:22.064Z,1716420622.064 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:22.468Z,1716420622.468 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:22.872Z,1716420622.872 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:23.276Z,1716420623.276 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:23.680Z,1716420623.680 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:24.084Z,1716420624.084 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:24.488Z,1716420624.488 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:24.892Z,1716420624.892 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:25.296Z,1716420625.296 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:25.700Z,1716420625.700 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:26.104Z,1716420626.104 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:26.513Z,1716420626.513 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:26.916Z,1716420626.916 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:27.321Z,1716420627.321 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:27.724Z,1716420627.724 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:28.128Z,1716420628.128 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:28.535Z,1716420628.535 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:28.936Z,1716420628.936 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:29.341Z,1716420629.341 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:29.744Z,1716420629.744 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:30.148Z,1716420630.148 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:30.552Z,1716420630.552 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:30.956Z,1716420630.956 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:31.362Z,1716420631.362 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:31.764Z,1716420631.764 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:32.168Z,1716420632.168 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:32.577Z,1716420632.577 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:32.980Z,1716420632.980 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:33.386Z,1716420633.386 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:33.788Z,1716420633.788 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:34.192Z,1716420634.192 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:34.596Z,1716420634.596 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:35.001Z,1716420635.001 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:35.408Z,1716420635.408 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:35.808Z,1716420635.808 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:36.213Z,1716420636.213 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:36.622Z,1716420636.622 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:37.025Z,1716420637.025 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:37.429Z,1716420637.429 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:37.832Z,1716420637.832 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:38.236Z,1716420638.236 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:38.640Z,1716420638.640 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:39.044Z,1716420639.044 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:39.449Z,1716420639.449 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:39.853Z,1716420639.853 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:40.256Z,1716420640.256 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:40.625Z,1716420640.625 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:30:40.660Z,1716420640.660 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:41.064Z,1716420641.064 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:41.469Z,1716420641.469 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:41.874Z,1716420641.874 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:42.277Z,1716420642.277 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:42.680Z,1716420642.680 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:43.084Z,1716420643.084 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:43.489Z,1716420643.489 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:43.893Z,1716420643.893 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:44.296Z,1716420644.296 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:44.700Z,1716420644.700 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:45.104Z,1716420645.104 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:45.508Z,1716420645.508 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:45.912Z,1716420645.912 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:46.316Z,1716420646.316 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:46.721Z,1716420646.721 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:47.124Z,1716420647.124 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:47.528Z,1716420647.528 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:47.932Z,1716420647.932 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:48.336Z,1716420648.336 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:48.740Z,1716420648.740 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:49.144Z,1716420649.144 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:49.548Z,1716420649.548 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:49.952Z,1716420649.952 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:50.357Z,1716420650.357 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:50.761Z,1716420650.761 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:51.165Z,1716420651.165 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:51.568Z,1716420651.568 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:51.973Z,1716420651.973 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:52.378Z,1716420652.378 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:52.780Z,1716420652.780 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:53.186Z,1716420653.186 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:53.588Z,1716420653.588 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:53.992Z,1716420653.992 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:54.396Z,1716420654.396 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:54.800Z,1716420654.800 [Radio_Surface](INFO): Stopped 2024-05-22T23:30:55.045Z,1716420655.045 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:30:55.204Z,1716420655.204 [Radio_Surface](INFO): Start 2024-05-22T23:30:55.204Z,1716420655.204 [Radio_Surface](INFO): Powering up 2024-05-22T23:30:55.609Z,1716420655.609 [Radio_Surface](INFO): Starting 2024-05-22T23:30:56.012Z,1716420656.012 [Radio_Surface](INFO): Starting 2024-05-22T23:30:56.417Z,1716420656.417 [Radio_Surface](INFO): Starting 2024-05-22T23:30:56.820Z,1716420656.820 [Radio_Surface](INFO): Starting 2024-05-22T23:30:57.225Z,1716420657.225 [Radio_Surface](INFO): Starting 2024-05-22T23:30:57.628Z,1716420657.628 [Radio_Surface](INFO): Starting 2024-05-22T23:30:58.033Z,1716420658.033 [Radio_Surface](INFO): Starting 2024-05-22T23:30:58.436Z,1716420658.436 [Radio_Surface](INFO): Starting 2024-05-22T23:30:58.841Z,1716420658.841 [Radio_Surface](INFO): Starting 2024-05-22T23:30:59.244Z,1716420659.244 [Radio_Surface](INFO): Starting 2024-05-22T23:30:59.648Z,1716420659.648 [Radio_Surface](INFO): Starting 2024-05-22T23:31:00.052Z,1716420660.052 [Radio_Surface](INFO): Starting 2024-05-22T23:31:00.457Z,1716420660.457 [Radio_Surface](INFO): Starting 2024-05-22T23:31:00.457Z,1716420660.457 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-05-22T23:31:00.458Z,1716420660.458 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:31:00.458Z,1716420660.458 [Radio_Surface](IMPORTANT): Local IP not on subnet 10.89.10, restarting DHCP 2024-05-22T23:31:00.510Z,1716420660.510 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:31:01.170Z,1716420661.170 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC233101_sh 2024-05-22T23:31:01.264Z,1716420661.264 [Radio_Surface](INFO): Stop 2024-05-22T23:31:01.264Z,1716420661.264 [Radio_Surface](INFO): Powering down 2024-05-22T23:31:01.669Z,1716420661.669 [Radio_Surface](INFO): Stopping 2024-05-22T23:31:02.072Z,1716420662.072 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:02.476Z,1716420662.476 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:02.639Z,1716420662.639 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:31:02.880Z,1716420662.880 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:03.284Z,1716420663.284 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:03.688Z,1716420663.688 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:04.092Z,1716420664.092 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:04.496Z,1716420664.496 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:04.901Z,1716420664.901 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:05.283Z,1716420665.283 [OnDock:I.](INFO): *** querying acoustic contact *** 2024-05-22T23:31:05.304Z,1716420665.304 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:05.449Z,1716420665.449 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:31:05.449Z,1716420665.449 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:31:05.449Z,1716420665.449 [DAT](INFO): Querying Benthos address 201 with one ping in standard two-way mode. 2024-05-22T23:31:05.701Z,1716420665.701 [DAT](INFO): DAT read: user:9> 2024-05-22T23:31:05.702Z,1716420665.702 [DAT](INFO): DAT read: Tx time:23:31:05.0252 2024-05-22T23:31:05.702Z,1716420665.702 [DAT](INFO): Ping request sent. 2024-05-22T23:31:05.702Z,1716420665.702 [DAT](INFO): transmitted an acoustic signal 2024-05-22T23:31:05.702Z,1716420665.702 [DAT](INFO): publishing transmit ping time 2024-05-22T23:31:05.703Z,1716420665.703 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000809 2024-05-22T23:31:05.709Z,1716420665.709 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:05.953Z,1716420665.953 [DAT](INFO): DAT read: TxSync time:23:31:05.0245 2024-05-22T23:31:05.953Z,1716420665.953 [DAT](INFO): unknown deviceResponse_: TxSync time:23:31:05.0245 2024-05-22T23:31:05.954Z,1716420665.954 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251958 2024-05-22T23:31:06.120Z,1716420666.120 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:06.206Z,1716420666.206 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503659 2024-05-22T23:31:06.457Z,1716420666.457 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755159 2024-05-22T23:31:06.524Z,1716420666.524 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:06.709Z,1716420666.709 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006784 2024-05-22T23:31:06.929Z,1716420666.929 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:06.961Z,1716420666.961 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258888 2024-05-22T23:31:07.213Z,1716420667.213 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.511066 2024-05-22T23:31:07.332Z,1716420667.332 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:07.466Z,1716420667.466 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763864 2024-05-22T23:31:07.717Z,1716420667.717 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015090 2024-05-22T23:31:07.739Z,1716420667.739 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:07.969Z,1716420667.969 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.267071 2024-05-22T23:31:08.140Z,1716420668.140 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:08.221Z,1716420668.221 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519275 2024-05-22T23:31:08.473Z,1716420668.473 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770774 2024-05-22T23:31:08.475Z,1716420668.475 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:31:08.544Z,1716420668.544 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:08.725Z,1716420668.725 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022994 2024-05-22T23:31:08.949Z,1716420668.949 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:08.977Z,1716420668.977 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.275004 2024-05-22T23:31:09.229Z,1716420669.229 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526701 2024-05-22T23:31:09.353Z,1716420669.353 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:09.481Z,1716420669.481 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779021 2024-05-22T23:31:09.733Z,1716420669.733 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.031057 2024-05-22T23:31:09.756Z,1716420669.756 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:09.985Z,1716420669.985 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282674 2024-05-22T23:31:10.160Z,1716420670.160 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:10.242Z,1716420670.242 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.539672 2024-05-22T23:31:10.493Z,1716420670.493 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.790732 2024-05-22T23:31:10.564Z,1716420670.564 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:10.745Z,1716420670.745 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.042677 2024-05-22T23:31:10.859Z,1716420670.859 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:31:10.970Z,1716420670.970 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:10.997Z,1716420670.997 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.295172 2024-05-22T23:31:11.249Z,1716420671.249 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.546754 2024-05-22T23:31:11.372Z,1716420671.372 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:11.501Z,1716420671.501 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.798755 2024-05-22T23:31:11.753Z,1716420671.753 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.051015 2024-05-22T23:31:11.776Z,1716420671.776 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:12.005Z,1716420672.005 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.302742 2024-05-22T23:31:12.180Z,1716420672.180 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:12.258Z,1716420672.258 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.555696 2024-05-22T23:31:12.509Z,1716420672.509 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.806723 2024-05-22T23:31:12.584Z,1716420672.584 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:12.761Z,1716420672.761 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.058897 2024-05-22T23:31:12.990Z,1716420672.990 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:13.033Z,1716420673.033 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.330620 2024-05-22T23:31:13.285Z,1716420673.285 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.582519 2024-05-22T23:31:13.392Z,1716420673.392 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:13.537Z,1716420673.537 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.834797 2024-05-22T23:31:13.789Z,1716420673.789 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.086681 2024-05-22T23:31:13.797Z,1716420673.797 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:14.041Z,1716420674.041 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.338873 2024-05-22T23:31:14.200Z,1716420674.200 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:14.293Z,1716420674.293 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.591028 2024-05-22T23:31:14.545Z,1716420674.545 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.842769 2024-05-22T23:31:14.604Z,1716420674.604 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:14.797Z,1716420674.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.095050 2024-05-22T23:31:15.009Z,1716420675.009 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:15.052Z,1716420675.052 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.349232 2024-05-22T23:31:15.301Z,1716420675.301 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.598676 2024-05-22T23:31:15.412Z,1716420675.412 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:15.553Z,1716420675.553 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.851053 2024-05-22T23:31:15.816Z,1716420675.816 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:16.220Z,1716420676.220 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:16.626Z,1716420676.626 [Radio_Surface](INFO): Start 2024-05-22T23:31:16.626Z,1716420676.626 [Radio_Surface](INFO): Powering up 2024-05-22T23:31:17.029Z,1716420677.029 [Radio_Surface](INFO): Starting 2024-05-22T23:31:17.433Z,1716420677.433 [Radio_Surface](INFO): Starting 2024-05-22T23:31:17.836Z,1716420677.836 [Radio_Surface](INFO): Starting 2024-05-22T23:31:18.075Z,1716420678.075 [DAT](INFO): DAT read: Response Not Received 2024-05-22T23:31:18.076Z,1716420678.076 [DAT](INFO): response not received 2024-05-22T23:31:18.077Z,1716420678.077 [DAT](ERROR): No response from remote modem. 2024-05-22T23:31:18.240Z,1716420678.240 [Radio_Surface](INFO): Starting 2024-05-22T23:31:18.644Z,1716420678.644 [Radio_Surface](INFO): Starting 2024-05-22T23:31:19.050Z,1716420679.050 [Radio_Surface](INFO): Starting 2024-05-22T23:31:19.452Z,1716420679.452 [Radio_Surface](INFO): Starting 2024-05-22T23:31:19.856Z,1716420679.856 [Radio_Surface](INFO): Starting 2024-05-22T23:31:20.260Z,1716420680.260 [Radio_Surface](INFO): Starting 2024-05-22T23:31:20.665Z,1716420680.665 [Radio_Surface](INFO): Starting 2024-05-22T23:31:21.068Z,1716420681.068 [Radio_Surface](INFO): Starting 2024-05-22T23:31:21.472Z,1716420681.472 [Radio_Surface](INFO): Starting 2024-05-22T23:31:21.876Z,1716420681.876 [Radio_Surface](INFO): Starting 2024-05-22T23:31:21.876Z,1716420681.876 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-05-22T23:31:21.877Z,1716420681.877 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:31:21.877Z,1716420681.877 [Radio_Surface](IMPORTANT): Local IP not on subnet 10.89.10, restarting DHCP 2024-05-22T23:31:21.929Z,1716420681.929 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:31:22.684Z,1716420682.684 [Radio_Surface](INFO): Stop 2024-05-22T23:31:22.685Z,1716420682.685 [Radio_Surface](INFO): Powering down 2024-05-22T23:31:22.769Z,1716420682.769 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC233122_sh 2024-05-22T23:31:23.089Z,1716420683.089 [Radio_Surface](INFO): Stopping 2024-05-22T23:31:23.492Z,1716420683.492 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:23.896Z,1716420683.896 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:24.300Z,1716420684.300 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:24.704Z,1716420684.704 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:25.108Z,1716420685.108 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:25.149Z,1716420685.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:31:25.512Z,1716420685.512 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:25.916Z,1716420685.916 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:26.218Z,1716420686.218 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:31:26.320Z,1716420686.320 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:26.725Z,1716420686.725 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:27.129Z,1716420687.129 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:27.532Z,1716420687.532 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:27.936Z,1716420687.936 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:28.340Z,1716420688.340 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:28.744Z,1716420688.744 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:29.148Z,1716420689.148 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:29.552Z,1716420689.552 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:29.956Z,1716420689.956 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:30.360Z,1716420690.360 [Radio_Surface](INFO): Start 2024-05-22T23:31:30.360Z,1716420690.360 [Radio_Surface](INFO): Powering up 2024-05-22T23:31:30.733Z,1716420690.733 [CommandExec](IMPORTANT): got command get depth 2024-05-22T23:31:30.733Z,1716420690.733 [CommandExec](IMPORTANT): depth 0.999260 m 2024-05-22T23:31:30.764Z,1716420690.764 [Radio_Surface](INFO): Starting 2024-05-22T23:31:31.168Z,1716420691.168 [Radio_Surface](INFO): Starting 2024-05-22T23:31:31.580Z,1716420691.580 [Radio_Surface](INFO): Starting 2024-05-22T23:31:31.984Z,1716420691.984 [Radio_Surface](INFO): Starting 2024-05-22T23:31:32.388Z,1716420692.388 [Radio_Surface](INFO): Starting 2024-05-22T23:31:32.792Z,1716420692.792 [Radio_Surface](INFO): Starting 2024-05-22T23:31:33.196Z,1716420693.196 [Radio_Surface](INFO): Starting 2024-05-22T23:31:33.600Z,1716420693.600 [Radio_Surface](INFO): Starting 2024-05-22T23:31:34.004Z,1716420694.004 [Radio_Surface](INFO): Starting 2024-05-22T23:31:34.408Z,1716420694.408 [Radio_Surface](INFO): Starting 2024-05-22T23:31:34.812Z,1716420694.812 [Radio_Surface](INFO): Starting 2024-05-22T23:31:35.216Z,1716420695.216 [Radio_Surface](INFO): Starting 2024-05-22T23:31:35.620Z,1716420695.620 [Radio_Surface](INFO): Starting 2024-05-22T23:31:35.620Z,1716420695.620 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-05-22T23:31:35.621Z,1716420695.621 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:31:35.621Z,1716420695.621 [Radio_Surface](IMPORTANT): Local IP not on subnet 10.89.10, restarting DHCP 2024-05-22T23:31:35.623Z,1716420695.623 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:31:36.287Z,1716420696.287 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC233136_sh 2024-05-22T23:31:36.428Z,1716420696.428 [Radio_Surface](INFO): Stop 2024-05-22T23:31:36.428Z,1716420696.428 [Radio_Surface](INFO): Powering down 2024-05-22T23:31:36.833Z,1716420696.833 [Radio_Surface](INFO): Stopping 2024-05-22T23:31:37.236Z,1716420697.236 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:37.640Z,1716420697.640 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:38.044Z,1716420698.044 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:38.448Z,1716420698.448 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:38.852Z,1716420698.852 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:39.256Z,1716420699.256 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:39.660Z,1716420699.660 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:40.065Z,1716420700.065 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:40.468Z,1716420700.468 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:40.872Z,1716420700.872 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:41.277Z,1716420701.277 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:41.680Z,1716420701.680 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:42.003Z,1716420702.003 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:31:42.084Z,1716420702.084 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:42.488Z,1716420702.488 [Radio_Surface](INFO): Stopped 2024-05-22T23:31:42.892Z,1716420702.892 [Radio_Surface](INFO): Start 2024-05-22T23:31:42.892Z,1716420702.892 [Radio_Surface](INFO): Powering up 2024-05-22T23:31:42.941Z,1716420702.941 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:31:43.296Z,1716420703.296 [Radio_Surface](INFO): Starting 2024-05-22T23:31:43.702Z,1716420703.702 [Radio_Surface](INFO): Starting 2024-05-22T23:31:44.104Z,1716420704.104 [Radio_Surface](INFO): Starting 2024-05-22T23:31:44.512Z,1716420704.512 [Radio_Surface](INFO): Starting 2024-05-22T23:31:44.917Z,1716420704.917 [Radio_Surface](INFO): Starting 2024-05-22T23:31:45.112Z,1716420705.112 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 5 meter 2024-05-22T23:31:45.320Z,1716420705.320 [Radio_Surface](INFO): Starting 2024-05-22T23:31:45.724Z,1716420705.724 [Radio_Surface](INFO): Starting 2024-05-22T23:31:46.128Z,1716420706.128 [Radio_Surface](INFO): Starting 2024-05-22T23:31:46.532Z,1716420706.532 [Radio_Surface](INFO): Starting 2024-05-22T23:31:46.936Z,1716420706.936 [Radio_Surface](INFO): Starting 2024-05-22T23:31:47.340Z,1716420707.340 [Radio_Surface](INFO): Starting 2024-05-22T23:31:47.744Z,1716420707.744 [Radio_Surface](INFO): Starting 2024-05-22T23:31:48.148Z,1716420708.148 [Radio_Surface](INFO): Starting 2024-05-22T23:31:48.149Z,1716420708.149 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-05-22T23:31:48.149Z,1716420708.149 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:31:48.150Z,1716420708.150 [Radio_Surface](IMPORTANT): Local IP not on subnet 10.89.10, restarting DHCP 2024-05-22T23:31:48.240Z,1716420708.240 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:31:48.921Z,1716420708.921 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC233148_sh 2024-05-22T23:31:51.037Z,1716420711.037 [DataOverHttps](INFO): Radio surface powered ON. 2024-05-22T23:31:56.976Z,1716420716.976 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:32:04.168Z,1716420724.168 [CommandExec](IMPORTANT): got command show best depth 2024-05-22T23:32:04.168Z,1716420724.168 [CommandExec](IMPORTANT): depth best is Depth_Keller.depth 2024-05-22T23:32:10.592Z,1716420730.592 [CommandExec](IMPORTANT): got command get Depth_Keller.depth 2024-05-22T23:32:10.593Z,1716420730.593 [CommandExec](IMPORTANT): Depth_Keller.depth 5.000000 m 2024-05-22T23:32:11.547Z,1716420731.547 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:32:27.302Z,1716420747.302 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:32:42.655Z,1716420762.655 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:32:46.902Z,1716420766.902 [DockingStepper](ERROR): getADC uart error serial timeout 2024-05-22T23:32:46.902Z,1716420766.902 [DockingStepper](FAULT): uart error - getPosition..serial timeout 2024-05-22T23:32:46.902Z,1716420766.902 [DockingStepper] Communications Fault, FailCount= 1 2024-05-22T23:32:46.902Z,1716420766.902 [DockingStepper](ERROR): Communications Fault 2024-05-22T23:32:46.907Z,1716420766.907 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-05-22T23:32:47.083Z,1716420767.083 [DockingStepper](INFO): Stop 2024-05-22T23:32:47.083Z,1716420767.083 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-05-22T23:32:47.084Z,1716420767.084 [DockingStepper](INFO): Powering down 2024-05-22T23:32:47.445Z,1716420767.445 [DockingStepper](INFO): Stopping 2024-05-22T23:32:47.797Z,1716420767.797 [DockingStepper](INFO): Stopped 2024-05-22T23:32:47.807Z,1716420767.807 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-05-22T23:32:47.807Z,1716420767.807 [DockingStepper] No Fault, FailCount= 1 2024-05-22T23:32:48.202Z,1716420768.202 [DockingStepper](INFO): Start 2024-05-22T23:32:48.203Z,1716420768.203 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-22T23:32:48.203Z,1716420768.203 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-22T23:32:48.633Z,1716420768.633 [DockingStepper](INFO): Starting 2024-05-22T23:32:49.001Z,1716420769.001 [DockingStepper](INFO): Starting 2024-05-22T23:32:49.473Z,1716420769.473 [DockingStepper](INFO): Starting 2024-05-22T23:32:49.527Z,1716420769.527 [DockingStepper](INFO): Init string: /1z16080aE13561N3m50 2024-05-22T23:32:49.830Z,1716420769.830 [DockingStepper](INFO): Starting 2024-05-22T23:32:50.212Z,1716420770.212 [DockingStepper](INFO): Starting 2024-05-22T23:32:50.667Z,1716420770.667 [DockingStepper](INFO): Starting 2024-05-22T23:32:51.038Z,1716420771.038 [DockingStepper](INFO): Starting 2024-05-22T23:32:51.078Z,1716420771.078 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-22T23:32:51.485Z,1716420771.485 [DockingStepper](INFO): Starting 2024-05-22T23:32:51.831Z,1716420771.831 [DockingStepper](INFO): Deisolating dock charge 2024-05-22T23:32:59.137Z,1716420779.137 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-22T23:33:05.742Z,1716420785.742 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:33:05.835Z,1716420785.835 [OnDock:I.](INFO): *** querying acoustic contact *** 2024-05-22T23:33:05.902Z,1716420785.902 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:33:05.903Z,1716420785.903 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:33:05.903Z,1716420785.903 [DAT](INFO): Querying Benthos address 201 with one ping in standard two-way mode. 2024-05-22T23:33:06.156Z,1716420786.156 [DAT](INFO): DAT read: user:10> 2024-05-22T23:33:06.158Z,1716420786.158 [DAT](INFO): DAT read: Tx time:23:33:04.5262 2024-05-22T23:33:06.158Z,1716420786.158 [DAT](INFO): Ping request sent. 2024-05-22T23:33:06.158Z,1716420786.158 [DAT](INFO): transmitted an acoustic signal 2024-05-22T23:33:06.159Z,1716420786.159 [DAT](INFO): publishing transmit ping time 2024-05-22T23:33:06.159Z,1716420786.159 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000946 2024-05-22T23:33:06.406Z,1716420786.406 [DAT](INFO): DAT read: TxSync time:23:33:04.5254 2024-05-22T23:33:06.407Z,1716420786.407 [DAT](INFO): unknown deviceResponse_: TxSync time:23:33:04.5254 2024-05-22T23:33:06.407Z,1716420786.407 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.248882 2024-05-22T23:33:06.658Z,1716420786.658 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.499995 2024-05-22T23:33:06.911Z,1716420786.911 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.752033 2024-05-22T23:33:07.163Z,1716420787.163 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.004286 2024-05-22T23:33:07.414Z,1716420787.414 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.255935 2024-05-22T23:33:07.666Z,1716420787.666 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.508026 2024-05-22T23:33:07.918Z,1716420787.918 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.759993 2024-05-22T23:33:08.171Z,1716420788.171 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.012626 2024-05-22T23:33:08.422Z,1716420788.422 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.264027 2024-05-22T23:33:08.497Z,1716420788.497 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:33:08.674Z,1716420788.674 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.515961 2024-05-22T23:33:08.927Z,1716420788.927 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.768089 2024-05-22T23:33:09.178Z,1716420789.178 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.019987 2024-05-22T23:33:09.430Z,1716420789.430 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.271924 2024-05-22T23:33:09.682Z,1716420789.682 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.523966 2024-05-22T23:33:09.935Z,1716420789.935 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.776146 2024-05-22T23:33:10.187Z,1716420790.187 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.028150 2024-05-22T23:33:10.438Z,1716420790.438 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.280006 2024-05-22T23:33:10.690Z,1716420790.690 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.532057 2024-05-22T23:33:10.942Z,1716420790.942 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.783930 2024-05-22T23:33:11.194Z,1716420791.194 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.035994 2024-05-22T23:33:11.446Z,1716420791.446 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.288049 2024-05-22T23:33:11.698Z,1716420791.698 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.540054 2024-05-22T23:33:11.951Z,1716420791.951 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.792273 2024-05-22T23:33:12.207Z,1716420792.207 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.047774 2024-05-22T23:33:12.454Z,1716420792.454 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.296011 2024-05-22T23:33:12.706Z,1716420792.706 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.548014 2024-05-22T23:33:12.958Z,1716420792.958 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.799983 2024-05-22T23:33:13.210Z,1716420793.210 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.051956 2024-05-22T23:33:13.467Z,1716420793.467 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.308140 2024-05-22T23:33:13.717Z,1716420793.717 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.557584 2024-05-22T23:33:13.966Z,1716420793.966 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.807890 2024-05-22T23:33:14.219Z,1716420794.219 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.060239 2024-05-22T23:33:14.470Z,1716420794.470 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.312024 2024-05-22T23:33:14.726Z,1716420794.726 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.568004 2024-05-22T23:33:14.978Z,1716420794.978 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819977 2024-05-22T23:33:15.231Z,1716420795.231 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.072582 2024-05-22T23:33:15.482Z,1716420795.482 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.323833 2024-05-22T23:33:15.736Z,1716420795.736 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.577494 2024-05-22T23:33:15.986Z,1716420795.986 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.827910 2024-05-22T23:33:18.507Z,1716420798.507 [DAT](INFO): DAT read: Response Not Received 2024-05-22T23:33:18.507Z,1716420798.507 [DAT](INFO): response not received 2024-05-22T23:33:18.507Z,1716420798.507 [DAT](ERROR): No response from remote modem. 2024-05-22T23:33:26.150Z,1716420806.150 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 5 meter 2024-05-22T23:33:39.970Z,1716420819.970 [CommandExec](IMPORTANT): got command get Depth_Keller.depth 2024-05-22T23:33:39.970Z,1716420819.970 [CommandExec](IMPORTANT): Depth_Keller.depth 5.000000 m 2024-05-22T23:34:04.503Z,1716420844.503 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:34:38.894Z,1716420878.894 [CommandExec](IMPORTANT): got command get Depth_Keller.depth 2024-05-22T23:34:38.895Z,1716420878.895 [CommandExec](IMPORTANT): Depth_Keller.depth 5.000000 m 2024-05-22T23:35:06.148Z,1716420906.148 [OnDock:I.](INFO): *** querying acoustic contact *** 2024-05-22T23:35:06.170Z,1716420906.170 [DAT](INFO): ****** received valid address query ****** 2024-05-22T23:35:06.170Z,1716420906.170 [DAT](INFO): ****** received valid ping request ****** 2024-05-22T23:35:06.171Z,1716420906.171 [DAT](INFO): Querying Benthos address 201 with one ping in standard two-way mode. 2024-05-22T23:35:06.422Z,1716420906.422 [DAT](INFO): DAT read: user:11> 2024-05-22T23:35:06.423Z,1716420906.423 [DAT](INFO): DAT read: Tx time:23:35:04.8272 2024-05-22T23:35:06.423Z,1716420906.423 [DAT](INFO): Ping request sent. 2024-05-22T23:35:06.424Z,1716420906.424 [DAT](INFO): transmitted an acoustic signal 2024-05-22T23:35:06.424Z,1716420906.424 [DAT](INFO): publishing transmit ping time 2024-05-22T23:35:06.424Z,1716420906.424 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000762 2024-05-22T23:35:06.622Z,1716420906.622 [OnDock:PeriodicCheck:CheckIP:B.Wait](INFO): Done Waiting. 2024-05-22T23:35:06.622Z,1716420906.622 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped 2024-05-22T23:35:06.622Z,1716420906.622 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component. 2024-05-22T23:35:06.623Z,1716420906.623 [OnDock:PeriodicCheck:CheckIP](INFO): Completed OnDock:PeriodicCheck:CheckIP 2024-05-22T23:35:06.623Z,1716420906.623 [OnDock:PeriodicCheck:CheckIP] Stopped 2024-05-22T23:35:06.623Z,1716420906.623 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:35:06.623Z,1716420906.623 [OnDock:PeriodicCheck](INFO): Completed OnDock:PeriodicCheck 2024-05-22T23:35:06.675Z,1716420906.675 [DAT](INFO): DAT read: TxSync time:23:35:04.8264 2024-05-22T23:35:06.675Z,1716420906.675 [DAT](INFO): unknown deviceResponse_: TxSync time:23:35:04.8264 2024-05-22T23:35:06.676Z,1716420906.676 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252428 2024-05-22T23:35:06.926Z,1716420906.926 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502638 2024-05-22T23:35:07.025Z,1716420907.025 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:35:07.190Z,1716420907.190 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.766845 2024-05-22T23:35:07.205Z,1716420907.205 [OnDock:PeriodicCheck] Running Loop=1 2024-05-22T23:35:07.205Z,1716420907.205 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2024-05-22T23:35:07.205Z,1716420907.205 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2024-05-22T23:35:07.209Z,1716420907.209 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:35:07.210Z,1716420907.210 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2024-05-22T23:35:07.210Z,1716420907.210 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2024-05-22T23:35:07.210Z,1716420907.210 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2024-05-22T23:35:07.210Z,1716420907.210 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2024-05-22T23:35:07.210Z,1716420907.210 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2024-05-22T23:35:07.287Z,1716420907.287 [CommandExec](IMPORTANT): got command ! ifconfig 2024-05-22T23:35:07.443Z,1716420907.443 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.019468 2024-05-22T23:35:07.551Z,1716420907.551 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:134.89.93.61 Bcast:134.89.93.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:11324 errors:0 dropped:0 overruns:0 frame:0 TX packets:12376 errors:0 dropped:0 overruns:0 carrier:0 collisions:20 txqueuelen:1000 RX bytes:3727439 (3.5 Mb) TX bytes:2360705 (2.2 Mb) Interrupt:29 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1 RX packets:382 errors:0 dropped:0 overruns:0 frame:0 TX packets:382 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:31300 (30.5 Kb) TX bytes:31300 (30.5 Kb) 2024-05-22T23:35:07.694Z,1716420907.694 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.270810 2024-05-22T23:35:07.947Z,1716420907.947 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.522980 2024-05-22T23:35:08.199Z,1716420908.199 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.774949 2024-05-22T23:35:08.451Z,1716420908.451 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.027130 2024-05-22T23:35:08.702Z,1716420908.702 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.278735 2024-05-22T23:35:08.812Z,1716420908.812 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:35:08.956Z,1716420908.956 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.532166 2024-05-22T23:35:09.207Z,1716420909.207 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.783097 2024-05-22T23:35:09.459Z,1716420909.459 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.034946 2024-05-22T23:35:09.711Z,1716420909.711 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.287186 2024-05-22T23:35:09.962Z,1716420909.962 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.538845 2024-05-22T23:35:10.214Z,1716420910.214 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.790875 2024-05-22T23:35:10.467Z,1716420910.467 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.043505 2024-05-22T23:35:10.718Z,1716420910.718 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.294838 2024-05-22T23:35:10.971Z,1716420910.971 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.547338 2024-05-22T23:35:11.223Z,1716420911.223 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.799122 2024-05-22T23:35:11.474Z,1716420911.474 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.050843 2024-05-22T23:35:11.726Z,1716420911.726 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.302874 2024-05-22T23:35:11.978Z,1716420911.978 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.554819 2024-05-22T23:35:12.230Z,1716420912.230 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.806873 2024-05-22T23:35:12.483Z,1716420912.483 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.059342 2024-05-22T23:35:12.734Z,1716420912.734 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.310792 2024-05-22T23:35:12.987Z,1716420912.987 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.563561 2024-05-22T23:35:13.238Z,1716420913.238 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.814747 2024-05-22T23:35:13.490Z,1716420913.490 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.066866 2024-05-22T23:35:13.743Z,1716420913.743 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.318970 2024-05-22T23:35:13.994Z,1716420913.994 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.570759 2024-05-22T23:35:14.246Z,1716420914.246 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.822782 2024-05-22T23:35:14.499Z,1716420914.499 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.075629 2024-05-22T23:35:14.750Z,1716420914.750 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.326679 2024-05-22T23:35:15.006Z,1716420915.006 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.582124 2024-05-22T23:35:15.254Z,1716420915.254 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.830776 2024-05-22T23:35:15.506Z,1716420915.506 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.082788 2024-05-22T23:35:15.759Z,1716420915.759 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.335630 2024-05-22T23:35:16.010Z,1716420916.010 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.586714 2024-05-22T23:35:16.263Z,1716420916.263 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.838930 2024-05-22T23:35:16.638Z,1716420916.638 [CommandExec](IMPORTANT): got command get Depth_Keller.depth 2024-05-22T23:35:16.639Z,1716420916.639 [CommandExec](IMPORTANT): Depth_Keller.depth 5.000000 m 2024-05-22T23:35:18.790Z,1716420918.790 [DAT](INFO): DAT read: Response Not Received 2024-05-22T23:35:18.791Z,1716420918.791 [DAT](INFO): response not received 2024-05-22T23:35:18.791Z,1716420918.791 [DAT](ERROR): No response from remote modem. 2024-05-22T23:35:19.853Z,1716420919.853 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](IMPORTANT): Altitude envelope ACTIVE 2024-05-22T23:35:44.671Z,1716420944.671 [CommandExec](IMPORTANT): got command show variable radio_surface 2024-05-22T23:35:44.780Z,1716420944.780 [CommandExec](IMPORTANT): Radio_Surface.loadAtStartup (bool) 2024-05-22T23:35:44.781Z,1716420944.781 [CommandExec](IMPORTANT): Radio_Surface.simulateHardware (bool) 2024-05-22T23:35:44.789Z,1716420944.789 [CommandExec](IMPORTANT): Radio_Surface.power (watt) 2024-05-22T23:35:44.790Z,1716420944.790 [CommandExec](IMPORTANT): Radio_Surface.manageDockNetwork (bool) 2024-05-22T23:35:45.000Z,1716420945.000 [CommandExec](IMPORTANT): Radio_Surface.loadControl (none) 2024-05-22T23:35:45.108Z,1716420945.108 [CommandExec](IMPORTANT): Radio_Surface.manageDockNetwork (bool) 2024-05-22T23:35:45.251Z,1716420945.251 [CommandExec](IMPORTANT): Radio_Surface.radio_surface_power (enum) 2024-05-22T23:35:45.274Z,1716420945.274 [CommandExec](IMPORTANT): Radio_Surface.enableBroadcast (bool) 2024-05-22T23:35:45.275Z,1716420945.275 [CommandExec](IMPORTANT): Radio_Surface.component_voltage (volt) 2024-05-22T23:35:45.275Z,1716420945.275 [CommandExec](IMPORTANT): Radio_Surface.component_avgVoltage (volt) 2024-05-22T23:35:45.276Z,1716420945.276 [CommandExec](IMPORTANT): Radio_Surface.component_current (milliampere) 2024-05-22T23:35:45.276Z,1716420945.276 [CommandExec](IMPORTANT): Radio_Surface.component_avgCurrent (milliampere) 2024-05-22T23:35:52.629Z,1716420952.629 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-05-22T23:36:04.401Z,1716420964.401 [CommandExec](IMPORTANT): got command get Radio_Surface.radio_surface_power 2024-05-22T23:36:04.401Z,1716420964.401 [CommandExec](IMPORTANT): Radio_Surface.radio_surface_power 1 enum 2024-05-22T23:36:17.156Z,1716420977.156 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:36:20.929Z,1716420980.929 [CommandExec](IMPORTANT): got command maintain control Radio_Surface.radio_surface_power 0 enum 2024-05-22T23:36:20.943Z,1716420980.943 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Radio_Surface.radio_surface_power" handled in the control thread. 2024-05-22T23:36:21.048Z,1716420981.048 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_Radio_Surface.radio_surface_power,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-22T23:36:32.662Z,1716420992.662 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-05-22T23:36:34.568Z,1716420994.568 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-22T23:36:41.879Z,1716421001.879 [CommandExec](IMPORTANT): got command maintain sensor Radio_Surface.radio_surface_power 0 enum 2024-05-22T23:36:51.067Z,1716421011.067 [CommandExec](IMPORTANT): got command get Radio_Surface.radio_surface_power 2024-05-22T23:36:51.067Z,1716421011.067 [CommandExec](IMPORTANT): Radio_Surface.radio_surface_power 0 enum 2024-05-22T23:36:51.695Z,1716421011.695 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-22T23:36:52.039Z,1716421012.039 [BPC1](ERROR): Battery stick #7 (s/n: 02BB) reported TERMINATE_CHARGE_ALARM. Status code: 0x4090. 2024-05-22T23:36:52.040Z,1716421012.040 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 4. 2024-05-22T23:36:52.044Z,1716421012.044 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-05-22T23:36:52.658Z,1716421012.658 [Radio_Surface](INFO): Stop 2024-05-22T23:36:52.658Z,1716421012.658 [Radio_Surface](INFO): Powering down 2024-05-22T23:36:53.062Z,1716421013.062 [Radio_Surface](INFO): Stopping 2024-05-22T23:36:53.466Z,1716421013.466 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:53.870Z,1716421013.870 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:54.274Z,1716421014.274 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:54.678Z,1716421014.678 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:55.082Z,1716421015.082 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:55.486Z,1716421015.486 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:55.890Z,1716421015.890 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:56.294Z,1716421016.294 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:56.698Z,1716421016.698 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:57.102Z,1716421017.102 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:57.510Z,1716421017.510 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:57.914Z,1716421017.914 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:58.317Z,1716421018.317 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:58.350Z,1716421018.350 [CommandExec](IMPORTANT): got command stop 2024-05-22T23:36:58.350Z,1716421018.350 [CommandExec](IMPORTANT): Scheduling is paused 2024-05-22T23:36:58.350Z,1716421018.350 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2024-05-22T23:36:58.617Z,1716421018.617 [MissionManager](INFO): MissionManager is completed. 2024-05-22T23:36:58.621Z,1716421018.621 [MissionManager](INFO): Uninitializing Mission OnDock 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock](DEBUG): Aggregate::uninitialize OnDock 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes](DEBUG): Aggregate::uninitialize OnDock:StandardEnvelopes 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:B.DepthEnvelope] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:BackseatDriver] Stopped 2024-05-22T23:36:58.622Z,1716421018.622 [OnDock:BackseatDriver](DEBUG): Aggregate::uninitialize OnDock:BackseatDriver 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:BackseatDriver:A.BackseatDriver] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PowerOnly] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PowerOnly](DEBUG): Aggregate::uninitialize OnDock:PowerOnly 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PowerOnly:E.Wait] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:H] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:I.] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:I.](DEBUG): Uninitializing TrackAcousticContact. 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PeriodicCheck] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PeriodicCheck](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PeriodicCheck:CheckIP] Stopped 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:36:58.623Z,1716421018.623 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped 2024-05-22T23:36:58.624Z,1716421018.624 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component. 2024-05-22T23:36:58.624Z,1716421018.624 [OnDock:O.Docked] Stopped 2024-05-22T23:36:58.722Z,1716421018.722 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:58.927Z,1716421018.927 [MissionManager](IMPORTANT): Started mission DefaultTankUndock 2024-05-22T23:36:58.927Z,1716421018.927 [DefaultTankUndock] Running Loop=1 2024-05-22T23:36:58.927Z,1716421018.927 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock 2024-05-22T23:36:58.927Z,1716421018.927 [DefaultTankUndock:B.GoToSurface] Running Loop=1 2024-05-22T23:36:58.927Z,1716421018.927 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-22T23:36:58.927Z,1716421018.927 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-22T23:36:58.928Z,1716421018.928 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-22T23:36:58.928Z,1716421018.928 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-22T23:36:58.928Z,1716421018.928 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-22T23:36:58.929Z,1716421018.929 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-05-22T23:36:58.929Z,1716421018.929 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-22T23:36:58.934Z,1716421018.934 [DefaultTankUndock:A.Wait] Running Loop=1 2024-05-22T23:36:58.934Z,1716421018.934 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component. 2024-05-22T23:36:59.125Z,1716421019.125 [Radio_Surface](INFO): Stopped 2024-05-22T23:36:59.530Z,1716421019.530 [Radio_Surface](INFO): Start 2024-05-22T23:36:59.530Z,1716421019.530 [Radio_Surface](INFO): Powering up 2024-05-22T23:36:59.934Z,1716421019.934 [Radio_Surface](INFO): Starting 2024-05-22T23:37:00.337Z,1716421020.337 [Radio_Surface](INFO): Starting 2024-05-22T23:37:00.742Z,1716421020.742 [Radio_Surface](INFO): Starting 2024-05-22T23:37:01.146Z,1716421021.146 [Radio_Surface](INFO): Starting 2024-05-22T23:37:01.550Z,1716421021.550 [Radio_Surface](INFO): Starting 2024-05-22T23:37:01.954Z,1716421021.954 [Radio_Surface](INFO): Starting 2024-05-22T23:37:02.358Z,1716421022.358 [Radio_Surface](INFO): Starting 2024-05-22T23:37:02.762Z,1716421022.762 [Radio_Surface](INFO): Starting 2024-05-22T23:37:03.166Z,1716421023.166 [Radio_Surface](INFO): Starting 2024-05-22T23:37:03.571Z,1716421023.571 [Radio_Surface](INFO): Starting 2024-05-22T23:37:03.974Z,1716421023.974 [Radio_Surface](INFO): Starting 2024-05-22T23:37:04.378Z,1716421024.378 [Radio_Surface](INFO): Starting 2024-05-22T23:37:04.782Z,1716421024.782 [Radio_Surface](INFO): Starting 2024-05-22T23:37:04.782Z,1716421024.782 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-05-22T23:37:04.782Z,1716421024.782 [CommandExec](INFO): Found local IP address 134.89.93.61 for eth0 2024-05-22T23:37:04.783Z,1716421024.783 [Radio_Surface](IMPORTANT): Local IP not on subnet 10.89.10, restarting DHCP 2024-05-22T23:37:04.799Z,1716421024.799 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2024-05-22T23:37:05.238Z,1716421025.238 [CommandExec](IMPORTANT): /mnt/mmc/started/2024-05-22UTC233705_sh 2024-05-22T23:37:06.751Z,1716421026.751 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@ 2024-05-22T23:37:06.751Z,1716421026.751 [DockingStepper](FAULT): Docking arm not reporting position 2024-05-22T23:37:06.751Z,1716421026.751 [DockingStepper] Communications Fault, FailCount= 1 2024-05-22T23:37:06.752Z,1716421026.752 [DockingStepper](ERROR): Communications Fault 2024-05-22T23:37:06.817Z,1716421026.817 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-05-22T23:37:07.131Z,1716421027.131 [DockingStepper](INFO): Stop 2024-05-22T23:37:07.131Z,1716421027.131 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-05-22T23:37:07.131Z,1716421027.131 [DockingStepper](INFO): Powering down 2024-05-22T23:37:07.543Z,1716421027.543 [DockingStepper](INFO): Stopping 2024-05-22T23:37:07.967Z,1716421027.967 [DockingStepper](INFO): Stopped 2024-05-22T23:37:08.023Z,1716421028.023 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-05-22T23:37:08.023Z,1716421028.023 [DockingStepper] No Fault, FailCount= 1 2024-05-22T23:37:08.338Z,1716421028.338 [DockingStepper](INFO): Start 2024-05-22T23:37:08.339Z,1716421028.339 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-22T23:37:08.339Z,1716421028.339 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-22T23:37:08.762Z,1716421028.762 [DockingStepper](INFO): Starting 2024-05-22T23:37:09.155Z,1716421029.155 [DockingStepper](INFO): Starting 2024-05-22T23:37:09.543Z,1716421029.543 [DockingStepper](INFO): Starting 2024-05-22T23:37:09.594Z,1716421029.594 [DockingStepper](INFO): Init string: /1z16068aE13561N3m50 2024-05-22T23:37:09.974Z,1716421029.974 [DockingStepper](INFO): Starting 2024-05-22T23:37:10.379Z,1716421030.379 [DockingStepper](INFO): Starting 2024-05-22T23:37:10.799Z,1716421030.799 [DockingStepper](INFO): Starting 2024-05-22T23:37:11.171Z,1716421031.171 [DockingStepper](INFO): Starting 2024-05-22T23:37:11.210Z,1716421031.210 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-22T23:37:11.587Z,1716421031.587 [DockingStepper](INFO): Starting 2024-05-22T23:37:11.966Z,1716421031.966 [DefaultTankUndock:A.Wait](INFO): Done Waiting. 2024-05-22T23:37:11.967Z,1716421031.967 [DefaultTankUndock:A.Wait] Stopped 2024-05-22T23:37:11.967Z,1716421031.967 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2024-05-22T23:37:31.224Z,1716421051.224 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, , -4.03, -0.42, 8.75, 0.00 2024-05-22T23:37:41.370Z,1716421061.370 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@ 2024-05-22T23:37:41.371Z,1716421061.371 [DockingStepper](FAULT): Docking arm not reporting position 2024-05-22T23:37:41.371Z,1716421061.371 [DockingStepper] Communications Fault, FailCount= 1 2024-05-22T23:37:41.371Z,1716421061.371 [DockingStepper](ERROR): Communications Fault 2024-05-22T23:37:41.429Z,1716421061.429 [CBIT](ERROR): Communications Fault in component: DockingStepper 2024-05-22T23:37:41.755Z,1716421061.755 [DockingStepper](INFO): Stop 2024-05-22T23:37:41.755Z,1716421061.755 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-05-22T23:37:41.755Z,1716421061.755 [DockingStepper](INFO): Powering down 2024-05-22T23:37:42.218Z,1716421062.218 [DockingStepper](INFO): Stopping 2024-05-22T23:37:42.591Z,1716421062.591 [DockingStepper](INFO): Stopped 2024-05-22T23:37:42.649Z,1716421062.649 [CBIT](INFO): Clearing failed state for component DockingStepper 2024-05-22T23:37:42.649Z,1716421062.649 [DockingStepper] No Fault, FailCount= 1 2024-05-22T23:37:42.970Z,1716421062.970 [DockingStepper](INFO): Start 2024-05-22T23:37:42.971Z,1716421062.971 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-22T23:37:42.971Z,1716421062.971 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-22T23:37:43.418Z,1716421063.418 [DockingStepper](INFO): Starting 2024-05-22T23:37:43.791Z,1716421063.791 [DockingStepper](INFO): Starting 2024-05-22T23:37:44.246Z,1716421064.246 [DockingStepper](INFO): Starting 2024-05-22T23:37:44.307Z,1716421064.307 [DockingStepper](INFO): Init string: /1z16064aE13561N3m50 2024-05-22T23:37:44.614Z,1716421064.614 [DockingStepper](INFO): Starting 2024-05-22T23:37:45.018Z,1716421065.018 [DockingStepper](INFO): Starting 2024-05-22T23:37:45.411Z,1716421065.411 [DockingStepper](INFO): Starting 2024-05-22T23:37:45.806Z,1716421065.806 [DockingStepper](INFO): Starting 2024-05-22T23:37:45.834Z,1716421065.834 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-22T23:37:46.250Z,1716421066.250 [DockingStepper](INFO): Starting 2024-05-22T23:37:48.687Z,1716421068.687 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.754936 2024-05-22T23:37:49.690Z,1716421069.690 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:37:59.088Z,1716421079.088 [DefaultTankUndock:B.GoToSurface](ERROR): Pitch down timeout. Pitch: -2.97 2024-05-22T23:38:24.971Z,1716421104.971 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -0.42, 0.00, 26.09 2024-05-22T23:38:43.650Z,1716421123.650 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD +1.25, -2.27, +1.24, 20.00, 5.06 2024-05-22T23:38:43.950Z,1716421123.950 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003194 2024-05-22T23:38:44.950Z,1716421124.950 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:38:48.775Z,1716421128.775 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,24052215401237,3.7, 0.0,1520.8, 0 2024-05-22T23:38:54.478Z,1716421134.478 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:39:02.940Z,1716421142.940 [CommandExec](IMPORTANT): got command run ./Missions/Engineering/OnDock.tl 2024-05-22T23:39:02.940Z,1716421142.940 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/OnDock.tl 2024-05-22T23:39:02.941Z,1716421142.941 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/OnDock.tl 2024-05-22T23:39:02.946Z,1716421142.946 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/OnDock.tl 2024-05-22T23:39:03.610Z,1716421143.610 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/OnDock.tl translated into: 8 2 1 5 2 30 5 Skipping DHCP restart to test autonetwork Restarting logs restart logs ! ifconfig Mission ending, breaking off. Range: . 2024-05-22T23:39:03.615Z,1716421143.615 [MissionManager](INFO): DefineArg OnDock.DockedTime = 8.000000 h 2024-05-22T23:39:03.618Z,1716421143.618 [MissionManager](INFO): DefineArg OnDock.DetachedTimeout = 28800.000000 s 2024-05-22T23:39:03.620Z,1716421143.620 [MissionManager](INFO): DefineArg OnDock.RangeTimeout = 600.000000 s 2024-05-22T23:39:03.623Z,1716421143.623 [MissionManager](INFO): DefineArg OnDock.TrackingUpdatePeriod = 2.000000 min 2024-05-22T23:39:03.625Z,1716421143.625 [MissionManager](INFO): DefineArg OnDock.NumberOfPings = 1.000000 count 2024-05-22T23:39:03.627Z,1716421143.627 [MissionManager](INFO): DefineArg OnDock.TransponderCode = 201 count 2024-05-22T23:39:03.730Z,1716421143.730 [MissionManager](INFO): DefineArg OnDock.MaxDepth = 215.000000 m 2024-05-22T23:39:03.732Z,1716421143.732 [MissionManager](INFO): DefineArg OnDock.MinAltitude = 5.000000 m 2024-05-22T23:39:03.739Z,1716421143.739 [MissionManager](INFO): DefineArg OnDock.MinOffshore = 2.000000 km 2024-05-22T23:39:03.740Z,1716421143.740 [MissionManager](INFO): DefineArg OnDock.StayOnDock = 0 bool 2024-05-22T23:39:03.763Z,1716421143.763 [MissionManager](INFO): DefineArg OnDock.IfconfigInterval = 30.000000 min 2024-05-22T23:39:03.765Z,1716421143.765 [MissionManager](INFO): DefineArg OnDock.MissionTimeout = 8.000000 h 2024-05-22T23:39:03.782Z,1716421143.782 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2024-05-22T23:39:03.783Z,1716421143.783 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2024-05-22T23:39:03.784Z,1716421143.784 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2024-05-22T23:39:04.000Z,1716421144.000 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2024-05-22T23:39:04.004Z,1716421144.004 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinAltitude = 5.000000 m 2024-05-22T23:39:04.006Z,1716421144.006 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2024-05-22T23:39:04.008Z,1716421144.008 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepth = 200.000000 m 2024-05-22T23:39:04.010Z,1716421144.010 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinOffshore = 2000.000000 m 2024-05-22T23:39:04.011Z,1716421144.011 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2024-05-22T23:39:04.014Z,1716421144.014 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-05-22T23:39:04.018Z,1716421144.018 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2024-05-22T23:39:04.025Z,1716421144.025 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2024-05-22T23:39:04.036Z,1716421144.036 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2024-05-22T23:39:04.036Z,1716421144.036 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2024-05-22T23:39:04.066Z,1716421144.066 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2024-05-22T23:39:04.175Z,1716421144.175 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2024-05-22T23:39:04.186Z,1716421144.186 [MissionManager](INFO): DefineArg OnDock:BackseatDriver.EnableBackseat = 0 bool 2024-05-22T23:39:04.189Z,1716421144.189 [OnDock:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2024-05-22T23:39:04.202Z,1716421144.202 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2024-05-22T23:39:04.202Z,1716421144.202 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2024-05-22T23:39:04.252Z,1716421144.252 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2024-05-22T23:39:04.438Z,1716421144.438 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2024-05-22T23:39:04.442Z,1716421144.442 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleAll = 0 bool 2024-05-22T23:39:04.445Z,1716421144.445 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad1 = 0 bool 2024-05-22T23:39:04.464Z,1716421144.464 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad2 = 0 bool 2024-05-22T23:39:04.476Z,1716421144.476 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad3 = 0 bool 2024-05-22T23:39:04.503Z,1716421144.503 [MissionManager](INFO): DefineArg OnDock:PowerOnly.EnabledPowerOnly = 0 bool 2024-05-22T23:39:04.533Z,1716421144.533 [OnDock:PowerOnly:E.Wait](DEBUG): Construct Wait. 2024-05-22T23:39:04.626Z,1716421144.626 [OnDock:L.Execute](DEBUG): Construct Execute. 2024-05-22T23:39:04.629Z,1716421144.629 [OnDock:PeriodicCheck:CheckIP:A.Execute](DEBUG): Construct Execute. 2024-05-22T23:39:04.636Z,1716421144.636 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Construct Wait. 2024-05-22T23:39:04.643Z,1716421144.643 [OnDock:O.Docked](DEBUG): Construct. 2024-05-22T23:39:04.644Z,1716421144.644 [OnDock:O.Docked](DEBUG): Initializing internal variables to default values. 2024-05-22T23:39:04.674Z,1716421144.674 [OnDock:Detach:B.Undock](DEBUG): Construct. 2024-05-22T23:39:04.674Z,1716421144.674 [OnDock:Detach:B.Undock](DEBUG): Initializing internal variables to default values. 2024-05-22T23:39:04.693Z,1716421144.693 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission { """ Wait on dock, communicating when possible """ arguments { DockedTime = 8 hour """ Time to stay on dock. Mission timeout will be five minutes longer. """ DetachedTimeout = Dock:Docked.detachTimeout """ Time duration limit for determining if the vehicle is detached from the dock. """ RangeTimeout = Dock:Docked.rangeTimeout """ Maximum allowed time without acoustic range. """ TrackingUpdatePeriod = 2 minute """ How long to wait between acoustic queries. """ NumberOfPings = 1 count """ Number of pings requested each time. """ TransponderCode = Dock:Dock.transponderCode """ Transponder Address. """ MaxDepth = BIT:CBIT.stopDepth """ Maximum depth while docked. """ MinAltitude = 5 meter """ Minimum altitude """ MinOffshore = 2 km """ Minimum offshore """ StayOnDock = false """ If true, don't detach from dock at end of mission """ IfconfigInterval = 30 minute """ How long to wait between ifconfig runs """ # Mission variables (do not change) MissionTimeout = DockedTime """ Mission timeout (local variable, do not change) """ } timeout duration=MissionTimeout insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MinAltitude = MinAltitude assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore # End docking 5 minutes before end of mission to allow clean undock assign in sequence MissionTimeout = DockedTime + 5 minute insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl # Send data when connection exists readData { while ( Sensor:DataOverHttps.connectionStatus == true ) Universal:platform_communications } behavior Estimation:TrackAcousticContact { run in parallel set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } aggregate restartDHCP { run when ( called ) syslog important "Skipping DHCP restart to test autonetwork" # behavior Guidance:Execute { # run in sequence # set command = "! /mnt/mmc/LRAUV/Tools/dhcp.sh" # } } syslog important "Restarting logs" behavior Guidance:Execute { run in sequence set command = "restart logs" } # Kick DHCP again, in case it took us a while to close the arm in Docked call refId="restartDHCP" aggregate PeriodicCheck { run in parallel aggregate CheckIP { run in sequence behavior Guidance:Execute { run in sequence set command = "! ifconfig" } behavior Guidance:Wait { run in sequence set duration = IfconfigInterval } } } behavior Dock:Docked { run in sequence timeout duration=DockedTime set detachTimeout = DetachedTimeout set rangeTimeout = RangeTimeout } # Undock cleanly, instead of relying on DefaultWithUndock to come next aggregate Detach { run in sequence break if ( StayOnDock == true ) syslog important "Mission ending, breaking off. Range: " + Estimation:TrackAcousticContact.range_to_contact~meter + "." behavior Dock:Undock { run in sequence } # Get our 10.89 IP back once we're on the surface call refId="restartDHCP" } } 2024-05-22T23:39:04.695Z,1716421144.695 [CommandExec](IMPORTANT): Running ./Missions/Engineering/OnDock.tl 2024-05-22T23:39:04.996Z,1716421144.996 [DefaultTankUndock] Stopped 2024-05-22T23:39:04.996Z,1716421144.996 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock 2024-05-22T23:39:04.996Z,1716421144.996 [DefaultTankUndock:B.GoToSurface] Stopped 2024-05-22T23:39:04.997Z,1716421144.997 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-22T23:39:04.997Z,1716421144.997 [MissionManager](IMPORTANT): Started mission OnDock 2024-05-22T23:39:04.997Z,1716421144.997 [OnDock] Running Loop=1 2024-05-22T23:39:04.997Z,1716421144.997 [OnDock](DEBUG): Aggregate::initialize OnDock 2024-05-22T23:39:04.997Z,1716421144.997 [OnDock:StandardEnvelopes] Running Loop=1 2024-05-22T23:39:04.997Z,1716421144.997 [OnDock:StandardEnvelopes](DEBUG): Aggregate::initialize OnDock:StandardEnvelopes 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:BackseatDriver] Running Loop=1 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:BackseatDriver](DEBUG): Aggregate::initialize OnDock:BackseatDriver 2024-05-22T23:39:04.998Z,1716421144.998 [OnDock:BackseatDriver:A.BackseatDriver] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly](DEBUG): Aggregate::initialize OnDock:PowerOnly 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:A] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:B] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:C] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:D] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:E.Wait] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:H] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:I.] Running Loop=1 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:I.](INFO): Initializing TrackAcousticContact. 2024-05-22T23:39:04.999Z,1716421144.999 [OnDock:PeriodicCheck] Running Loop=1 2024-05-22T23:39:04.000Z,1716421145.000 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2024-05-22T23:39:04.000Z,1716421145.000 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2024-05-22T23:39:04.000Z,1716421145.000 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2024-05-22T23:39:04.000Z,1716421145.000 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2024-05-22T23:39:05.000Z,1716421145.000 [OnDock:B] Running Loop=1 2024-05-22T23:39:05.000Z,1716421145.000 [OnDock:PeriodicCheck] Running Loop=1 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:I.] Running Loop=1 2024-05-22T23:39:05.001Z,1716421145.001 [OnDock:H] Running Loop=1 2024-05-22T23:39:05.002Z,1716421145.002 [OnDock:H](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-22T23:39:05.002Z,1716421145.002 [OnDock:PowerOnly] Running Loop=1 2024-05-22T23:39:05.002Z,1716421145.002 [OnDock:PowerOnly:D] Stopped 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:PowerOnly:C] Stopped 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:PowerOnly:B] Stopped 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:PowerOnly:A] Stopped 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:BackseatDriver] Running Loop=1 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:B] Stopped 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:C] Running Loop=1 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:StandardEnvelopes] Running Loop=1 2024-05-22T23:39:05.003Z,1716421145.003 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-05-22T23:39:05.004Z,1716421145.004 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2024-05-22T23:39:05.007Z,1716421145.007 [CommandExec](IMPORTANT): got command ! ifconfig 2024-05-22T23:39:05.087Z,1716421145.087 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-05-22T23:39:05.088Z,1716421145.088 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-05-22T23:39:05.148Z,1716421145.148 [DockingStepper](INFO): Deisolating dock charge 2024-05-22T23:39:05.364Z,1716421145.364 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:134.89.93.61 Bcast:134.89.93.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:12525 errors:0 dropped:0 overruns:0 frame:0 TX packets:13509 errors:0 dropped:0 overruns:0 carrier:0 collisions:20 txqueuelen:1000 RX bytes:3885147 (3.7 Mb) TX bytes:2519270 (2.4 Mb) Interrupt:29 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1 RX packets:382 errors:0 dropped:0 overruns:0 frame:0 TX packets:382 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:31300 (30.5 Kb) TX bytes:31300 (30.5 Kb) 2024-05-22T23:39:06.143Z,1716421146.143 [OnDock:C] Stopped 2024-05-22T23:39:06.144Z,1716421146.144 [OnDock:D] Running Loop=1 2024-05-22T23:39:06.556Z,1716421146.556 [OnDock:D] Stopped 2024-05-22T23:39:06.556Z,1716421146.556 [OnDock:E] Running Loop=1 2024-05-22T23:39:07.070Z,1716421147.070 [OnDock:E] Stopped 2024-05-22T23:39:07.070Z,1716421147.070 [OnDock:K] Running Loop=1 2024-05-22T23:39:07.388Z,1716421147.388 [OnDock:K](IMPORTANT): Restarting logs 2024-05-22T23:39:07.388Z,1716421147.388 [OnDock:K] Stopped 2024-05-22T23:39:07.388Z,1716421147.388 [OnDock:L.Execute] Running Loop=1 2024-05-22T23:39:07.771Z,1716421147.771 [OnDock:L.Execute](INFO): Executing command restart logs 2024-05-22T23:39:07.771Z,1716421147.771 [OnDock:L.Execute] Stopped 2024-05-22T23:39:07.771Z,1716421147.771 [OnDock:M] Running Loop=1 2024-05-22T23:39:07.771Z,1716421147.771 [OnDock:M](DEBUG): Aggregate::initialize OnDock:M