2025-04-15T21:35:22.629Z,1744752922.629 [OnDock:L.Execute](INFO): Executing command restart logs 2025-04-15T21:35:22.629Z,1744752922.629 [OnDock:L.Execute] Stopped 2025-04-15T21:35:22.629Z,1744752922.629 [OnDock:N.Docked] Running Loop=1 2025-04-15T21:35:22.629Z,1744752922.629 [OnDock:N.Docked](DEBUG): Initialize. 2025-04-15T21:35:22.629Z,1744752922.629 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values. 2025-04-15T21:35:22.650Z,1744752922.650 [CommandExec](IMPORTANT): got command restart logs 2025-04-15T21:35:22.890Z,1744752922.890 [Reporter](INFO): platform_buoyancy_position 401.664062 cc 2025-04-15T21:35:23.062Z,1744752923.062 [OnDock:N.Docked](INFO): Found local IP address 10.89.10.2 for eth0 2025-04-15T21:35:23.062Z,1744752923.062 [OnDock:N.Docked](IMPORTANT): No IP address on dock subnet, restarting DHCP 2025-04-15T21:35:23.157Z,1744752923.157 [DAT](IMPORTANT): Requesting device enable set for address 0. 2025-04-15T21:35:23.259Z,1744752923.259 [Reporter](INFO): platform_buoyancy_position 408.110474 cc 2025-04-15T21:35:23.409Z,1744752923.409 [DAT](INFO): DAT read: user:6> 2025-04-15T21:35:23.410Z,1744752923.410 [DAT](INFO): DAT read: Tx time:21:35:22.6963 2025-04-15T21:35:23.410Z,1744752923.410 [DAT](INFO): Ping request sent. 2025-04-15T21:35:23.410Z,1744752923.410 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:35:23.411Z,1744752923.411 [DAT](INFO): publishing transmit ping time 2025-04-15T21:35:23.412Z,1744752923.412 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000979 2025-04-15T21:35:23.412Z,1744752923.412 [DAT](IMPORTANT): Requesting device enable set for address 0. 2025-04-15T21:35:23.662Z,1744752923.662 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251501 2025-04-15T21:35:23.663Z,1744752923.663 [DAT](IMPORTANT): Requesting device enable set for address 0. 2025-04-15T21:35:23.675Z,1744752923.675 [Reporter](INFO): platform_buoyancy_position 412.408020 cc 2025-04-15T21:35:23.913Z,1744752923.913 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502707 2025-04-15T21:35:24.012Z,1744752924.012 [Reporter](INFO): platform_buoyancy_position 415.362671 cc 2025-04-15T21:35:24.166Z,1744752924.166 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755057 2025-04-15T21:35:24.417Z,1744752924.417 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006859 2025-04-15T21:35:24.669Z,1744752924.669 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258824 2025-04-15T21:35:24.921Z,1744752924.921 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510811 2025-04-15T21:35:25.173Z,1744752925.173 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762848 2025-04-15T21:35:25.425Z,1744752925.425 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014698 2025-04-15T21:35:25.678Z,1744752925.678 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.267187 2025-04-15T21:35:25.929Z,1744752925.929 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518816 2025-04-15T21:35:26.181Z,1744752926.181 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770723 2025-04-15T21:35:26.434Z,1744752926.434 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022967 2025-04-15T21:35:26.685Z,1744752926.685 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274901 2025-04-15T21:35:26.937Z,1744752926.937 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526840 2025-04-15T21:35:27.190Z,1744752927.190 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778994 2025-04-15T21:35:27.441Z,1744752927.441 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030851 2025-04-15T21:35:27.693Z,1744752927.693 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282734 2025-04-15T21:35:27.945Z,1744752927.945 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534859 2025-04-15T21:35:28.079Z,1744752928.079 [Reporter](INFO): platform_buoyancy_position 373.595337 cc 2025-04-15T21:35:28.197Z,1744752928.197 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786837 2025-04-15T21:35:28.238Z,1744752928.238 [Reporter](INFO): platform_buoyancy_position 371.446533 cc 2025-04-15T21:35:28.449Z,1744752928.449 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.038763 2025-04-15T21:35:28.623Z,1744752928.623 [Reporter](INFO): platform_buoyancy_position 365.134460 cc 2025-04-15T21:35:28.701Z,1744752928.701 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290806 2025-04-15T21:35:28.953Z,1744752928.953 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542844 2025-04-15T21:35:29.110Z,1744752929.110 [Reporter](INFO): platform_buoyancy_position 358.688049 cc 2025-04-15T21:35:29.205Z,1744752929.205 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794767 2025-04-15T21:35:29.451Z,1744752929.451 [Reporter](INFO): platform_buoyancy_position 354.390442 cc 2025-04-15T21:35:29.458Z,1744752929.458 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.047027 2025-04-15T21:35:29.709Z,1744752929.709 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298676 2025-04-15T21:35:29.961Z,1744752929.961 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550797 2025-04-15T21:35:30.213Z,1744752930.213 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802821 2025-04-15T21:35:30.465Z,1744752930.465 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054857 2025-04-15T21:35:30.717Z,1744752930.717 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.306854 2025-04-15T21:35:30.970Z,1744752930.970 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.559085 2025-04-15T21:35:31.221Z,1744752931.221 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810831 2025-04-15T21:35:31.473Z,1744752931.473 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062707 2025-04-15T21:35:31.726Z,1744752931.726 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314996 2025-04-15T21:35:31.978Z,1744752931.978 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566994 2025-04-15T21:35:32.230Z,1744752932.230 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:35:32.230Z,1744752932.230 [DAT](INFO): response not received 2025-04-15T21:35:32.231Z,1744752932.231 [DAT](INFO): DAT read: user:7> 2025-04-15T21:35:32.232Z,1744752932.232 [DAT](INFO): DAT read: Tx time:21:35:31.6464 2025-04-15T21:35:32.232Z,1744752932.232 [DAT](INFO): Ping request sent. 2025-04-15T21:35:32.232Z,1744752932.232 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:35:32.232Z,1744752932.232 [DAT](INFO): publishing transmit ping time 2025-04-15T21:35:32.233Z,1744752932.233 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000901 2025-04-15T21:35:32.482Z,1744752932.482 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.249571 2025-04-15T21:35:32.733Z,1744752932.733 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501419 2025-04-15T21:35:32.987Z,1744752932.987 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755022 2025-04-15T21:35:33.238Z,1744752933.238 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005531 2025-04-15T21:35:33.420Z,1744752933.420 [Reporter](INFO): platform_buoyancy_position 302.684937 cc 2025-04-15T21:35:33.489Z,1744752933.489 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257420 2025-04-15T21:35:33.595Z,1744752933.595 [Reporter](INFO): platform_buoyancy_position 300.536133 cc 2025-04-15T21:35:33.741Z,1744752933.741 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509325 2025-04-15T21:35:33.978Z,1744752933.978 [Reporter](INFO): platform_buoyancy_position 296.372833 cc 2025-04-15T21:35:33.994Z,1744752933.994 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761588 2025-04-15T21:35:34.127Z,1744752934.127 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh 2025-04-15T21:35:34.246Z,1744752934.246 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.013728 2025-04-15T21:35:34.448Z,1744752934.448 [Reporter](INFO): platform_buoyancy_position 289.792145 cc 2025-04-15T21:35:34.498Z,1744752934.498 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265575 2025-04-15T21:35:34.750Z,1744752934.750 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517719 2025-04-15T21:35:34.835Z,1744752934.835 [Reporter](INFO): platform_buoyancy_position 283.345734 cc 2025-04-15T21:35:34.946Z,1744752934.946 [CommandExec](IMPORTANT): /mnt/mmc/started/2025-04-15UTC213534_sh 2025-04-15T21:35:35.004Z,1744752935.004 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771943 2025-04-15T21:35:35.253Z,1744752935.253 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021339 2025-04-15T21:35:35.506Z,1744752935.506 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.273563 2025-04-15T21:35:35.758Z,1744752935.758 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.525638 2025-04-15T21:35:36.011Z,1744752936.011 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779026 2025-04-15T21:35:36.262Z,1744752936.262 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.029878 2025-04-15T21:35:36.513Z,1744752936.513 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.281435 2025-04-15T21:35:36.765Z,1744752936.765 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.533328 2025-04-15T21:35:37.021Z,1744752937.021 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.788191 2025-04-15T21:35:37.269Z,1744752937.269 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.037384 2025-04-15T21:35:37.521Z,1744752937.521 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.289217 2025-04-15T21:35:37.774Z,1744752937.774 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.541702 2025-04-15T21:35:38.028Z,1744752938.028 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.795235 2025-04-15T21:35:38.277Z,1744752938.277 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.045217 2025-04-15T21:35:38.521Z,1744752938.521 [Reporter](INFO): platform_buoyancy_position 236.206421 cc 2025-04-15T21:35:38.530Z,1744752938.530 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.297693 2025-04-15T21:35:38.747Z,1744752938.747 [Reporter](INFO): platform_buoyancy_position 233.923340 cc 2025-04-15T21:35:38.781Z,1744752938.781 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.549376 2025-04-15T21:35:39.035Z,1744752939.035 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802876 2025-04-15T21:35:39.195Z,1744752939.195 [Reporter](INFO): platform_buoyancy_position 227.476929 cc 2025-04-15T21:35:39.285Z,1744752939.285 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.053246 2025-04-15T21:35:39.537Z,1744752939.537 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.305479 2025-04-15T21:35:39.639Z,1744752939.639 [Reporter](INFO): platform_buoyancy_position 221.164825 cc 2025-04-15T21:35:39.789Z,1744752939.789 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.557252 2025-04-15T21:35:39.917Z,1744752939.917 [Reporter](INFO): platform_buoyancy_position 218.881744 cc 2025-04-15T21:35:40.044Z,1744752940.044 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.811826 2025-04-15T21:35:40.293Z,1744752940.293 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.061494 2025-04-15T21:35:40.545Z,1744752940.545 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.313373 2025-04-15T21:35:40.797Z,1744752940.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.565453 2025-04-15T21:35:41.052Z,1744752941.052 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819181 2025-04-15T21:35:41.302Z,1744752941.302 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:35:41.302Z,1744752941.302 [DAT](INFO): response not received 2025-04-15T21:35:41.303Z,1744752941.303 [DAT](INFO): DAT read: user:8> 2025-04-15T21:35:41.303Z,1744752941.303 [DAT](INFO): DAT read: Tx time:21:35:40.5965 2025-04-15T21:35:41.304Z,1744752941.304 [DAT](INFO): Ping request sent. 2025-04-15T21:35:41.304Z,1744752941.304 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:35:41.304Z,1744752941.304 [DAT](INFO): publishing transmit ping time 2025-04-15T21:35:41.309Z,1744752941.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.004296 2025-04-15T21:35:41.554Z,1744752941.554 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250060 2025-04-15T21:35:41.805Z,1744752941.805 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.501622 2025-04-15T21:35:42.060Z,1744752942.060 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755579 2025-04-15T21:35:42.309Z,1744752942.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.005775 2025-04-15T21:35:42.561Z,1744752942.561 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257746 2025-04-15T21:35:42.813Z,1744752942.813 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509683 2025-04-15T21:35:42.980Z,1744752942.980 [Reporter](INFO): platform_buoyancy_position 201.019836 cc 2025-04-15T21:35:43.068Z,1744752943.068 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763874 2025-04-15T21:35:43.318Z,1744752943.318 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014435 2025-04-15T21:35:43.569Z,1744752943.569 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265575 2025-04-15T21:35:43.821Z,1744752943.821 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517589 2025-04-15T21:35:44.075Z,1744752944.075 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771411 2025-04-15T21:35:44.325Z,1744752944.325 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021602 2025-04-15T21:35:44.578Z,1744752944.578 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.273978 2025-04-15T21:35:44.829Z,1744752944.829 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.525634 2025-04-15T21:35:45.084Z,1744752945.084 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779566 2025-04-15T21:35:45.333Z,1744752945.333 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.029639 2025-04-15T21:35:45.585Z,1744752945.585 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.281669 2025-04-15T21:35:45.837Z,1744752945.837 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.533583 2025-04-15T21:35:46.090Z,1744752946.090 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.785929 2025-04-15T21:35:46.342Z,1744752946.342 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.037905 2025-04-15T21:35:46.593Z,1744752946.593 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.289491 2025-04-15T21:35:46.846Z,1744752946.846 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.541857 2025-04-15T21:35:47.097Z,1744752947.097 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.793640 2025-04-15T21:35:47.349Z,1744752947.349 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.045618 2025-04-15T21:35:47.602Z,1744752947.602 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298000 2025-04-15T21:35:47.853Z,1744752947.853 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.549709 2025-04-15T21:35:48.105Z,1744752948.105 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.801589 2025-04-15T21:35:48.357Z,1744752948.357 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.053732 2025-04-15T21:35:48.613Z,1744752948.613 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.308838 2025-04-15T21:35:48.866Z,1744752948.866 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.562662 2025-04-15T21:35:49.118Z,1744752949.118 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.813829 2025-04-15T21:35:49.369Z,1744752949.369 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.065718 2025-04-15T21:35:49.621Z,1744752949.621 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.317554 2025-04-15T21:35:49.873Z,1744752949.873 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.569551 2025-04-15T21:35:50.126Z,1744752950.126 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:35:50.126Z,1744752950.126 [DAT](INFO): response not received 2025-04-15T21:35:50.126Z,1744752950.126 [DAT](ERROR): No response from remote modem. 2025-04-15T21:35:50.126Z,1744752950.126 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.822716 2025-04-15T21:35:50.377Z,1744752950.377 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.073709 2025-04-15T21:35:50.629Z,1744752950.629 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.325731 2025-04-15T21:35:50.677Z,1744752950.677 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:35:50.881Z,1744752950.881 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.577756 2025-04-15T21:35:51.133Z,1744752951.133 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.829712 2025-04-15T21:35:51.681Z,1744752951.681 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:36:21.797Z,1744752981.797 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:36:22.801Z,1744752982.801 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:36:35.671Z,1744752995.671 [OnDock:N.Docked](FAULT): Off dock, range timeout exceeded 2025-04-15T21:36:35.671Z,1744752995.671 [OnDock:N.Docked](IMPORTANT): State switched to DETACHED. Waiting for state timeout to act... 2025-04-15T21:36:52.933Z,1744753012.933 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:36:53.937Z,1744753013.937 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:37:05.948Z,1744753025.948 [NAL9602](INFO): Not Powering down - fast GPS 2025-04-15T21:37:18.540Z,1744753038.540 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-04-15T21:37:18.617Z,1744753038.617 [DAT](DEBUG): Acoustic response timeout 2025-04-15T21:37:18.618Z,1744753038.618 [DAT](INFO): setting remote address to 0 2025-04-15T21:37:18.869Z,1744753038.869 [DAT](INFO): DAT read: user:9> 2025-04-15T21:37:18.870Z,1744753038.870 [DAT](INFO): DAT read: RemoteAddr | 0 2025-04-15T21:37:18.870Z,1744753038.870 [DAT](INFO): set remote address to 0 2025-04-15T21:37:18.871Z,1744753038.871 [DAT](DEBUG): Acoustic response timeout 2025-04-15T21:37:18.871Z,1744753038.871 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-04-15T21:37:19.121Z,1744753039.121 [DAT](INFO): DAT read: user:10> 2025-04-15T21:37:19.122Z,1744753039.122 [DAT](INFO): DAT read: Tx time:21:37:18.3986 2025-04-15T21:37:19.122Z,1744753039.122 [DAT](INFO): Ping request sent. 2025-04-15T21:37:19.122Z,1744753039.122 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:37:19.122Z,1744753039.122 [DAT](INFO): publishing transmit ping time 2025-04-15T21:37:19.123Z,1744753039.123 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000748 2025-04-15T21:37:19.374Z,1744753039.374 [DAT](INFO): DAT read: TxSync time:21:37:18.3978 2025-04-15T21:37:19.374Z,1744753039.374 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252135 2025-04-15T21:37:19.626Z,1744753039.626 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503394 2025-04-15T21:37:19.877Z,1744753039.877 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754959 2025-04-15T21:37:20.130Z,1744753040.130 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.007426 2025-04-15T21:37:20.381Z,1744753040.381 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258937 2025-04-15T21:37:20.633Z,1744753040.633 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510941 2025-04-15T21:37:20.885Z,1744753040.885 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763105 2025-04-15T21:37:21.137Z,1744753041.137 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014942 2025-04-15T21:37:21.389Z,1744753041.389 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266934 2025-04-15T21:37:21.642Z,1744753041.642 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519195 2025-04-15T21:37:21.893Z,1744753041.893 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771022 2025-04-15T21:37:22.145Z,1744753042.145 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023028 2025-04-15T21:37:22.398Z,1744753042.398 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.275413 2025-04-15T21:37:22.649Z,1744753042.649 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526997 2025-04-15T21:37:22.909Z,1744753042.909 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.786767 2025-04-15T21:37:23.154Z,1744753043.154 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.031335 2025-04-15T21:37:23.405Z,1744753043.405 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.283076 2025-04-15T21:37:23.657Z,1744753043.657 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534960 2025-04-15T21:37:23.910Z,1744753043.910 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.787180 2025-04-15T21:37:24.057Z,1744753044.057 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:37:24.161Z,1744753044.161 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.039049 2025-04-15T21:37:24.413Z,1744753044.413 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.291084 2025-04-15T21:37:24.665Z,1744753044.665 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542967 2025-04-15T21:37:24.917Z,1744753044.917 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794932 2025-04-15T21:37:25.061Z,1744753045.061 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:37:25.169Z,1744753045.169 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046854 2025-04-15T21:37:25.421Z,1744753045.421 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.299061 2025-04-15T21:37:25.673Z,1744753045.673 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.551013 2025-04-15T21:37:25.925Z,1744753045.925 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802943 2025-04-15T21:37:26.179Z,1744753046.179 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.056227 2025-04-15T21:37:26.429Z,1744753046.429 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307002 2025-04-15T21:37:26.681Z,1744753046.681 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558987 2025-04-15T21:37:26.933Z,1744753046.933 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.811148 2025-04-15T21:37:27.185Z,1744753047.185 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062999 2025-04-15T21:37:27.437Z,1744753047.437 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314906 2025-04-15T21:37:27.690Z,1744753047.690 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.567211 2025-04-15T21:37:27.941Z,1744753047.941 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819014 2025-04-15T21:37:28.193Z,1744753048.193 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.070930 2025-04-15T21:37:28.446Z,1744753048.446 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.323163 2025-04-15T21:37:28.698Z,1744753048.698 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.575651 2025-04-15T21:37:28.949Z,1744753048.949 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.826937 2025-04-15T21:37:29.201Z,1744753049.201 [DAT](INFO): Reached modem response timeout 2025-04-15T21:37:29.958Z,1744753049.958 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:37:29.958Z,1744753049.958 [DAT](INFO): response not received 2025-04-15T21:37:29.958Z,1744753049.958 [DAT](ERROR): No response from remote modem. 2025-04-15T21:37:55.197Z,1744753075.197 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:37:56.201Z,1744753076.201 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:38:26.346Z,1744753106.346 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:38:27.349Z,1744753107.349 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:38:57.473Z,1744753137.473 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:38:58.477Z,1744753138.477 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:39:18.897Z,1744753158.897 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-04-15T21:39:19.113Z,1744753159.113 [DAT](DEBUG): Acoustic response timeout 2025-04-15T21:39:19.114Z,1744753159.114 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-04-15T21:39:19.365Z,1744753159.365 [DAT](INFO): DAT read: user:11> 2025-04-15T21:39:19.366Z,1744753159.366 [DAT](INFO): DAT read: Tx time:21:39:18.6500 2025-04-15T21:39:19.366Z,1744753159.366 [DAT](INFO): Ping request sent. 2025-04-15T21:39:19.367Z,1744753159.367 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:39:19.367Z,1744753159.367 [DAT](INFO): publishing transmit ping time 2025-04-15T21:39:19.367Z,1744753159.367 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000741 2025-04-15T21:39:19.617Z,1744753159.617 [DAT](INFO): DAT read: TxSync time:21:39:18.6493 2025-04-15T21:39:19.618Z,1744753159.618 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251566 2025-04-15T21:39:19.870Z,1744753159.870 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502974 2025-04-15T21:39:20.122Z,1744753160.122 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755245 2025-04-15T21:39:20.373Z,1744753160.373 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006625 2025-04-15T21:39:20.625Z,1744753160.625 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258682 2025-04-15T21:39:20.879Z,1744753160.879 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.512189 2025-04-15T21:39:21.129Z,1744753161.129 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762651 2025-04-15T21:39:21.386Z,1744753161.386 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.019121 2025-04-15T21:39:21.637Z,1744753161.637 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.270717 2025-04-15T21:39:21.889Z,1744753161.889 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.522664 2025-04-15T21:39:22.144Z,1744753162.144 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.777257 2025-04-15T21:39:22.396Z,1744753162.396 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.028978 2025-04-15T21:39:22.645Z,1744753162.645 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.278614 2025-04-15T21:39:22.898Z,1744753162.898 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.531013 2025-04-15T21:39:23.149Z,1744753163.149 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.782667 2025-04-15T21:39:23.401Z,1744753163.401 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.034757 2025-04-15T21:39:23.654Z,1744753163.654 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.287020 2025-04-15T21:39:23.905Z,1744753163.905 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.538740 2025-04-15T21:39:24.157Z,1744753164.157 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.790738 2025-04-15T21:39:24.410Z,1744753164.410 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.043063 2025-04-15T21:39:24.661Z,1744753164.661 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.294694 2025-04-15T21:39:24.913Z,1744753164.913 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.546607 2025-04-15T21:39:25.165Z,1744753165.165 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.798749 2025-04-15T21:39:25.417Z,1744753165.417 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.050841 2025-04-15T21:39:25.669Z,1744753165.669 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.302814 2025-04-15T21:39:25.921Z,1744753165.921 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.554724 2025-04-15T21:39:26.173Z,1744753166.173 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.806772 2025-04-15T21:39:26.427Z,1744753166.427 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.060442 2025-04-15T21:39:26.677Z,1744753166.677 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.310687 2025-04-15T21:39:26.929Z,1744753166.929 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.562682 2025-04-15T21:39:27.181Z,1744753167.181 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.814660 2025-04-15T21:39:27.435Z,1744753167.435 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.068567 2025-04-15T21:39:27.685Z,1744753167.685 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.318717 2025-04-15T21:39:27.937Z,1744753167.937 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.570620 2025-04-15T21:39:28.189Z,1744753168.189 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.822747 2025-04-15T21:39:28.443Z,1744753168.443 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.076462 2025-04-15T21:39:28.597Z,1744753168.597 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:39:28.693Z,1744753168.693 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.326683 2025-04-15T21:39:28.945Z,1744753168.945 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.578702 2025-04-15T21:39:29.197Z,1744753169.197 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.830719 2025-04-15T21:39:29.451Z,1744753169.451 [DAT](INFO): Reached modem response timeout 2025-04-15T21:39:29.601Z,1744753169.601 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:39:30.205Z,1744753170.205 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:39:30.206Z,1744753170.206 [DAT](INFO): response not received 2025-04-15T21:39:30.206Z,1744753170.206 [DAT](ERROR): No response from remote modem. 2025-04-15T21:39:59.733Z,1744753199.733 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:40:00.738Z,1744753200.738 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:40:30.857Z,1744753230.857 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:40:31.861Z,1744753231.861 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:40:48.642Z,1744753248.642 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25041513415955,35.0, +18.91518.6, 0 2025-04-15T21:41:02.005Z,1744753262.005 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:41:03.009Z,1744753263.009 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:41:19.302Z,1744753279.302 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-04-15T21:41:19.369Z,1744753279.369 [DAT](DEBUG): Acoustic response timeout 2025-04-15T21:41:19.370Z,1744753279.370 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-04-15T21:41:19.621Z,1744753279.621 [DAT](INFO): DAT read: user:12> 2025-04-15T21:41:19.622Z,1744753279.622 [DAT](INFO): DAT read: Tx time:21:41:18.9015 2025-04-15T21:41:19.622Z,1744753279.622 [DAT](INFO): Ping request sent. 2025-04-15T21:41:19.622Z,1744753279.622 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:41:19.622Z,1744753279.622 [DAT](INFO): publishing transmit ping time 2025-04-15T21:41:19.623Z,1744753279.623 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000744 2025-04-15T21:41:19.874Z,1744753279.874 [DAT](INFO): DAT read: TxSync time:21:41:18.9007 2025-04-15T21:41:19.874Z,1744753279.874 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251951 2025-04-15T21:41:20.126Z,1744753280.126 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503239 2025-04-15T21:41:20.377Z,1744753280.377 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754987 2025-04-15T21:41:20.629Z,1744753280.629 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006883 2025-04-15T21:41:20.882Z,1744753280.882 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259380 2025-04-15T21:41:21.133Z,1744753281.133 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510957 2025-04-15T21:41:21.385Z,1744753281.385 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763063 2025-04-15T21:41:21.637Z,1744753281.637 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014880 2025-04-15T21:41:21.889Z,1744753281.889 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266984 2025-04-15T21:41:22.144Z,1744753282.144 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.520834 2025-04-15T21:41:22.393Z,1744753282.393 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770826 2025-04-15T21:41:22.645Z,1744753282.645 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022960 2025-04-15T21:41:22.897Z,1744753282.897 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.275027 2025-04-15T21:41:23.150Z,1744753283.150 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527243 2025-04-15T21:41:23.402Z,1744753283.402 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779171 2025-04-15T21:41:23.653Z,1744753283.653 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030895 2025-04-15T21:41:23.905Z,1744753283.905 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282902 2025-04-15T21:41:24.159Z,1744753284.159 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.536698 2025-04-15T21:41:24.409Z,1744753284.409 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786839 2025-04-15T21:41:24.664Z,1744753284.664 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.041838 2025-04-15T21:41:24.917Z,1744753284.917 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.294867 2025-04-15T21:41:25.172Z,1744753285.172 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.548805 2025-04-15T21:41:25.421Z,1744753285.421 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.799019 2025-04-15T21:41:25.673Z,1744753285.673 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.050953 2025-04-15T21:41:25.925Z,1744753285.925 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.302887 2025-04-15T21:41:26.179Z,1744753286.179 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.556264 2025-04-15T21:41:26.429Z,1744753286.429 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.807058 2025-04-15T21:41:26.681Z,1744753286.681 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.058895 2025-04-15T21:41:26.934Z,1744753286.934 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.311261 2025-04-15T21:41:27.188Z,1744753287.188 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.564944 2025-04-15T21:41:27.438Z,1744753287.438 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.815273 2025-04-15T21:41:27.689Z,1744753287.689 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.066927 2025-04-15T21:41:27.945Z,1744753287.945 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.322049 2025-04-15T21:41:28.195Z,1744753288.195 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.572260 2025-04-15T21:41:28.445Z,1744753288.445 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.822910 2025-04-15T21:41:28.698Z,1744753288.698 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.075213 2025-04-15T21:41:28.949Z,1744753288.949 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.326814 2025-04-15T21:41:29.203Z,1744753289.203 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.580733 2025-04-15T21:41:29.454Z,1744753289.454 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.831429 2025-04-15T21:41:29.705Z,1744753289.705 [DAT](INFO): Reached modem response timeout 2025-04-15T21:41:30.461Z,1744753290.461 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:41:30.462Z,1744753290.462 [DAT](INFO): response not received 2025-04-15T21:41:30.462Z,1744753290.462 [DAT](ERROR): No response from remote modem. 2025-04-15T21:41:33.145Z,1744753293.145 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:41:34.149Z,1744753294.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:42:04.281Z,1744753324.281 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:42:05.285Z,1744753325.285 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:42:34.417Z,1744753354.417 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003525 2025-04-15T21:42:44.841Z,1744753364.841 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250415T211501/Courier0019.lzma 2025-04-15T21:42:45.842Z,1744753365.842 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0019.lzma.bak 2025-04-15T21:42:45.843Z,1744753365.843 [DataOverHttps](INFO): SBD MOMSN=24668176 2025-04-15T21:42:55.114Z,1744753375.114 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:42:55.114Z,1744753375.114 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:43:05.424Z,1744753385.424 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250415T211501/Courier0022.lzma 2025-04-15T21:43:06.426Z,1744753386.426 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0022.lzma.bak 2025-04-15T21:43:06.426Z,1744753386.426 [DataOverHttps](INFO): SBD MOMSN=24668179 2025-04-15T21:43:16.282Z,1744753396.282 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:43:16.282Z,1744753396.282 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:43:19.311Z,1744753399.311 [OnDock:J.](INFO): *** querying acoustic contact *** 2025-04-15T21:43:19.381Z,1744753399.381 [DAT](DEBUG): Acoustic response timeout 2025-04-15T21:43:19.381Z,1744753399.381 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode. 2025-04-15T21:43:19.633Z,1744753399.633 [DAT](INFO): DAT read: user:13> 2025-04-15T21:43:19.634Z,1744753399.634 [DAT](INFO): DAT read: Tx time:21:43:18.9031 2025-04-15T21:43:19.634Z,1744753399.634 [DAT](INFO): Ping request sent. 2025-04-15T21:43:19.634Z,1744753399.634 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:43:19.634Z,1744753399.634 [DAT](INFO): publishing transmit ping time 2025-04-15T21:43:19.635Z,1744753399.635 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000801 2025-04-15T21:43:19.888Z,1744753399.888 [DAT](INFO): DAT read: TxSync time:21:43:18.9023 2025-04-15T21:43:19.889Z,1744753399.889 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.254844 2025-04-15T21:43:20.137Z,1744753400.137 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502957 2025-04-15T21:43:20.390Z,1744753400.390 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755217 2025-04-15T21:43:20.641Z,1744753400.641 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.007019 2025-04-15T21:43:20.893Z,1744753400.893 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259074 2025-04-15T21:43:21.146Z,1744753401.146 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.511219 2025-04-15T21:43:21.397Z,1744753401.397 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763103 2025-04-15T21:43:21.649Z,1744753401.649 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015180 2025-04-15T21:43:21.906Z,1744753401.906 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.271230 2025-04-15T21:43:22.153Z,1744753402.153 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519029 2025-04-15T21:43:22.405Z,1744753402.405 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771123 2025-04-15T21:43:22.657Z,1744753402.657 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022951 2025-04-15T21:43:22.912Z,1744753402.912 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.276861 2025-04-15T21:43:23.161Z,1744753403.161 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526955 2025-04-15T21:43:23.416Z,1744753403.416 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.782143 2025-04-15T21:43:23.669Z,1744753403.669 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.034997 2025-04-15T21:43:23.923Z,1744753403.923 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.288677 2025-04-15T21:43:24.174Z,1744753404.174 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.539347 2025-04-15T21:43:24.425Z,1744753404.425 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.791037 2025-04-15T21:43:24.679Z,1744753404.679 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.044548 2025-04-15T21:43:24.932Z,1744753404.932 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.297513 2025-04-15T21:43:25.181Z,1744753405.181 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.547140 2025-04-15T21:43:25.433Z,1744753405.433 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.799075 2025-04-15T21:43:25.685Z,1744753405.685 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.051060 2025-04-15T21:43:25.770Z,1744753405.770 [CommandExec](IMPORTANT): got command stop 2025-04-15T21:43:25.770Z,1744753405.770 [CommandExec](IMPORTANT): Scheduling is paused 2025-04-15T21:43:25.770Z,1744753405.770 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2025-04-15T21:43:25.785Z,1744753405.785 [MissionManager](INFO): MissionManager is completed. 2025-04-15T21:43:25.785Z,1744753405.785 [MissionManager](INFO): Uninitializing Mission OnDock 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock] Stopped 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock](DEBUG): Aggregate::uninitialize OnDock 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock:StandardEnvelopes] Stopped 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock:StandardEnvelopes](DEBUG): Aggregate::uninitialize OnDock:StandardEnvelopes 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-04-15T21:43:25.785Z,1744753405.785 [OnDock:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:BackseatDriver] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:BackseatDriver](DEBUG): Aggregate::uninitialize OnDock:BackseatDriver 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:BackseatDriver:A.BackseatDriver] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:PowerOnly] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:PowerOnly](DEBUG): Aggregate::uninitialize OnDock:PowerOnly 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:PowerOnly:E.Wait] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:dataRead] Stopped 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:dataRead](DEBUG): Aggregate::uninitialize OnDock:dataRead 2025-04-15T21:43:25.786Z,1744753405.786 [OnDock:dataRead:A] Stopped 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:J.] Stopped 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:J.](DEBUG): Uninitializing TrackAcousticContact. 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck] Stopped 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck:CheckIP] Stopped 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:43:25.787Z,1744753405.787 [OnDock:N.Docked] Stopped 2025-04-15T21:43:25.940Z,1744753405.940 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.304952 2025-04-15T21:43:26.189Z,1744753406.189 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.555011 2025-04-15T21:43:26.224Z,1744753406.224 [MissionManager](IMPORTANT): Started mission DefaultTankUndock 2025-04-15T21:43:26.232Z,1744753406.232 [DefaultTankUndock] Running Loop=1 2025-04-15T21:43:26.232Z,1744753406.232 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock 2025-04-15T21:43:26.233Z,1744753406.233 [DefaultTankUndock:B.GoToSurface] Running Loop=1 2025-04-15T21:43:26.233Z,1744753406.233 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-15T21:43:26.233Z,1744753406.233 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-15T21:43:26.233Z,1744753406.233 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-15T21:43:26.233Z,1744753406.233 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-15T21:43:26.234Z,1744753406.234 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-15T21:43:26.234Z,1744753406.234 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-15T21:43:26.234Z,1744753406.234 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-15T21:43:26.235Z,1744753406.235 [DefaultTankUndock:A.Wait] Running Loop=1 2025-04-15T21:43:26.235Z,1744753406.235 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:43:26.442Z,1744753406.442 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.807287 2025-04-15T21:43:26.695Z,1744753406.695 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.060256 2025-04-15T21:43:26.948Z,1744753406.948 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.313209 2025-04-15T21:43:27.198Z,1744753407.198 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.563288 2025-04-15T21:43:27.449Z,1744753407.449 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.815186 2025-04-15T21:43:27.704Z,1744753407.704 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.070093 2025-04-15T21:43:27.726Z,1744753407.726 [Reporter](INFO): platform_buoyancy_position 201.691315 cc 2025-04-15T21:43:27.934Z,1744753407.934 [Reporter](INFO): platform_buoyancy_position 201.825623 cc 2025-04-15T21:43:27.956Z,1744753407.956 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.321345 2025-04-15T21:43:28.205Z,1744753408.205 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.571025 2025-04-15T21:43:28.457Z,1744753408.457 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.823000 2025-04-15T21:43:28.710Z,1744753408.710 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.075542 2025-04-15T21:43:28.838Z,1744753408.838 [Reporter](INFO): platform_buoyancy_position 205.988922 cc 2025-04-15T21:43:28.964Z,1744753408.964 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.329233 2025-04-15T21:43:29.213Z,1744753409.213 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.578949 2025-04-15T21:43:29.290Z,1744753409.290 [Reporter](INFO): platform_buoyancy_position 211.360931 cc 2025-04-15T21:43:29.466Z,1744753409.466 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.831484 2025-04-15T21:43:29.495Z,1744753409.495 [Reporter](INFO): platform_buoyancy_position 214.584137 cc 2025-04-15T21:43:29.717Z,1744753409.717 [DAT](INFO): Reached modem response timeout 2025-04-15T21:43:29.717Z,1744753409.717 [DAT](IMPORTANT): Requesting device enable clr for address 50. 2025-04-15T21:43:29.899Z,1744753409.899 [Reporter](INFO): platform_buoyancy_position 221.164825 cc 2025-04-15T21:43:29.971Z,1744753409.971 [DAT](IMPORTANT): Requesting device enable clr for address 50. 2025-04-15T21:43:30.162Z,1744753410.162 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:43:30.162Z,1744753410.162 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:43:30.221Z,1744753410.221 [DAT](IMPORTANT): Requesting device enable clr for address 50. 2025-04-15T21:43:30.297Z,1744753410.297 [DockingStepper](INFO): Changing to mode: 2 2025-04-15T21:43:30.298Z,1744753410.298 [DockingStepper](INFO): Armed mode. 2025-04-15T21:43:30.369Z,1744753410.369 [DockingStepper](INFO): Commanding negative:54198 2025-04-15T21:43:30.391Z,1744753410.391 [DataOverHttps](INFO): Sending 486 bytes from file Logs/20250415T211501/Express0020.lzma 2025-04-15T21:43:30.428Z,1744753410.428 [Reporter](INFO): platform_buoyancy_position 225.328125 cc 2025-04-15T21:43:30.474Z,1744753410.474 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:43:30.474Z,1744753410.474 [DAT](INFO): response not received 2025-04-15T21:43:30.474Z,1744753410.474 [DAT](INFO): DAT read: user:14> 2025-04-15T21:43:30.475Z,1744753410.475 [DAT](INFO): DAT read: Tx time:21:43:29.8522 2025-04-15T21:43:30.475Z,1744753410.475 [DAT](INFO): Ping request sent. 2025-04-15T21:43:30.475Z,1744753410.475 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:43:30.475Z,1744753410.475 [DAT](INFO): publishing transmit ping time 2025-04-15T21:43:30.476Z,1744753410.476 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000726 2025-04-15T21:43:30.729Z,1744753410.729 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.252649 2025-04-15T21:43:30.763Z,1744753410.763 [Reporter](INFO): platform_buoyancy_position 231.774536 cc 2025-04-15T21:43:30.980Z,1744753410.980 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.504135 2025-04-15T21:43:31.163Z,1744753411.163 [Reporter](INFO): platform_buoyancy_position 236.072144 cc 2025-04-15T21:43:31.229Z,1744753411.229 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754006 2025-04-15T21:43:31.390Z,1744753411.390 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0020.lzma.bak 2025-04-15T21:43:31.390Z,1744753411.390 [DataOverHttps](INFO): SBD MOMSN=24668181 2025-04-15T21:43:31.482Z,1744753411.482 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006298 2025-04-15T21:43:31.547Z,1744753411.547 [Reporter](INFO): platform_buoyancy_position 242.518524 cc 2025-04-15T21:43:31.733Z,1744753411.733 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257966 2025-04-15T21:43:31.914Z,1744753411.914 [Reporter](INFO): platform_buoyancy_position 246.816147 cc 2025-04-15T21:43:31.986Z,1744753411.986 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510752 2025-04-15T21:43:32.237Z,1744753412.237 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.761936 2025-04-15T21:43:32.331Z,1744753412.331 [Reporter](INFO): platform_buoyancy_position 251.516647 cc 2025-04-15T21:43:32.489Z,1744753412.489 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.013892 2025-04-15T21:43:32.719Z,1744753412.719 [Reporter](INFO): platform_buoyancy_position 257.694427 cc 2025-04-15T21:43:32.741Z,1744753412.741 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.265991 2025-04-15T21:43:32.993Z,1744753412.993 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.517922 2025-04-15T21:43:33.163Z,1744753413.163 [Reporter](INFO): platform_buoyancy_position 264.140839 cc 2025-04-15T21:43:33.246Z,1744753413.246 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770207 2025-04-15T21:43:33.498Z,1744753413.498 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022504 2025-04-15T21:43:33.521Z,1744753413.521 [Reporter](INFO): platform_buoyancy_position 268.304138 cc 2025-04-15T21:43:33.749Z,1744753413.749 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.273944 2025-04-15T21:43:33.939Z,1744753413.939 [Reporter](INFO): platform_buoyancy_position 273.138947 cc 2025-04-15T21:43:34.001Z,1744753414.001 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.525984 2025-04-15T21:43:34.253Z,1744753414.253 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778053 2025-04-15T21:43:34.331Z,1744753414.331 [Reporter](INFO): platform_buoyancy_position 279.182434 cc 2025-04-15T21:43:34.505Z,1744753414.505 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.029988 2025-04-15T21:43:34.746Z,1744753414.746 [Reporter](INFO): platform_buoyancy_position 283.480042 cc 2025-04-15T21:43:34.757Z,1744753414.757 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282019 2025-04-15T21:43:35.009Z,1744753415.009 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.533919 2025-04-15T21:43:35.216Z,1744753415.216 [Reporter](INFO): platform_buoyancy_position 289.792145 cc 2025-04-15T21:43:35.261Z,1744753415.261 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.785976 2025-04-15T21:43:35.515Z,1744753415.515 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.039681 2025-04-15T21:43:35.595Z,1744753415.595 [Reporter](INFO): platform_buoyancy_position 296.238525 cc 2025-04-15T21:43:35.765Z,1744753415.765 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290055 2025-04-15T21:43:35.954Z,1744753415.954 [Reporter](INFO): platform_buoyancy_position 300.670441 cc 2025-04-15T21:43:36.017Z,1744753416.017 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542008 2025-04-15T21:43:36.269Z,1744753416.269 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794063 2025-04-15T21:43:36.378Z,1744753416.378 [Reporter](INFO): platform_buoyancy_position 304.968048 cc 2025-04-15T21:43:36.521Z,1744753416.521 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046067 2025-04-15T21:43:36.773Z,1744753416.773 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.297968 2025-04-15T21:43:36.786Z,1744753416.786 [Reporter](INFO): platform_buoyancy_position 311.280151 cc 2025-04-15T21:43:37.026Z,1744753417.026 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550306 2025-04-15T21:43:37.235Z,1744753417.235 [Reporter](INFO): platform_buoyancy_position 317.860840 cc 2025-04-15T21:43:37.277Z,1744753417.277 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802061 2025-04-15T21:43:37.529Z,1744753417.529 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054166 2025-04-15T21:43:37.627Z,1744753417.627 [Reporter](INFO): platform_buoyancy_position 322.158447 cc 2025-04-15T21:43:37.781Z,1744753417.781 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.305985 2025-04-15T21:43:37.979Z,1744753417.979 [Reporter](INFO): platform_buoyancy_position 326.321716 cc 2025-04-15T21:43:38.033Z,1744753418.033 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558059 2025-04-15T21:43:38.285Z,1744753418.285 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.809929 2025-04-15T21:43:38.435Z,1744753418.435 [Reporter](INFO): platform_buoyancy_position 332.768127 cc 2025-04-15T21:43:38.537Z,1744753418.537 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062030 2025-04-15T21:43:38.790Z,1744753418.790 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314392 2025-04-15T21:43:38.820Z,1744753418.820 [Reporter](INFO): platform_buoyancy_position 337.200012 cc 2025-04-15T21:43:39.041Z,1744753419.041 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566018 2025-04-15T21:43:39.219Z,1744753419.219 [Reporter](INFO): platform_buoyancy_position 343.512146 cc 2025-04-15T21:43:39.295Z,1744753419.295 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:43:39.296Z,1744753419.296 [DAT](INFO): response not received 2025-04-15T21:43:39.296Z,1744753419.296 [DAT](ERROR): No response from remote modem. 2025-04-15T21:43:39.296Z,1744753419.296 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.821131 2025-04-15T21:43:39.502Z,1744753419.502 [DefaultTankUndock:A.Wait](INFO): Done Waiting. 2025-04-15T21:43:39.502Z,1744753419.502 [DefaultTankUndock:A.Wait] Stopped 2025-04-15T21:43:39.502Z,1744753419.502 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:43:39.545Z,1744753419.545 [DAT](INFO): DAT read: user:15> 2025-04-15T21:43:39.546Z,1744753419.546 [DAT](INFO): DAT read: Tx time:21:43:38.8023 2025-04-15T21:43:39.546Z,1744753419.546 [DAT](INFO): Ping request sent. 2025-04-15T21:43:39.546Z,1744753419.546 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:43:39.547Z,1744753419.547 [DAT](INFO): publishing transmit ping time 2025-04-15T21:43:39.547Z,1744753419.547 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000722 2025-04-15T21:43:39.603Z,1744753419.603 [Reporter](INFO): platform_buoyancy_position 347.809753 cc 2025-04-15T21:43:39.797Z,1744753419.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250703 2025-04-15T21:43:39.883Z,1744753419.883 [DefaultTankUndock:C.Execute] Running Loop=1 2025-04-15T21:43:39.971Z,1744753419.971 [Reporter](INFO): platform_buoyancy_position 352.241638 cc 2025-04-15T21:43:40.049Z,1744753420.049 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502752 2025-04-15T21:43:40.301Z,1744753420.301 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754904 2025-04-15T21:43:40.307Z,1744753420.307 [DefaultTankUndock:C.Execute](INFO): Executing command dock arm 2025-04-15T21:43:40.307Z,1744753420.307 [DefaultTankUndock:C.Execute] Stopped 2025-04-15T21:43:40.307Z,1744753420.307 [DefaultTankUndock:CheckIn] Running Loop=1 2025-04-15T21:43:40.308Z,1744753420.308 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn 2025-04-15T21:43:40.308Z,1744753420.308 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1 2025-04-15T21:43:40.378Z,1744753420.378 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:43:40.378Z,1744753420.378 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:43:40.420Z,1744753420.420 [Reporter](INFO): platform_buoyancy_position 358.553711 cc 2025-04-15T21:43:40.553Z,1744753420.553 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006677 2025-04-15T21:43:40.805Z,1744753420.805 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258837 2025-04-15T21:43:40.808Z,1744753420.808 [Reporter](INFO): platform_buoyancy_position 362.985657 cc 2025-04-15T21:43:41.057Z,1744753421.057 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510742 2025-04-15T21:43:41.207Z,1744753421.207 [Reporter](INFO): platform_buoyancy_position 369.297729 cc 2025-04-15T21:43:41.309Z,1744753421.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762873 2025-04-15T21:43:41.561Z,1744753421.561 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014731 2025-04-15T21:43:41.635Z,1744753421.635 [Reporter](INFO): platform_buoyancy_position 373.729614 cc 2025-04-15T21:43:41.813Z,1744753421.813 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266722 2025-04-15T21:43:41.965Z,1744753421.965 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:43:42.003Z,1744753422.003 [Reporter](INFO): platform_buoyancy_position 380.041748 cc 2025-04-15T21:43:42.065Z,1744753422.065 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518695 2025-04-15T21:43:42.287Z,1744753422.287 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214341.00,A,3648.16384,N,12147.28377,W,0.447,0.00,150425,,,A*74 2025-04-15T21:43:42.290Z,1744753422.290 [NAL9602](INFO): GPS fix at 20250415T214341: (36.802731, -121.788063) 2025-04-15T21:43:42.317Z,1744753422.317 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770846 2025-04-15T21:43:42.321Z,1744753422.321 [DefaultTankUndock:CheckIn:Read_GPS] Stopped 2025-04-15T21:43:42.321Z,1744753422.321 [DefaultTankUndock:CheckIn:Read_Iridium] Running Loop=1 2025-04-15T21:43:42.427Z,1744753422.427 [Reporter](INFO): platform_buoyancy_position 384.339355 cc 2025-04-15T21:43:42.573Z,1744753422.573 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.025295 2025-04-15T21:43:42.822Z,1744753422.822 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.275828 2025-04-15T21:43:42.828Z,1744753422.828 [Reporter](INFO): platform_buoyancy_position 390.651428 cc 2025-04-15T21:43:43.074Z,1744753423.074 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527119 2025-04-15T21:43:43.325Z,1744753423.325 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778848 2025-04-15T21:43:43.534Z,1744753423.534 [Reporter](INFO): platform_buoyancy_position 399.515259 cc 2025-04-15T21:43:43.577Z,1744753423.577 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030780 2025-04-15T21:43:43.830Z,1744753423.830 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.283115 2025-04-15T21:43:43.880Z,1744753423.880 [Reporter](INFO): platform_buoyancy_position 403.812866 cc 2025-04-15T21:43:44.081Z,1744753424.081 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534724 2025-04-15T21:43:44.274Z,1744753424.274 [Reporter](INFO): platform_buoyancy_position 410.124939 cc 2025-04-15T21:43:44.333Z,1744753424.333 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786856 2025-04-15T21:43:44.585Z,1744753424.585 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.038903 2025-04-15T21:43:44.645Z,1744753424.645 [Reporter](INFO): platform_buoyancy_position 414.556824 cc 2025-04-15T21:43:44.837Z,1744753424.837 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290919 2025-04-15T21:43:45.018Z,1744753425.018 [Reporter](INFO): platform_buoyancy_position 418.720154 cc 2025-04-15T21:43:45.089Z,1744753425.089 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542846 2025-04-15T21:43:45.341Z,1744753425.341 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794878 2025-04-15T21:43:45.482Z,1744753425.482 [Reporter](INFO): platform_buoyancy_position 425.300842 cc 2025-04-15T21:43:45.593Z,1744753425.593 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046929 2025-04-15T21:43:45.819Z,1744753425.819 [Reporter](INFO): platform_buoyancy_position 429.598450 cc 2025-04-15T21:43:45.845Z,1744753425.845 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298761 2025-04-15T21:43:46.097Z,1744753426.097 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550859 2025-04-15T21:43:46.241Z,1744753426.241 [Reporter](INFO): platform_buoyancy_position 434.030334 cc 2025-04-15T21:43:46.349Z,1744753426.349 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802772 2025-04-15T21:43:46.602Z,1744753426.602 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.055062 2025-04-15T21:43:46.643Z,1744753426.643 [Reporter](INFO): platform_buoyancy_position 440.342468 cc 2025-04-15T21:43:46.854Z,1744753426.854 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307147 2025-04-15T21:43:47.045Z,1744753427.045 [Reporter](INFO): platform_buoyancy_position 444.640076 cc 2025-04-15T21:43:47.105Z,1744753427.105 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558877 2025-04-15T21:43:47.357Z,1744753427.357 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810742 2025-04-15T21:43:47.502Z,1744753427.502 [Reporter](INFO): platform_buoyancy_position 451.086426 cc 2025-04-15T21:43:47.609Z,1744753427.609 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062783 2025-04-15T21:43:47.843Z,1744753427.843 [Reporter](INFO): platform_buoyancy_position 455.652649 cc 2025-04-15T21:43:47.861Z,1744753427.861 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314844 2025-04-15T21:43:48.113Z,1744753428.113 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566632 2025-04-15T21:43:48.305Z,1744753428.305 [Reporter](INFO): platform_buoyancy_position 461.830444 cc 2025-04-15T21:43:48.365Z,1744753428.365 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:43:48.366Z,1744753428.366 [DAT](INFO): response not received 2025-04-15T21:43:48.366Z,1744753428.366 [DAT](INFO): DAT read: user:16> 2025-04-15T21:43:48.367Z,1744753428.367 [DAT](INFO): DAT read: Tx time:21:43:47.7524 2025-04-15T21:43:48.367Z,1744753428.367 [DAT](INFO): Ping request sent. 2025-04-15T21:43:48.367Z,1744753428.367 [DAT](INFO): transmitted an acoustic signal 2025-04-15T21:43:48.367Z,1744753428.367 [DAT](INFO): publishing transmit ping time 2025-04-15T21:43:48.368Z,1744753428.368 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000723 2025-04-15T21:43:48.625Z,1744753428.625 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.258208 2025-04-15T21:43:48.708Z,1744753428.708 [Reporter](INFO): platform_buoyancy_position 466.396667 cc 2025-04-15T21:43:48.877Z,1744753428.877 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.510094 2025-04-15T21:43:49.067Z,1744753429.067 [Reporter](INFO): platform_buoyancy_position 472.305847 cc 2025-04-15T21:43:49.129Z,1744753429.129 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.762096 2025-04-15T21:43:49.381Z,1744753429.381 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.014158 2025-04-15T21:43:49.526Z,1744753429.526 [Reporter](INFO): platform_buoyancy_position 478.886536 cc 2025-04-15T21:43:49.633Z,1744753429.633 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.266069 2025-04-15T21:43:49.886Z,1744753429.886 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.518486 2025-04-15T21:43:49.894Z,1744753429.894 [Reporter](INFO): platform_buoyancy_position 483.184143 cc 2025-04-15T21:43:50.137Z,1744753430.137 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.769984 2025-04-15T21:43:50.261Z,1744753430.261 [Reporter](INFO): platform_buoyancy_position 487.481750 cc 2025-04-15T21:43:50.389Z,1744753430.389 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.022080 2025-04-15T21:43:50.653Z,1744753430.653 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.286091 2025-04-15T21:43:50.713Z,1744753430.713 [Reporter](INFO): platform_buoyancy_position 493.793793 cc 2025-04-15T21:43:50.905Z,1744753430.905 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.538171 2025-04-15T21:43:51.070Z,1744753431.070 [Reporter](INFO): platform_buoyancy_position 498.225800 cc 2025-04-15T21:43:51.157Z,1744753431.157 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.790058 2025-04-15T21:43:51.409Z,1744753431.409 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.042128 2025-04-15T21:43:51.546Z,1744753431.546 [Reporter](INFO): platform_buoyancy_position 504.672180 cc 2025-04-15T21:43:51.661Z,1744753431.661 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.294253 2025-04-15T21:43:51.863Z,1744753431.863 [Reporter](INFO): platform_buoyancy_position 509.104065 cc 2025-04-15T21:43:51.913Z,1744753431.913 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.546085 2025-04-15T21:43:52.165Z,1744753432.165 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.798172 2025-04-15T21:43:52.275Z,1744753432.275 [Reporter](INFO): platform_buoyancy_position 513.267334 cc 2025-04-15T21:43:52.418Z,1744753432.418 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.050644 2025-04-15T21:43:52.670Z,1744753432.670 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.302327 2025-04-15T21:43:52.699Z,1744753432.699 [Reporter](INFO): platform_buoyancy_position 519.713745 cc 2025-04-15T21:43:52.922Z,1744753432.922 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.554299 2025-04-15T21:43:52.973Z,1744753432.973 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250415T213522/Courier0000.lzma 2025-04-15T21:43:53.071Z,1744753433.071 [Reporter](INFO): platform_buoyancy_position 524.011353 cc 2025-04-15T21:43:53.173Z,1744753433.173 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.806155 2025-04-15T21:43:53.425Z,1744753433.425 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.058007 2025-04-15T21:43:53.531Z,1744753433.531 [Reporter](INFO): platform_buoyancy_position 530.457764 cc 2025-04-15T21:43:53.677Z,1744753433.677 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.310032 2025-04-15T21:43:53.883Z,1744753433.883 [Reporter](INFO): platform_buoyancy_position 535.023926 cc 2025-04-15T21:43:53.933Z,1744753433.933 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.566220 2025-04-15T21:43:53.974Z,1744753433.974 [DataOverHttps](INFO): Moved sent file to Logs/20250415T213522/Courier0000.lzma.bak 2025-04-15T21:43:53.974Z,1744753433.974 [DataOverHttps](INFO): SBD MOMSN=24668199 2025-04-15T21:43:54.185Z,1744753434.185 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.818145 2025-04-15T21:43:54.307Z,1744753434.307 [Reporter](INFO): platform_buoyancy_position 541.067444 cc 2025-04-15T21:43:54.437Z,1744753434.437 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.070038 2025-04-15T21:43:54.690Z,1744753434.690 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.322616 2025-04-15T21:43:54.731Z,1744753434.731 [Reporter](INFO): platform_buoyancy_position 545.767944 cc 2025-04-15T21:43:54.941Z,1744753434.941 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.574023 2025-04-15T21:43:55.147Z,1744753435.147 [Reporter](INFO): platform_buoyancy_position 551.945740 cc 2025-04-15T21:43:55.193Z,1744753435.193 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.826190 2025-04-15T21:43:55.445Z,1744753435.445 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.078174 2025-04-15T21:43:55.608Z,1744753435.608 [Reporter](INFO): platform_buoyancy_position 558.392151 cc 2025-04-15T21:43:55.698Z,1744753435.698 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.330545 2025-04-15T21:43:55.933Z,1744753435.933 [Reporter](INFO): platform_buoyancy_position 562.689758 cc 2025-04-15T21:43:55.950Z,1744753435.950 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.582388 2025-04-15T21:43:56.201Z,1744753436.201 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.834020 2025-04-15T21:43:56.346Z,1744753436.346 [Reporter](INFO): platform_buoyancy_position 567.121643 cc 2025-04-15T21:43:56.453Z,1744753436.453 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.086156 2025-04-15T21:43:56.706Z,1744753436.706 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.339104 2025-04-15T21:43:56.771Z,1744753436.771 [Reporter](INFO): platform_buoyancy_position 573.568054 cc 2025-04-15T21:43:56.957Z,1744753436.957 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.590214 2025-04-15T21:43:57.151Z,1744753437.151 [Reporter](INFO): platform_buoyancy_position 577.731384 cc 2025-04-15T21:43:57.209Z,1744753437.209 [DAT](INFO): DAT read: Response Not Received 2025-04-15T21:43:57.210Z,1744753437.210 [DAT](INFO): response not received 2025-04-15T21:43:57.210Z,1744753437.210 [DAT](ERROR): No response from remote modem. 2025-04-15T21:43:57.210Z,1744753437.210 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.843113 2025-04-15T21:43:57.461Z,1744753437.461 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.094164 2025-04-15T21:43:57.619Z,1744753437.619 [Reporter](INFO): platform_buoyancy_position 584.177734 cc 2025-04-15T21:43:57.715Z,1744753437.715 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.347760 2025-04-15T21:43:57.938Z,1744753437.938 [Reporter](INFO): platform_buoyancy_position 588.475342 cc 2025-04-15T21:43:57.969Z,1744753437.969 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.600939 2025-04-15T21:43:58.217Z,1744753438.217 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.850052 2025-04-15T21:43:58.381Z,1744753438.381 [Reporter](INFO): platform_buoyancy_position 594.787476 cc 2025-04-15T21:43:58.911Z,1744753438.911 [Reporter](INFO): platform_buoyancy_position 601.368164 cc 2025-04-15T21:43:59.134Z,1744753439.134 [Reporter](INFO): platform_buoyancy_position 603.516968 cc 2025-04-15T21:43:59.843Z,1744753439.843 [Reporter](INFO): platform_buoyancy_position 614.260986 cc 2025-04-15T21:44:00.039Z,1744753440.039 [Reporter](INFO): platform_buoyancy_position 616.409790 cc 2025-04-15T21:44:00.399Z,1744753440.399 [Reporter](INFO): platform_buoyancy_position 620.707336 cc 2025-04-15T21:44:00.870Z,1744753440.870 [Reporter](INFO): platform_buoyancy_position 626.616577 cc 2025-04-15T21:44:01.216Z,1744753441.216 [Reporter](INFO): platform_buoyancy_position 631.317078 cc 2025-04-15T21:44:01.623Z,1744753441.623 [Reporter](INFO): platform_buoyancy_position 635.748962 cc 2025-04-15T21:44:02.003Z,1744753442.003 [Reporter](INFO): platform_buoyancy_position 642.329651 cc 2025-04-15T21:44:02.391Z,1744753442.391 [Reporter](INFO): platform_buoyancy_position 646.627258 cc 2025-04-15T21:44:02.832Z,1744753442.832 [Reporter](INFO): platform_buoyancy_position 652.939392 cc 2025-04-15T21:44:03.226Z,1744753443.226 [Reporter](INFO): platform_buoyancy_position 657.236938 cc 2025-04-15T21:44:03.707Z,1744753443.707 [Reporter](INFO): platform_buoyancy_position 663.683350 cc 2025-04-15T21:44:04.034Z,1744753444.034 [Reporter](INFO): platform_buoyancy_position 667.980957 cc 2025-04-15T21:44:04.465Z,1744753444.465 [Reporter](INFO): platform_buoyancy_position 674.561646 cc 2025-04-15T21:44:04.927Z,1744753444.927 [Reporter](INFO): platform_buoyancy_position 680.873779 cc 2025-04-15T21:44:05.291Z,1744753445.291 [Reporter](INFO): platform_buoyancy_position 685.171387 cc 2025-04-15T21:44:05.819Z,1744753445.819 [Reporter](INFO): platform_buoyancy_position 691.752075 cc 2025-04-15T21:44:06.071Z,1744753446.071 [Reporter](INFO): platform_buoyancy_position 694.975281 cc 2025-04-15T21:44:06.516Z,1744753446.516 [Reporter](INFO): platform_buoyancy_position 700.481567 cc 2025-04-15T21:44:06.975Z,1744753446.975 [Reporter](INFO): platform_buoyancy_position 706.793640 cc 2025-04-15T21:44:07.335Z,1744753447.335 [Reporter](INFO): platform_buoyancy_position 711.091248 cc 2025-04-15T21:44:07.860Z,1744753447.860 [Reporter](INFO): platform_buoyancy_position 717.537659 cc 2025-04-15T21:44:08.146Z,1744753448.146 [Reporter](INFO): platform_buoyancy_position 721.969543 cc 2025-04-15T21:44:08.592Z,1744753448.592 [Reporter](INFO): platform_buoyancy_position 728.281677 cc 2025-04-15T21:44:09.058Z,1744753449.058 [Reporter](INFO): platform_buoyancy_position 734.593750 cc 2025-04-15T21:44:09.369Z,1744753449.369 [Reporter](INFO): platform_buoyancy_position 737.145447 cc 2025-04-15T21:44:09.898Z,1744753449.898 [Reporter](INFO): platform_buoyancy_position 745.337769 cc 2025-04-15T21:44:10.185Z,1744753450.185 [Reporter](INFO): platform_buoyancy_position 749.501099 cc 2025-04-15T21:44:10.643Z,1744753450.643 [Reporter](INFO): platform_buoyancy_position 754.067261 cc 2025-04-15T21:44:11.091Z,1744753451.091 [Reporter](INFO): platform_buoyancy_position 760.379395 cc 2025-04-15T21:44:11.343Z,1744753451.343 [Reporter](INFO): platform_buoyancy_position 764.811279 cc 2025-04-15T21:44:11.847Z,1744753451.847 [Reporter](INFO): platform_buoyancy_position 770.451843 cc 2025-04-15T21:44:12.139Z,1744753452.139 [Reporter](INFO): platform_buoyancy_position 774.615173 cc 2025-04-15T21:44:12.551Z,1744753452.551 [Reporter](INFO): platform_buoyancy_position 779.718567 cc 2025-04-15T21:44:13.039Z,1744753453.039 [Reporter](INFO): platform_buoyancy_position 786.164978 cc 2025-04-15T21:44:13.391Z,1744753453.391 [Reporter](INFO): platform_buoyancy_position 790.596863 cc 2025-04-15T21:44:13.883Z,1744753453.883 [Reporter](INFO): platform_buoyancy_position 796.908997 cc 2025-04-15T21:44:14.183Z,1744753454.183 [Reporter](INFO): platform_buoyancy_position 801.340881 cc 2025-04-15T21:44:14.599Z,1744753454.599 [Reporter](INFO): platform_buoyancy_position 805.772766 cc 2025-04-15T21:44:15.039Z,1744753455.039 [Reporter](INFO): platform_buoyancy_position 812.084900 cc 2025-04-15T21:44:15.389Z,1744753455.389 [Reporter](INFO): platform_buoyancy_position 816.382446 cc 2025-04-15T21:44:15.911Z,1744753455.911 [Reporter](INFO): platform_buoyancy_position 824.306152 cc 2025-04-15T21:44:16.262Z,1744753456.262 [Reporter](INFO): platform_buoyancy_position 829.140991 cc 2025-04-15T21:44:16.727Z,1744753456.727 [Reporter](INFO): platform_buoyancy_position 833.438599 cc 2025-04-15T21:44:17.179Z,1744753457.179 [Reporter](INFO): platform_buoyancy_position 839.885010 cc 2025-04-15T21:44:17.542Z,1744753457.542 [Reporter](INFO): platform_buoyancy_position 846.331421 cc 2025-04-15T21:44:18.014Z,1744753458.014 [Reporter](INFO): platform_buoyancy_position 851.434814 cc 2025-04-15T21:44:18.247Z,1744753458.247 [Reporter](INFO): platform_buoyancy_position 854.792236 cc 2025-04-15T21:44:18.659Z,1744753458.659 [Reporter](INFO): platform_buoyancy_position 859.492798 cc 2025-04-15T21:44:19.110Z,1744753459.110 [Reporter](INFO): platform_buoyancy_position 865.804932 cc 2025-04-15T21:44:19.527Z,1744753459.527 [Reporter](INFO): platform_buoyancy_position 872.116943 cc 2025-04-15T21:44:19.935Z,1744753459.935 [Reporter](INFO): platform_buoyancy_position 876.414551 cc 2025-04-15T21:44:20.231Z,1744753460.231 [Reporter](INFO): platform_buoyancy_position 880.846436 cc 2025-04-15T21:44:20.659Z,1744753460.659 [Reporter](INFO): platform_buoyancy_position 886.084229 cc 2025-04-15T21:44:21.087Z,1744753461.087 [Reporter](INFO): platform_buoyancy_position 891.590454 cc 2025-04-15T21:44:21.490Z,1744753461.490 [Reporter](INFO): platform_buoyancy_position 897.768311 cc 2025-04-15T21:44:21.962Z,1744753461.962 [Reporter](INFO): platform_buoyancy_position 904.483276 cc 2025-04-15T21:44:22.287Z,1744753462.287 [Reporter](INFO): platform_buoyancy_position 908.646606 cc 2025-04-15T21:44:22.681Z,1744753462.681 [Reporter](INFO): platform_buoyancy_position 913.078491 cc 2025-04-15T21:44:23.063Z,1744753463.063 [Reporter](INFO): platform_buoyancy_position 919.524902 cc 2025-04-15T21:44:23.237Z,1744753463.237 [DataOverHttps](INFO): Sending 549 bytes from file Logs/20250415T211501/Express0023.lzma 2025-04-15T21:44:23.479Z,1744753463.479 [Reporter](INFO): platform_buoyancy_position 923.822510 cc 2025-04-15T21:44:23.934Z,1744753463.934 [Reporter](INFO): platform_buoyancy_position 930.134644 cc 2025-04-15T21:44:24.235Z,1744753464.235 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0023.lzma.bak 2025-04-15T21:44:24.235Z,1744753464.235 [DataOverHttps](INFO): SBD MOMSN=24668214 2025-04-15T21:44:24.319Z,1744753464.319 [Reporter](INFO): platform_buoyancy_position 934.566528 cc 2025-04-15T21:44:24.675Z,1744753464.675 [Reporter](INFO): platform_buoyancy_position 938.729736 cc 2025-04-15T21:44:25.091Z,1744753465.091 [Reporter](INFO): platform_buoyancy_position 945.310425 cc 2025-04-15T21:44:25.507Z,1744753465.507 [Reporter](INFO): platform_buoyancy_position 949.473755 cc 2025-04-15T21:44:25.955Z,1744753465.955 [Reporter](INFO): platform_buoyancy_position 955.920166 cc 2025-04-15T21:44:26.331Z,1744753466.331 [Reporter](INFO): platform_buoyancy_position 960.217773 cc 2025-04-15T21:44:26.735Z,1744753466.735 [Reporter](INFO): platform_buoyancy_position 964.649658 cc 2025-04-15T21:44:27.159Z,1744753467.159 [Reporter](INFO): platform_buoyancy_position 971.096069 cc 2025-04-15T21:44:27.539Z,1744753467.539 [Reporter](INFO): platform_buoyancy_position 975.393677 cc 2025-04-15T21:44:27.981Z,1744753467.981 [Reporter](INFO): platform_buoyancy_position 981.840088 cc 2025-04-15T21:44:28.347Z,1744753468.347 [Reporter](INFO): platform_buoyancy_position 986.137634 cc 2025-04-15T21:44:28.831Z,1744753468.831 [Reporter](INFO): platform_buoyancy_position 990.435242 cc 2025-04-15T21:44:43.813Z,1744753483.813 [CommandExec](IMPORTANT): got command docking standby 2025-04-15T21:44:43.813Z,1744753483.813 [CommandExec](IMPORTANT): Switching docking module to STANDBY. 2025-04-15T21:44:43.999Z,1744753483.999 [DockingStepper](INFO): Changing to mode: 1 2025-04-15T21:44:43.999Z,1744753483.999 [DockingStepper](INFO): Standby mode. 2025-04-15T21:44:44.068Z,1744753484.068 [DockingStepper](INFO): Commanding positive:54180 2025-04-15T21:44:47.361Z,1744753487.361 [DataOverHttps](INFO): Sending 734 bytes from file Logs/20250415T213522/Express0001.lzma 2025-04-15T21:44:48.362Z,1744753488.362 [DataOverHttps](INFO): Moved sent file to Logs/20250415T213522/Express0001.lzma.bak 2025-04-15T21:44:48.362Z,1744753488.362 [DataOverHttps](INFO): SBD MOMSN=24668224 2025-04-15T21:44:54.078Z,1744753494.078 [DefaultTankUndock:CheckIn:Read_Iridium] Stopped 2025-04-15T21:44:54.078Z,1744753494.078 [DefaultTankUndock:CheckIn:C.Wait] Running Loop=1 2025-04-15T21:44:54.078Z,1744753494.078 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:45:18.025Z,1744753518.025 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:45:26.897Z,1744753526.897 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:45:34.454Z,1744753534.454 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:45:34.454Z,1744753534.454 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:45:35.917Z,1744753535.917 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:45:45.085Z,1744753545.085 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:45:53.044Z,1744753553.044 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:45:53.044Z,1744753553.044 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:45:54.973Z,1744753554.973 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:04.341Z,1744753564.341 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:16.757Z,1744753576.757 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:27.517Z,1744753587.517 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:36.797Z,1744753596.797 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:45.801Z,1744753605.801 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:46:46.047Z,1744753606.047 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:46:46.048Z,1744753606.048 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:46:54.881Z,1744753614.881 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:03.881Z,1744753623.881 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:13.193Z,1744753633.193 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:22.089Z,1744753642.089 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:31.197Z,1744753651.197 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:40.397Z,1744753660.397 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:49.393Z,1744753669.393 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:47:58.581Z,1744753678.581 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:48:07.621Z,1744753687.621 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:48:16.627Z,1744753696.627 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:48:16.627Z,1744753696.627 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:48:20.269Z,1744753700.269 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:48:32.849Z,1744753712.849 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:48:41.746Z,1744753721.746 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:48:44.094Z,1744753724.094 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-15T21:48:50.833Z,1744753730.833 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:01.105Z,1744753741.105 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:10.321Z,1744753750.321 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:14.797Z,1744753754.797 [NAL9602](INFO): Not Powering down - fast GPS 2025-04-15T21:49:19.577Z,1744753759.577 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:26.094Z,1744753766.094 [CommandExec](IMPORTANT): got command strobe off 2025-04-15T21:49:26.094Z,1744753766.094 [CommandExec](IMPORTANT): Deactivating strobe 2025-04-15T21:49:28.693Z,1744753768.693 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:37.878Z,1744753777.878 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:46.741Z,1744753786.741 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:54.829Z,1744753794.829 [DefaultTankUndock:CheckIn:C.Wait](INFO): Done Waiting. 2025-04-15T21:49:54.829Z,1744753794.829 [DefaultTankUndock:CheckIn:C.Wait] Stopped 2025-04-15T21:49:54.829Z,1744753794.829 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:49:54.829Z,1744753794.829 [DefaultTankUndock:CheckIn:D] Running Loop=1 2025-04-15T21:49:55.208Z,1744753795.208 [DefaultTankUndock:CheckIn:D] Stopped 2025-04-15T21:49:55.209Z,1744753795.209 [DefaultTankUndock:CheckIn:E] Running Loop=1 2025-04-15T21:49:55.607Z,1744753795.607 [DefaultTankUndock:CheckIn:E](IMPORTANT): Default mission has been running for 6.483064 min 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn:E] Stopped 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn](INFO): Completed DefaultTankUndock:CheckIn 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn] Stopped 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn](INFO): Running loop #2 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn] Running Loop=2 2025-04-15T21:49:55.608Z,1744753795.608 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn 2025-04-15T21:49:55.609Z,1744753795.609 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1 2025-04-15T21:49:55.797Z,1744753795.797 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:49:57.626Z,1744753797.626 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214956.00,A,3648.16419,N,12147.28269,W,0.136,0.00,150425,,,D*73 2025-04-15T21:49:57.628Z,1744753797.628 [NAL9602](INFO): GPS fix at 20250415T214956: (36.802737, -121.788045) 2025-04-15T21:49:57.644Z,1744753797.644 [DefaultTankUndock:CheckIn:Read_GPS] Stopped 2025-04-15T21:49:57.644Z,1744753797.644 [DefaultTankUndock:CheckIn:Read_Iridium] Running Loop=1 2025-04-15T21:50:04.562Z,1744753804.562 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250415T213522/Courier0003.lzma 2025-04-15T21:50:05.566Z,1744753805.566 [DataOverHttps](INFO): Moved sent file to Logs/20250415T213522/Courier0003.lzma.bak 2025-04-15T21:50:05.566Z,1744753805.566 [DataOverHttps](INFO): SBD MOMSN=24668257 2025-04-15T21:50:28.114Z,1744753828.114 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-04-15T21:50:28.192Z,1744753828.192 [NAL9602](ERROR): received: +CSQ:0 OK932, 2, 0, 0, 0 OK 2025-04-15T21:50:34.257Z,1744753834.257 [DataOverHttps](INFO): Sending 354 bytes from file Logs/20250415T213522/Express0004.lzma 2025-04-15T21:50:35.258Z,1744753835.258 [DataOverHttps](INFO): Moved sent file to Logs/20250415T213522/Express0004.lzma.bak 2025-04-15T21:50:35.258Z,1744753835.258 [DataOverHttps](INFO): SBD MOMSN=24668260 2025-04-15T21:50:40.682Z,1744753840.682 [DefaultTankUndock:CheckIn:Read_Iridium] Stopped 2025-04-15T21:50:40.682Z,1744753840.682 [DefaultTankUndock:CheckIn:C.Wait] Running Loop=1 2025-04-15T21:50:40.682Z,1744753840.682 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:50:57.758Z,1744753857.758 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:50:57.758Z,1744753857.758 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:50:58.067Z,1744753858.067 [DockingStepper](INFO): Changing to mode: 2 2025-04-15T21:50:58.067Z,1744753858.067 [DockingStepper](INFO): Armed mode. 2025-04-15T21:50:58.129Z,1744753858.129 [DockingStepper](INFO): Commanding negative:54297 2025-04-15T21:51:01.769Z,1744753861.769 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:10.742Z,1744753870.742 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:19.501Z,1744753879.501 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:28.365Z,1744753888.365 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:37.077Z,1744753897.077 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:41.834Z,1744753901.834 [CommandExec](IMPORTANT): got command docking standby 2025-04-15T21:51:41.834Z,1744753901.834 [CommandExec](IMPORTANT): Switching docking module to STANDBY. 2025-04-15T21:51:42.087Z,1744753902.087 [DockingStepper](INFO): Changing to mode: 1 2025-04-15T21:51:42.087Z,1744753902.087 [DockingStepper](INFO): Standby mode. 2025-04-15T21:51:42.158Z,1744753902.158 [DockingStepper](INFO): Commanding positive:54297 2025-04-15T21:51:44.487Z,1744753904.487 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25041513525501,8.9, 0.0,1518.6, 0 2025-04-15T21:51:46.187Z,1744753906.187 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:51:54.945Z,1744753914.945 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:04.005Z,1744753924.005 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:09.597Z,1744753929.597 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, +19, -8, 2025-04-15T21:52:16.602Z,1744753936.602 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:30.189Z,1744753950.189 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:39.378Z,1744753959.378 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:49.537Z,1744753969.537 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:52:57.498Z,1744753977.498 [DataOverHttps](IMPORTANT): SBD MTMSN=20250415T215256 2025-04-15T21:53:05.732Z,1744753985.732 [DataOverHttps](INFO): Received command: load Engineering/OnDock.tl;set OnDock.DockedTime .5 h;set OnDock.DetachedTimeout 1 hour;set OnDock.RangeTimeout 1 hour;set OnDock.MinAltitude 0.1 m;set OnDock.MinOffshore 0.0001 km;set OnDock.IfconfigInterval 2 min;run 2025-04-15T21:53:05.806Z,1744753985.806 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/OnDock.tl 2025-04-15T21:53:05.807Z,1744753985.807 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/OnDock.tl 2025-04-15T21:53:05.807Z,1744753985.807 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/OnDock.tl 2025-04-15T21:53:05.849Z,1744753985.849 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/OnDock.tl 2025-04-15T21:53:07.773Z,1744753987.773 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:53:08.014Z,1744753988.014 [Reporter](INFO): platform_buoyancy_position 1007.491394 cc 2025-04-15T21:53:08.781Z,1744753988.781 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/OnDock.tl translated into: 8 2 1 5 2 2 5 5 Restarting logs restart logs ! ifconfig Mission ending, breaking off. Range: . 2025-04-15T21:53:08.786Z,1744753988.786 [MissionManager](INFO): DefineArg OnDock.DockedTime = 8.000000 h 2025-04-15T21:53:08.789Z,1744753988.789 [MissionManager](INFO): DefineArg OnDock.DetachedTimeout = 30.000000 s 2025-04-15T21:53:08.791Z,1744753988.791 [MissionManager](INFO): DefineArg OnDock.RangeTimeout = 600.000000 s 2025-04-15T21:53:08.793Z,1744753988.793 [MissionManager](INFO): DefineArg OnDock.TrackingUpdatePeriod = 2.000000 min 2025-04-15T21:53:08.796Z,1744753988.796 [MissionManager](INFO): DefineArg OnDock.NumberOfPings = 1.000000 count 2025-04-15T21:53:08.798Z,1744753988.798 [MissionManager](INFO): DefineArg OnDock.TransponderCode = 50 count 2025-04-15T21:53:08.801Z,1744753988.801 [MissionManager](INFO): DefineArg OnDock.MaxDepth = 215.000000 m 2025-04-15T21:53:08.803Z,1744753988.803 [MissionManager](INFO): DefineArg OnDock.MinAltitude = 5.000000 m 2025-04-15T21:53:08.805Z,1744753988.805 [MissionManager](INFO): DefineArg OnDock.MinOffshore = 2.000000 km 2025-04-15T21:53:08.807Z,1744753988.807 [MissionManager](INFO): DefineArg OnDock.StayOnDock = 0 bool 2025-04-15T21:53:08.846Z,1744753988.846 [Reporter](INFO): platform_buoyancy_position 1005.476929 cc 2025-04-15T21:53:08.891Z,1744753988.891 [MissionManager](INFO): DefineArg OnDock.IfconfigInterval = 2.000000 h 2025-04-15T21:53:08.894Z,1744753988.894 [MissionManager](INFO): DefineArg OnDock.RunScience = 0 bool 2025-04-15T21:53:08.896Z,1744753988.896 [MissionManager](INFO): DefineArg OnDock.MissionTimeout = 8.000000 h 2025-04-15T21:53:08.908Z,1744753988.908 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:53:08.909Z,1744753988.909 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:53:08.910Z,1744753988.910 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:53:09.257Z,1744753989.257 [Reporter](INFO): platform_buoyancy_position 994.464294 cc 2025-04-15T21:53:09.264Z,1744753989.264 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-04-15T21:53:09.272Z,1744753989.272 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinAltitude = 5.000000 m 2025-04-15T21:53:09.278Z,1744753989.278 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-04-15T21:53:09.293Z,1744753989.293 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepth = 200.000000 m 2025-04-15T21:53:09.295Z,1744753989.295 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-04-15T21:53:09.296Z,1744753989.296 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-04-15T21:53:09.331Z,1744753989.331 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-04-15T21:53:09.347Z,1744753989.347 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-04-15T21:53:09.400Z,1744753989.400 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-04-15T21:53:09.401Z,1744753989.401 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-04-15T21:53:09.402Z,1744753989.402 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-04-15T21:53:09.450Z,1744753989.450 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-04-15T21:53:09.458Z,1744753989.458 [MissionManager](INFO): DefineArg OnDock:BackseatDriver.EnableBackseat = 0 bool 2025-04-15T21:53:09.460Z,1744753989.460 [OnDock:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-04-15T21:53:09.462Z,1744753989.462 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-04-15T21:53:09.462Z,1744753989.462 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-04-15T21:53:09.464Z,1744753989.464 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-04-15T21:53:09.555Z,1744753989.555 [Reporter](INFO): platform_buoyancy_position 992.584167 cc 2025-04-15T21:53:09.658Z,1744753989.658 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-04-15T21:53:09.662Z,1744753989.662 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleAll = 0 bool 2025-04-15T21:53:09.664Z,1744753989.664 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad1 = 0 bool 2025-04-15T21:53:09.666Z,1744753989.666 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad2 = 0 bool 2025-04-15T21:53:09.668Z,1744753989.668 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad3 = 0 bool 2025-04-15T21:53:09.670Z,1744753989.670 [MissionManager](INFO): DefineArg OnDock:PowerOnly.EnabledPowerOnly = 0 bool 2025-04-15T21:53:09.736Z,1744753989.736 [OnDock:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-04-15T21:53:09.740Z,1744753989.740 [OnDock:dataRead:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:53:09.742Z,1744753989.742 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl 2025-04-15T21:53:09.742Z,1744753989.742 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl 2025-04-15T21:53:09.746Z,1744753989.746 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl 2025-04-15T21:53:09.979Z,1744753989.979 [Reporter](INFO): platform_buoyancy_position 989.763794 cc 2025-04-15T21:53:14.397Z,1744753994.397 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into: NaN 3 100 80 20 5 NaN NaN 2.0 NaN NaN 5 NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN _.planktivore_LM_AvgRois _.planktivore_HM_AvgRois _.planktivore_diatoms _.planktivore_dinoflagellates Triggered. PeakChl values on consecutive yo-yo profiles fall in [ ] (NaN bound is ignored). 2025-04-15T21:53:14.443Z,1744753994.443 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectChlActive = 0 bool 2025-04-15T21:53:14.474Z,1744753994.474 [MissionManager](INFO): DefineArg OnDock:science:Science.TimeWindowPeakReport = nan min 2025-04-15T21:53:14.479Z,1744753994.479 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestChlPeakReportActive = 0 bool 2025-04-15T21:53:14.485Z,1744753994.485 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestSaltPeakReportActive = 0 bool 2025-04-15T21:53:14.487Z,1744753994.487 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestOilPeakReportActive = 0 bool 2025-04-15T21:53:14.494Z,1744753994.494 [MissionManager](INFO): DefineArg OnDock:science:Science.PatchTracking = 0 bool 2025-04-15T21:53:14.533Z,1744753994.533 [MissionManager](INFO): DefineArg OnDock:science:Science.FilterWidthHorizontal = 3.000000 count 2025-04-15T21:53:14.535Z,1744753994.535 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesSlidingwindow = 100.000000 count 2025-04-15T21:53:14.550Z,1744753994.550 [MissionManager](INFO): DefineArg OnDock:science:Science.OffPeakFractionHorizontal = 80.000000 % 2025-04-15T21:53:14.552Z,1744753994.552 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectNO3Active = 0 bool 2025-04-15T21:53:14.570Z,1744753994.570 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectOilActive = 0 bool 2025-04-15T21:53:14.572Z,1744753994.572 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectFDOMActive = 0 bool 2025-04-15T21:53:14.590Z,1744753994.590 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectSalinityActive = 0 bool 2025-04-15T21:53:14.592Z,1744753994.592 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool 2025-04-15T21:53:14.602Z,1744753994.602 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool 2025-04-15T21:53:14.604Z,1744753994.604 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool 2025-04-15T21:53:14.650Z,1744753994.650 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool 2025-04-15T21:53:14.652Z,1744753994.652 [MissionManager](INFO): DefineArg OnDock:science:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2025-04-15T21:53:14.671Z,1744753994.671 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledAanderaaO2 = 0 bool 2025-04-15T21:53:14.690Z,1744753994.690 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledNeilBrown = 0 bool 2025-04-15T21:53:14.711Z,1744753994.711 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledSeabird = 1 bool 2025-04-15T21:53:14.727Z,1744753994.727 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsBB2FL = 1 bool 2025-04-15T21:53:14.747Z,1744753994.747 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2025-04-15T21:53:14.778Z,1744753994.778 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsUBAT = 1 bool 2025-04-15T21:53:14.780Z,1744753994.780 [MissionManager](INFO): DefineArg OnDock:science:Science.LowPassWindowLength = 20.000000 count 2025-04-15T21:53:14.799Z,1744753994.799 [MissionManager](INFO): DefineArg OnDock:science:Science.MedianFilterLen = 5.000000 count 2025-04-15T21:53:14.813Z,1744753994.813 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakShallowBound = nan m 2025-04-15T21:53:14.815Z,1744753994.815 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDeepBound = nan m 2025-04-15T21:53:14.829Z,1744753994.829 [MissionManager](INFO): DefineArg OnDock:science:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2025-04-15T21:53:14.831Z,1744753994.831 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlThreshTriggerActive = 0 bool 2025-04-15T21:53:14.850Z,1744753994.850 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlLowerThresh = nan ug/l 2025-04-15T21:53:14.852Z,1744753994.852 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlUpperThresh = nan ug/l 2025-04-15T21:53:14.862Z,1744753994.862 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesThresh = 5.000000 count 2025-04-15T21:53:14.877Z,1744753994.877 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChl = nan ug/l 2025-04-15T21:53:14.879Z,1744753994.879 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlDepth = nan m 2025-04-15T21:53:14.889Z,1744753994.889 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlTemperature = nan degC 2025-04-15T21:53:14.892Z,1744753994.892 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLatitude = nan arcdeg 2025-04-15T21:53:14.914Z,1744753994.914 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLongitude = nan arcdeg 2025-04-15T21:53:14.929Z,1744753994.929 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3 = nan umol/l 2025-04-15T21:53:14.931Z,1744753994.931 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Depth = nan m 2025-04-15T21:53:14.949Z,1744753994.949 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Latitude = nan arcdeg 2025-04-15T21:53:14.952Z,1744753994.952 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Longitude = nan arcdeg 2025-04-15T21:53:14.970Z,1744753994.970 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOil = nan kg/m3 2025-04-15T21:53:14.985Z,1744753994.985 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilDepth = nan m 2025-04-15T21:53:14.987Z,1744753994.987 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLatitude = nan arcdeg 2025-04-15T21:53:15.002Z,1744753995.002 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLongitude = nan arcdeg 2025-04-15T21:53:15.040Z,1744753995.040 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOM = nan ppb 2025-04-15T21:53:15.043Z,1744753995.043 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMDepth = nan m 2025-04-15T21:53:15.058Z,1744753995.058 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMTemperature = nan degC 2025-04-15T21:53:15.060Z,1744753995.060 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLatitude = nan arcdeg 2025-04-15T21:53:15.082Z,1744753995.082 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLongitude = nan arcdeg 2025-04-15T21:53:15.102Z,1744753995.102 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSalt = nan psu 2025-04-15T21:53:15.139Z,1744753995.139 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltDepth = nan m 2025-04-15T21:53:15.182Z,1744753995.182 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltTemperature = nan degC 2025-04-15T21:53:15.205Z,1744753995.205 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLatitude = nan arcdeg 2025-04-15T21:53:15.207Z,1744753995.207 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLongitude = nan arcdeg 2025-04-15T21:53:15.222Z,1744753995.222 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROI = nan count/s 2025-04-15T21:53:15.224Z,1744753995.224 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROIDepth = nan m 2025-04-15T21:53:15.238Z,1744753995.238 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROITemperature = nan degC 2025-04-15T21:53:15.251Z,1744753995.251 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg 2025-04-15T21:53:15.258Z,1744753995.258 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg 2025-04-15T21:53:15.260Z,1744753995.260 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROI = nan count/s 2025-04-15T21:53:15.298Z,1744753995.298 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROIDepth = nan m 2025-04-15T21:53:15.313Z,1744753995.313 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROITemperature = nan degC 2025-04-15T21:53:15.315Z,1744753995.315 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg 2025-04-15T21:53:15.337Z,1744753995.337 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg 2025-04-15T21:53:15.339Z,1744753995.339 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatoms = nan count/ml 2025-04-15T21:53:15.359Z,1744753995.359 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsDepth = nan m 2025-04-15T21:53:15.374Z,1744753995.374 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsTemperature = nan degC 2025-04-15T21:53:15.376Z,1744753995.376 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg 2025-04-15T21:53:15.391Z,1744753995.391 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg 2025-04-15T21:53:15.406Z,1744753995.406 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellates = nan count/ml 2025-04-15T21:53:15.408Z,1744753995.408 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesDepth = nan m 2025-04-15T21:53:15.438Z,1744753995.438 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC 2025-04-15T21:53:15.453Z,1744753995.453 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg 2025-04-15T21:53:15.455Z,1744753995.455 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg 2025-04-15T21:53:15.474Z,1744753995.474 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChl = nan ug/l 2025-04-15T21:53:15.476Z,1744753995.476 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDepth = nan m 2025-04-15T21:53:15.505Z,1744753995.505 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLatitude = nan arcdeg 2025-04-15T21:53:15.507Z,1744753995.507 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLongitude = nan arcdeg 2025-04-15T21:53:15.521Z,1744753995.521 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDistance = nan m 2025-04-15T21:53:15.524Z,1744753995.524 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSalt = nan psu 2025-04-15T21:53:15.538Z,1744753995.538 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDepth = nan m 2025-04-15T21:53:15.553Z,1744753995.553 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLatitude = nan arcdeg 2025-04-15T21:53:15.555Z,1744753995.555 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLongitude = nan arcdeg 2025-04-15T21:53:15.573Z,1744753995.573 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDistance = nan m 2025-04-15T21:53:15.576Z,1744753995.576 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOil = nan psu 2025-04-15T21:53:15.590Z,1744753995.590 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDepth = nan m 2025-04-15T21:53:15.607Z,1744753995.607 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLatitude = nan arcdeg 2025-04-15T21:53:15.639Z,1744753995.639 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLongitude = nan arcdeg 2025-04-15T21:53:15.666Z,1744753995.666 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDistance = nan m 2025-04-15T21:53:15.685Z,1744753995.685 [MissionManager](INFO): DefineOutput OnDock:science:Science.TriggeredOnChl = 0 bool 2025-04-15T21:53:15.687Z,1744753995.687 [MissionManager](INFO): DefineOutput OnDock:science:Science.ChlTriggering = nan ug/l 2025-04-15T21:53:15.773Z,1744753995.773 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:15.868Z,1744753995.868 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:53:15.953Z,1744753995.953 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.013Z,1744753996.013 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.043Z,1744753996.043 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:53:16.119Z,1744753996.119 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.271Z,1744753996.271 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.355Z,1744753996.355 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:53:16.420Z,1744753996.420 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.472Z,1744753996.472 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.558Z,1744753996.558 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.607Z,1744753996.607 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:53:16.684Z,1744753996.684 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect. 2025-04-15T21:53:16.772Z,1744753996.772 [OnDock:L.Execute](DEBUG): Construct Execute. 2025-04-15T21:53:16.782Z,1744753996.782 [OnDock:PeriodicCheck:CheckIP:A.Execute](DEBUG): Construct Execute. 2025-04-15T21:53:16.784Z,1744753996.784 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:53:16.794Z,1744753996.794 [OnDock:N.Docked](DEBUG): Construct. 2025-04-15T21:53:16.794Z,1744753996.794 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values. 2025-04-15T21:53:16.831Z,1744753996.831 [OnDock:Detach:B.Undock](DEBUG): Construct. 2025-04-15T21:53:16.831Z,1744753996.831 [OnDock:Detach:B.Undock](DEBUG): Initializing internal variables to default values. 2025-04-15T21:53:16.935Z,1744753996.935 [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 = 2 hour """ How long to wait between ifconfig runs """ RunScience = false """ If true, run Science while on the dock. """ # 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 aggregate dataRead { run while ( true ) readDatum { Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } } aggregate science { run in parallel break if ( not RunScience ) insert Insert/Science.tl } behavior Estimation:TrackAcousticContact { run in parallel set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } syslog important "Restarting logs" behavior Guidance:Execute { run in sequence set command = "restart logs" } 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 } } } 2025-04-15T21:53:16.936Z,1744753996.936 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/OnDock.tl id=OnDock 2025-04-15T21:53:18.966Z,1744753998.966 [Reporter](INFO): platform_buoyancy_position 988.286438 cc 2025-04-15T21:53:19.278Z,1744753999.278 [Reporter](INFO): platform_buoyancy_position 990.166809 cc 2025-04-15T21:53:22.286Z,1744754002.286 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:53:34.226Z,1744754014.226 [DataOverHttps](IMPORTANT): SBD MTMSN=20250415T215333 2025-04-15T21:53:36.157Z,1744754016.157 [CommandExec](IMPORTANT): got command set OnDock.DockedTime .5 hour 2025-04-15T21:53:36.158Z,1744754016.158 [CommandExec](IMPORTANT): got command set OnDock.DetachedTimeout 1 hour 2025-04-15T21:53:36.159Z,1744754016.159 [CommandExec](IMPORTANT): got command set OnDock.RangeTimeout 1 hour 2025-04-15T21:53:36.159Z,1744754016.159 [CommandExec](IMPORTANT): got command set OnDock.MinAltitude 0.1 meter 2025-04-15T21:53:36.160Z,1744754016.160 [CommandExec](IMPORTANT): got command set OnDock.MinOffshore 0.0001 kilometer 2025-04-15T21:53:36.161Z,1744754016.161 [CommandExec](IMPORTANT): got command set OnDock.IfconfigInterval 2 minute 2025-04-15T21:53:36.161Z,1744754016.161 [CommandExec](IMPORTANT): got command run 2025-04-15T21:53:36.163Z,1744754016.163 [CommandExec](IMPORTANT): Running 2025-04-15T21:53:36.488Z,1744754016.488 [DefaultTankUndock] Stopped 2025-04-15T21:53:36.488Z,1744754016.488 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock 2025-04-15T21:53:36.505Z,1744754016.505 [DefaultTankUndock:B.GoToSurface] Stopped 2025-04-15T21:53:36.505Z,1744754016.505 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-15T21:53:36.505Z,1744754016.505 [DefaultTankUndock:CheckIn] Stopped 2025-04-15T21:53:36.506Z,1744754016.506 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn 2025-04-15T21:53:36.506Z,1744754016.506 [DefaultTankUndock:CheckIn:C.Wait] Stopped 2025-04-15T21:53:36.506Z,1744754016.506 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:53:36.506Z,1744754016.506 [MissionManager](IMPORTANT): Started mission OnDock 2025-04-15T21:53:36.507Z,1744754016.507 [OnDock] Running Loop=1 2025-04-15T21:53:36.507Z,1744754016.507 [OnDock](DEBUG): Aggregate::initialize OnDock 2025-04-15T21:53:36.508Z,1744754016.508 [OnDock:StandardEnvelopes] Running Loop=1 2025-04-15T21:53:36.508Z,1744754016.508 [OnDock:StandardEnvelopes](DEBUG): Aggregate::initialize OnDock:StandardEnvelopes 2025-04-15T21:53:36.516Z,1744754016.516 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:53:36.516Z,1744754016.516 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:BackseatDriver] Running Loop=1 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:BackseatDriver](DEBUG): Aggregate::initialize OnDock:BackseatDriver 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:PowerOnly] Running Loop=1 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:PowerOnly](DEBUG): Aggregate::initialize OnDock:PowerOnly 2025-04-15T21:53:36.517Z,1744754016.517 [OnDock:PowerOnly:A] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:PowerOnly:B] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:PowerOnly:C] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:PowerOnly:D] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:PowerOnly:E.Wait] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:dataRead] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:dataRead:A] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:science] Running Loop=1 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:science](DEBUG): Aggregate::initialize OnDock:science 2025-04-15T21:53:36.518Z,1744754016.518 [OnDock:science:Science] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science](DEBUG): Aggregate::initialize OnDock:science:Science 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:A] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:B] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:C] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:D] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:E] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:F] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:Read_Oil] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:PeakDetectChl] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectChl 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.519Z,1744754016.519 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.521Z,1744754016.521 [OnDock:science:Science:HighestChlPeakReport] Running Loop=1 2025-04-15T21:53:36.521Z,1744754016.521 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestChlPeakReport 2025-04-15T21:53:36.521Z,1744754016.521 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:53:36.521Z,1744754016.521 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:53:36.522Z,1744754016.522 [OnDock:science:Science:PeakDetectNO3] Running Loop=1 2025-04-15T21:53:36.522Z,1744754016.522 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectNO3 2025-04-15T21:53:36.522Z,1744754016.522 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.522Z,1744754016.522 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.523Z,1744754016.523 [OnDock:science:Science:PeakDetectOil] Running Loop=1 2025-04-15T21:53:36.523Z,1744754016.523 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectOil 2025-04-15T21:53:36.524Z,1744754016.524 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.524Z,1744754016.524 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.533Z,1744754016.533 [OnDock:science:Science:HighestOilPeakReport] Running Loop=1 2025-04-15T21:53:36.533Z,1744754016.533 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestOilPeakReport 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:PeakDetectFDOM] Running Loop=1 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectFDOM 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.534Z,1744754016.534 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.535Z,1744754016.535 [OnDock:science:Science:PeakDetectSalinity] Running Loop=1 2025-04-15T21:53:36.535Z,1744754016.535 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectSalinity 2025-04-15T21:53:36.536Z,1744754016.536 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.536Z,1744754016.536 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.537Z,1744754016.537 [OnDock:science:Science:HighestSaltPeakReport] Running Loop=1 2025-04-15T21:53:36.537Z,1744754016.537 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestSaltPeakReport 2025-04-15T21:53:36.537Z,1744754016.537 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:53:36.538Z,1744754016.538 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:53:36.538Z,1744754016.538 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1 2025-04-15T21:53:36.538Z,1744754016.538 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:53:36.538Z,1744754016.538 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.538Z,1744754016.538 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.539Z,1744754016.539 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_LM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:53:36.539Z,1744754016.539 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1 2025-04-15T21:53:36.539Z,1744754016.539 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:53:36.540Z,1744754016.540 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.540Z,1744754016.540 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.540Z,1744754016.540 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_HM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:53:36.549Z,1744754016.549 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1 2025-04-15T21:53:36.549Z,1744754016.549 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:53:36.549Z,1744754016.549 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.549Z,1744754016.549 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.550Z,1744754016.550 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_diatoms , but backseat URI detected. Waiting for presence. 2025-04-15T21:53:36.551Z,1744754016.551 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1 2025-04-15T21:53:36.551Z,1744754016.551 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:53:36.551Z,1744754016.551 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:53:36.551Z,1744754016.551 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:53:36.552Z,1744754016.552 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_dinoflagellates , but backseat URI detected. Waiting for presence. 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:ChlThreshTrigger] Running Loop=1 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize OnDock:science:Science:ChlThreshTrigger 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize. 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:OceanCurrent] Running Loop=1 2025-04-15T21:53:36.557Z,1744754016.557 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::initialize OnDock:science:Science:OceanCurrent 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:science:Science:OceanCurrent:A.] Running Loop=1 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:science:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:J.] Running Loop=1 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:J.](INFO): Initializing TrackAcousticContact. 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:PeriodicCheck] Running Loop=1 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2025-04-15T21:53:36.558Z,1744754016.558 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:B] Running Loop=1 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:PeriodicCheck] Running Loop=1 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2025-04-15T21:53:36.559Z,1744754016.559 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:53:36.560Z,1744754016.560 [OnDock:J.] Running Loop=1 2025-04-15T21:53:36.560Z,1744754016.560 [OnDock:science] Stopped 2025-04-15T21:53:36.560Z,1744754016.560 [OnDock:science](DEBUG): Aggregate::uninitialize OnDock:science 2025-04-15T21:53:36.560Z,1744754016.560 [OnDock:science:Science] Stopped 2025-04-15T21:53:36.572Z,1744754016.572 [OnDock:science:Science](DEBUG): Aggregate::uninitialize OnDock:science:Science 2025-04-15T21:53:36.572Z,1744754016.572 [OnDock:science:Science:A] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:B] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:C] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:D] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:E] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:F] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:Read_Oil] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:OceanCurrent] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::uninitialize OnDock:science:Science:OceanCurrent 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:OceanCurrent:A.] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:PeakDetectChl] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectChl 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:HighestChlPeakReport] Stopped 2025-04-15T21:53:36.573Z,1744754016.573 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestChlPeakReport 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectNO3] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectNO3 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectOil] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectOil 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestOilPeakReport] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestOilPeakReport 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:53:36.574Z,1744754016.574 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectFDOM] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectFDOM 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectSalinity] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectSalinity 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:HighestSaltPeakReport] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestSaltPeakReport 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:53:36.575Z,1744754016.575 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Stopped 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Stopped 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:53:36.576Z,1744754016.576 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.578Z,1744754016.578 [CommandExec](IMPORTANT): got command ! ifconfig 2025-04-15T21:53:36.594Z,1744754016.594 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.609Z,1744754016.609 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Stopped 2025-04-15T21:53:36.609Z,1744754016.609 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:53:36.609Z,1744754016.609 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.610Z,1744754016.610 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.610Z,1744754016.610 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Stopped 2025-04-15T21:53:36.610Z,1744754016.610 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:53:36.610Z,1744754016.610 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Stopped 2025-04-15T21:53:36.610Z,1744754016.610 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:53:36.611Z,1744754016.611 [OnDock:science:Science:ChlThreshTrigger] Stopped 2025-04-15T21:53:36.611Z,1744754016.611 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize OnDock:science:Science:ChlThreshTrigger 2025-04-15T21:53:36.611Z,1744754016.611 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Stopped 2025-04-15T21:53:36.611Z,1744754016.611 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize. 2025-04-15T21:53:36.612Z,1744754016.612 [OnDock:dataRead] Running Loop=1 2025-04-15T21:53:36.615Z,1744754016.615 [OnDock:dataRead:A](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-15T21:53:36.615Z,1744754016.615 [OnDock:PowerOnly] Running Loop=1 2025-04-15T21:53:36.621Z,1744754016.621 [OnDock:PowerOnly:D] Stopped 2025-04-15T21:53:36.621Z,1744754016.621 [OnDock:PowerOnly:C] Stopped 2025-04-15T21:53:36.621Z,1744754016.621 [OnDock:PowerOnly:B] Stopped 2025-04-15T21:53:36.621Z,1744754016.621 [OnDock:PowerOnly:A] Stopped 2025-04-15T21:53:36.621Z,1744754016.621 [OnDock:BackseatDriver] Running Loop=1 2025-04-15T21:53:36.622Z,1744754016.622 [OnDock:B] Stopped 2025-04-15T21:53:36.622Z,1744754016.622 [OnDock:C] Running Loop=1 2025-04-15T21:53:36.623Z,1744754016.623 [OnDock:StandardEnvelopes] Running Loop=1 2025-04-15T21:53:36.623Z,1744754016.623 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:53:36.623Z,1744754016.623 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2025-04-15T21:53:36.647Z,1744754016.647 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:53:36.648Z,1744754016.648 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:53:36.775Z,1744754016.775 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:10.89.10.2 Bcast:10.89.255.255 Mask:255.255.0.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:1074044 errors:0 dropped:0 overruns:0 frame:0 TX packets:1333002 errors:0 dropped:0 overruns:0 carrier:0 collisions:20930 txqueuelen:1000 RX bytes:390379789 (372.2 Mb) TX bytes:762804724 (727.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:402 errors:0 dropped:0 overruns:0 frame:0 TX packets:402 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:38896 (37.9 Kb) TX bytes:38896 (37.9 Kb) 2025-04-15T21:53:37.528Z,1744754017.528 [OnDock:C] Stopped 2025-04-15T21:53:37.529Z,1744754017.529 [OnDock:D] Running Loop=1 2025-04-15T21:53:37.878Z,1744754017.878 [OnDock:D] Stopped 2025-04-15T21:53:37.879Z,1744754017.879 [OnDock:E] Running Loop=1 2025-04-15T21:53:38.122Z,1744754018.122 [OnDock:E] Stopped 2025-04-15T21:53:38.122Z,1744754018.122 [OnDock:K] Running Loop=1 2025-04-15T21:53:38.647Z,1744754018.647 [OnDock:K](IMPORTANT): Restarting logs 2025-04-15T21:53:38.647Z,1744754018.647 [OnDock:K] Stopped 2025-04-15T21:53:38.647Z,1744754018.647 [OnDock:L.Execute] Running Loop=1