search

GobySoft / goby3

The Goby Underwater Autonomy Project Version 3
Other
24 stars 11 forks source link

Can't transmit data with Micromodem 2.0.27087 - doesn't wait for CCCFQ,TOP to finish #126

Closed russkel closed 4 years ago

russkel commented 4 years ago

Currently I have a application that connects to a deckbox via USB, configures the driver, configures the modem and then transmits some data. This works fine with a MM 1 but when I use a MM 2 it doesn't work any more. The number of CFG variables returned is much larger than MM1 and it tries to initiate data transfer before the CFG spam is complete. Perhaps it can wait until its finished before it pops the CFQ command from the queue? Also can query_all_cfg be made a configurable option?

Also, I receive a CAREV midway through the CFG barrage.

tsaubergine commented 4 years ago

Hi -

I haven't had any problem using 2.0.27087.

I'm fine making query_all_cfg optional. Also fine waiting to pop CFQ, though I'm not sure how to cleanly detect the end of the $CCCFQ messaging.

russkel commented 4 years ago

Hi Toby,

It might be because of the co-processor board that is also plugged in. I'll post a log later today.

Okay I will make a patch that makes it optional. I also have no good idea to detect the end of CFQ unless there's a timeout after last CFG msg to signify the end?

russkel commented 4 years ago 
sendMessage [2019-Dec-02 03:02:29.336071]: Adding FlexOstream group: goby::acomms::modemdriver::out::1 ()
sendMessage [2019-Dec-02 03:02:29.336161]: Adding FlexOstream group: goby::acomms::modemdriver::in::1 ()
sendMessage [2019-Dec-02 03:02:29.336436] {goby::acomms::modemdriver::out::1}: D: Goby Micro-Modem driver starting up.
sendMessage [2019-Dec-02 03:02:29.336508] {goby::acomms::modemdriver::out::1}: D: opening serial port /dev/deckbox @ 19200
sendMessage [2019-Dec-02 03:02:29.436819] {goby::acomms::modemdriver::out::1}: D: Setting RTS to low
sendMessage [2019-Dec-02 03:02:29.437380] {goby::acomms::modemdriver::out::1}: D: $CCCFG,CST,1*37
sendMessage [2019-Dec-02 03:02:29.437584] {goby::acomms::modemdriver::out::1}: ^ Set NVRAM configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:29.538168] {goby::acomms::modemdriver::in::1}: D: $CACFG,CST,1*35
sendMessage [2019-Dec-02 03:02:29.538420] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Cycle statistics message 1
sendMessage [2019-Dec-02 03:02:29.638820] {goby::acomms::modemdriver::out::1}: D: $CCCFG,SRC,0*30
sendMessage [2019-Dec-02 03:02:29.639047] {goby::acomms::modemdriver::out::1}: ^ Set NVRAM configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:29.739550] {goby::acomms::modemdriver::in::1}: D: $CACFG,SRC,0*32
sendMessage [2019-Dec-02 03:02:29.739770] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Default Source Address
sendMessage [2019-Dec-02 03:02:29.840135] {goby::acomms::modemdriver::out::1}: D: $CCCFG,REV,1*32
sendMessage [2019-Dec-02 03:02:29.840379] {goby::acomms::modemdriver::out::1}: ^ Set NVRAM configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:29.940927] {goby::acomms::modemdriver::in::1}: D: $CACFG,REV,1*30
sendMessage [2019-Dec-02 03:02:29.941182] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CAREV message
sendMessage [2019-Dec-02 03:02:30.041653] {goby::acomms::modemdriver::out::1}: D: $CCCFG,RXP,1*29
sendMessage [2019-Dec-02 03:02:30.041914] {goby::acomms::modemdriver::out::1}: ^ Set NVRAM configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:30.142511] {goby::acomms::modemdriver::in::1}: D: $CACFG,RXP,1*2B
sendMessage [2019-Dec-02 03:02:30.142766] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CARXP message
sendMessage [2019-Dec-02 03:02:30.243204] {goby::acomms::modemdriver::out::1}: D: $CCMSC,0,0,0*41
sendMessage [2019-Dec-02 03:02:30.243433] {goby::acomms::modemdriver::out::1}: ^ Sleep command, host to modem
sendMessage [2019-Dec-02 03:02:30.343871] {goby::acomms::modemdriver::in::1}: D: $CAMSC,0,0,0*43
sendMessage [2019-Dec-02 03:02:30.344065] {goby::acomms::modemdriver::in::1}: ^ Echo of Sleep command, modem to host
sendMessage [2019-Dec-02 03:02:30.444477] {goby::acomms::modemdriver::out::1}: D: $CCCFQ,SRC*3A
sendMessage [2019-Dec-02 03:02:30.444740] {goby::acomms::modemdriver::out::1}: ^ Query configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:31.746266] {goby::acomms::modemdriver::in::1}: D: $CAREV,030231,INIT,2.0.27087*4E
sendMessage [2019-Dec-02 03:02:31.746375] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:31.746459] {goby::acomms::modemdriver::in::1}: D: Micro-Modem rebooted.
sendMessage [2019-Dec-02 03:02:33.746802] {goby::acomms::modemdriver::in::1}: D: $CAREV,030231,SLOT1,2.0.27087*61
sendMessage [2019-Dec-02 03:02:33.747136] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:33.747460] {goby::acomms::modemdriver::in::1}: D: $CAREV,030231,AUV,2.0.27087*16
sendMessage [2019-Dec-02 03:02:33.747632] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:33.747827] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:02:33.748060] {goby::acomms::modemdriver::in::1}: D: $CAREV,030231,COPROC,0.30.0.56*40
sendMessage [2019-Dec-02 03:02:33.748277] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:33.748471] {goby::acomms::modemdriver::in::1}: D: $CATMG,2019-12-02T03:02:31Z,RTC,RTC*76
sendMessage [2019-Dec-02 03:02:33.748598] {goby::acomms::modemdriver::in::1}: ^ Informational message about timing source, printed when timing sources change (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:35.450750] {goby::acomms::modemdriver::out::1}: D: resending last command; no serial ack in 5 second(s). 
sendMessage [2019-Dec-02 03:02:35.451025] {goby::acomms::modemdriver::out::1}: D: $CCCFQ,SRC*3A
sendMessage [2019-Dec-02 03:02:35.451190] {goby::acomms::modemdriver::out::1}: ^ Query configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:35.551671] {goby::acomms::modemdriver::in::1}: D: $CACFG,SRC,0*32
sendMessage [2019-Dec-02 03:02:35.551890] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Default Source Address
sendMessage [2019-Dec-02 03:02:35.652233] {goby::acomms::modemdriver::out::1}: D: Setting the Micro-Modem clock.
sendMessage [2019-Dec-02 03:02:36.050363] {goby::acomms::modemdriver::out::1}: D: $CCTMS,2019-12-02T03:02:37Z,0*7A
sendMessage [2019-Dec-02 03:02:36.050557] {goby::acomms::modemdriver::out::1}: ^ Set the modem clock (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:36.751635] {goby::acomms::modemdriver::in::1}: D: $CATMS,0,2019-12-02T03:02:37Z*78
sendMessage [2019-Dec-02 03:02:36.751943] {goby::acomms::modemdriver::in::1}: ^ Response to set clock command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:36.753222] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.247809
sendMessage [2019-Dec-02 03:02:36.753501] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:02:36.753909] {goby::acomms::modemdriver::in::1}: D: $CATMG,2019-12-02T03:02:37Z,USER_CMD,RTC*31
sendMessage [2019-Dec-02 03:02:36.754171] {goby::acomms::modemdriver::in::1}: ^ Informational message about timing source, printed when timing sources change (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:36.854662] {goby::acomms::modemdriver::out::1}: D: $CCCFQ,TOP*33
sendMessage [2019-Dec-02 03:02:36.854884] {goby::acomms::modemdriver::out::1}: ^ Query configuration parameter, host to modem
sendMessage [2019-Dec-02 03:02:36.856005] {goby::acomms::modemdriver::out::1}: D: Beginning to initiate transmission.
sendMessage [2019-Dec-02 03:02:36.856210] {goby::acomms::modemdriver::out::1}: D:  this is a DATA transmission
sendMessage [2019-Dec-02 03:02:36.872829] {goby::acomms::modemdriver::in::1}: D: $CACFG,AGC,1*34
sendMessage [2019-Dec-02 03:02:36.873051] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Turn on automatic gain control
sendMessage [2019-Dec-02 03:02:36.874368] {goby::acomms::modemdriver::out::1}: D: $CCCYC,0,0,8,0,0,1*50
sendMessage [2019-Dec-02 03:02:36.874567] {goby::acomms::modemdriver::out::1}: ^ Network Cycle Initialization Command
sendMessage [2019-Dec-02 03:02:36.882387] {goby::acomms::modemdriver::in::1}: D: $CACFG,AGN,250*3F
sendMessage [2019-Dec-02 03:02:36.882557] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Analog Gain (50 is 6 dB, 250 is 30 dB)
sendMessage [2019-Dec-02 03:02:36.893562] {goby::acomms::modemdriver::in::1}: D: $CACFG,AGX,1*2F
sendMessage [2019-Dec-02 03:02:36.893737] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:36.902586] {goby::acomms::modemdriver::in::1}: D: $CACFG,ASD,1*27
sendMessage [2019-Dec-02 03:02:36.902755] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Always Send Data. Tells the modem to send test data when the user does not provide any.
sendMessage [2019-Dec-02 03:02:36.911592] {goby::acomms::modemdriver::in::1}: D: $CACFG,BBD,0*34
sendMessage [2019-Dec-02 03:02:36.911759] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  PSK Baseband data dump to serial port
sendMessage [2019-Dec-02 03:02:36.920571] {goby::acomms::modemdriver::in::1}: D: $CACFG,BND,3*3B
sendMessage [2019-Dec-02 03:02:36.920742] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Frequency Bank (1, 2, 3 for band A, B, or C, 0 for user-defined PSK only band)
sendMessage [2019-Dec-02 03:02:36.929612] {goby::acomms::modemdriver::in::1}: D: $CACFG,BR1,3*52
sendMessage [2019-Dec-02 03:02:36.929797] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Baud rate for serial port 1 (3 = 19200)
sendMessage [2019-Dec-02 03:02:36.938659] {goby::acomms::modemdriver::in::1}: D: $CACFG,BR2,3*51
sendMessage [2019-Dec-02 03:02:36.938830] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Baud rate for serial port 2 (3 = 19200)
sendMessage [2019-Dec-02 03:02:36.947712] {goby::acomms::modemdriver::in::1}: D: $CACFG,BR3,3*50
sendMessage [2019-Dec-02 03:02:36.947913] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:36.956761] {goby::acomms::modemdriver::in::1}: D: $CACFG,BR4,3*57
sendMessage [2019-Dec-02 03:02:36.956933] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:36.965762] {goby::acomms::modemdriver::in::1}: D: $CACFG,BRN,0*2E
sendMessage [2019-Dec-02 03:02:36.965934] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Run bootloader at next revert
sendMessage [2019-Dec-02 03:02:36.974825] {goby::acomms::modemdriver::in::1}: D: $CACFG,BSP,1*30
sendMessage [2019-Dec-02 03:02:36.975009] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Boot loader serial port
sendMessage [2019-Dec-02 03:02:36.984976] {goby::acomms::modemdriver::in::1}: D: $CACFG,BW0,5000*60
sendMessage [2019-Dec-02 03:02:36.985150] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Bandwidth for Band 0 PSK CPR 0-1 Coprocessor power toggle switch 1
sendMessage [2019-Dec-02 03:02:36.995072] {goby::acomms::modemdriver::in::1}: D: $CACFG,CPR,1*30
sendMessage [2019-Dec-02 03:02:36.995240] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.005189] {goby::acomms::modemdriver::in::1}: D: $CACFG,CRL,50*18
sendMessage [2019-Dec-02 03:02:37.005395] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Cycle init reverb lockout (ms) 50
sendMessage [2019-Dec-02 03:02:37.014378] {goby::acomms::modemdriver::in::1}: D: $CACFG,CST,1*35
sendMessage [2019-Dec-02 03:02:37.014594] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Cycle statistics message 1
sendMessage [2019-Dec-02 03:02:37.023474] {goby::acomms::modemdriver::in::1}: D: $CACFG,CTO,10*19
sendMessage [2019-Dec-02 03:02:37.023673] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Cycle init timeout (sec) 10
sendMessage [2019-Dec-02 03:02:37.032579] {goby::acomms::modemdriver::in::1}: D: $CACFG,DBG,0*31
sendMessage [2019-Dec-02 03:02:37.032830] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Enable low-level debug messages 0
sendMessage [2019-Dec-02 03:02:37.040612] {goby::acomms::modemdriver::in::1}: D: $CACFG,DGM,0*3E
sendMessage [2019-Dec-02 03:02:37.040785] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Diagnostic messaging 0
sendMessage [2019-Dec-02 03:02:37.049657] {goby::acomms::modemdriver::in::1}: D: $CACFG,DOP,0*2B
sendMessage [2019-Dec-02 03:02:37.049843] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CADOP message
sendMessage [2019-Dec-02 03:02:37.058739] {goby::acomms::modemdriver::in::1}: D: $CACFG,DQF,1*22
sendMessage [2019-Dec-02 03:02:37.058925] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CADQF message
sendMessage [2019-Dec-02 03:02:37.067782] {goby::acomms::modemdriver::in::1}: D: $CACFG,DTH,90*11
sendMessage [2019-Dec-02 03:02:37.068041] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Matched filter signal threshold, FSK
sendMessage [2019-Dec-02 03:02:37.077135] {goby::acomms::modemdriver::in::1}: D: $CACFG,DTO,2*2D
sendMessage [2019-Dec-02 03:02:37.077349] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Data request timeout (sec)
sendMessage [2019-Dec-02 03:02:37.086250] {goby::acomms::modemdriver::in::1}: D: $CACFG,DTP,90*09
sendMessage [2019-Dec-02 03:02:37.086432] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Matched filter signal threshold, PSK
sendMessage [2019-Dec-02 03:02:37.098506] {goby::acomms::modemdriver::in::1}: D: $CACFG,ECD,50*07
sendMessage [2019-Dec-02 03:02:37.098679] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Int Delay at end of cycle (ms)
sendMessage [2019-Dec-02 03:02:37.107527] {goby::acomms::modemdriver::in::1}: D: $CACFG,EFB,10*00
sendMessage [2019-Dec-02 03:02:37.107711] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Feedback taps for the LMS equalizer
sendMessage [2019-Dec-02 03:02:37.116580] {goby::acomms::modemdriver::in::1}: D: $CACFG,EFF,20*07
sendMessage [2019-Dec-02 03:02:37.116755] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Feedforward taps for the LMS equalizer
sendMessage [2019-Dec-02 03:02:37.129880] {goby::acomms::modemdriver::in::1}: D: $CACFG,FC0,25000*42
sendMessage [2019-Dec-02 03:02:37.130052] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Carrier at Band 0 PSK only
sendMessage [2019-Dec-02 03:02:37.139954] {goby::acomms::modemdriver::in::1}: D: $CACFG,FMD,1*3E
sendMessage [2019-Dec-02 03:02:37.140137] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  PSK FM probe direction,0 up, 1 down
sendMessage [2019-Dec-02 03:02:37.148997] {goby::acomms::modemdriver::in::1}: D: $CACFG,FML,200*35
sendMessage [2019-Dec-02 03:02:37.149165] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  PSK FM probe length, symbols
sendMessage [2019-Dec-02 03:02:37.157994] {goby::acomms::modemdriver::in::1}: D: $CACFG,GPS,0*34
sendMessage [2019-Dec-02 03:02:37.158161] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  GPS parser on aux. serial port
sendMessage [2019-Dec-02 03:02:37.167007] {goby::acomms::modemdriver::in::1}: D: $CACFG,HFC,0*3D
sendMessage [2019-Dec-02 03:02:37.167190] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Hardware flow control on main serial port
sendMessage [2019-Dec-02 03:02:37.176022] {goby::acomms::modemdriver::in::1}: D: $CACFG,IRE,0*2E
sendMessage [2019-Dec-02 03:02:37.176191] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Print impulse response of FM sweep
sendMessage [2019-Dec-02 03:02:37.185049] {goby::acomms::modemdriver::in::1}: D: $CACFG,MCM,1*32
sendMessage [2019-Dec-02 03:02:37.185217] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Enable current mode hydrophone power supply on Rev. C Multi-Channel Analog Board. Must be set to 1 for Rev. B Multi-Channel Analog Board.
sendMessage [2019-Dec-02 03:02:37.194047] {goby::acomms::modemdriver::in::1}: D: $CACFG,MFD,0*3F
sendMessage [2019-Dec-02 03:02:37.194225] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the MFD messages
sendMessage [2019-Dec-02 03:02:37.203069] {goby::acomms::modemdriver::in::1}: D: $CACFG,MOD,0*36
sendMessage [2019-Dec-02 03:02:37.203236] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  0 sends FSK minipacket, 1 sends PSK minipacket
sendMessage [2019-Dec-02 03:02:37.210984] {goby::acomms::modemdriver::in::1}: D: $CACFG,MPR,0*3F
sendMessage [2019-Dec-02 03:02:37.211150] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Enable power toggling on Multi-Channel Analog Board
sendMessage [2019-Dec-02 03:02:37.219970] {goby::acomms::modemdriver::in::1}: D: $CACFG,MSE,0*2B
sendMessage [2019-Dec-02 03:02:37.220139] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Print symbol mean squared error (dB) from the LMS equalizer
sendMessage [2019-Dec-02 03:02:37.228985] {goby::acomms::modemdriver::in::1}: D: $CACFG,MVM,0*26
sendMessage [2019-Dec-02 03:02:37.229152] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Enable voltage mode hydrophone power supply on Multi-Channel Analog Board
sendMessage [2019-Dec-02 03:02:37.239049] {goby::acomms::modemdriver::in::1}: D: $CACFG,NDT,120*2D
sendMessage [2019-Dec-02 03:02:37.239234] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Detect threshold for nav detector
sendMessage [2019-Dec-02 03:02:37.249289] {goby::acomms::modemdriver::in::1}: D: $CACFG,NRL,25*17
sendMessage [2019-Dec-02 03:02:37.249472] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Navigation reverb lockout (ms)
sendMessage [2019-Dec-02 03:02:37.259734] {goby::acomms::modemdriver::in::1}: D: $CACFG,NRV,0*3A
sendMessage [2019-Dec-02 03:02:37.259983] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Number of CTOs before hard reboot
sendMessage [2019-Dec-02 03:02:37.269102] {goby::acomms::modemdriver::in::1}: D: $CACFG,PAD,0*25
sendMessage [2019-Dec-02 03:02:37.269430] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Power-amp delay (ms)
sendMessage [2019-Dec-02 03:02:37.277325] {goby::acomms::modemdriver::in::1}: D: $CACFG,PCM,0*2E
sendMessage [2019-Dec-02 03:02:37.277515] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Passband channel mask
sendMessage [2019-Dec-02 03:02:37.287460] {goby::acomms::modemdriver::in::1}: D: $CACFG,POW,-20*27
sendMessage [2019-Dec-02 03:02:37.287631] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Detection power threshold (dB) PRL Int Packet reverb lockout (ms)
sendMessage [2019-Dec-02 03:02:37.296460] {goby::acomms::modemdriver::in::1}: D: $CACFG,PRL,50*0B
sendMessage [2019-Dec-02 03:02:37.296631] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.307608] {goby::acomms::modemdriver::in::1}: D: $CACFG,PTH,50*09
sendMessage [2019-Dec-02 03:02:37.307775] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Matched filter detector power threshold
sendMessage [2019-Dec-02 03:02:37.317751] {goby::acomms::modemdriver::in::1}: D: $CACFG,PTO,14*0E
sendMessage [2019-Dec-02 03:02:37.317933] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Packet timeout (sec)
sendMessage [2019-Dec-02 03:02:37.325831] {goby::acomms::modemdriver::in::1}: D: $CACFG,REV,1*30
sendMessage [2019-Dec-02 03:02:37.326015] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CAREV message
sendMessage [2019-Dec-02 03:02:37.334929] {goby::acomms::modemdriver::in::1}: D: $CACFG,RXA,0*3B
sendMessage [2019-Dec-02 03:02:37.335121] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CARXA message
sendMessage [2019-Dec-02 03:02:37.343954] {goby::acomms::modemdriver::in::1}: D: $CACFG,RXD,1*3F
sendMessage [2019-Dec-02 03:02:37.344123] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CARXD message
sendMessage [2019-Dec-02 03:02:37.352982] {goby::acomms::modemdriver::in::1}: D: $CACFG,RXP,1*2B
sendMessage [2019-Dec-02 03:02:37.353160] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CARXP message
sendMessage [2019-Dec-02 03:02:37.361997] {goby::acomms::modemdriver::in::1}: D: $CACFG,SCG,0*27
sendMessage [2019-Dec-02 03:02:37.362169] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Set clock from GPS
sendMessage [2019-Dec-02 03:02:37.370993] {goby::acomms::modemdriver::in::1}: D: $CACFG,SGP,0*34
sendMessage [2019-Dec-02 03:02:37.371201] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Show GPS messages on main serial port
sendMessage [2019-Dec-02 03:02:37.380045] {goby::acomms::modemdriver::in::1}: D: $CACFG,SHF,0*2D
sendMessage [2019-Dec-02 03:02:37.380212] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Whether or not to send the $CASHF message
sendMessage [2019-Dec-02 03:02:37.387995] {goby::acomms::modemdriver::in::1}: D: $CACFG,SNR,0*3F
sendMessage [2019-Dec-02 03:02:37.388162] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Turn on SNR stats for PSK comms
sendMessage [2019-Dec-02 03:02:37.398085] {goby::acomms::modemdriver::in::1}: D: $CACFG,SNV,0*3B
sendMessage [2019-Dec-02 03:02:37.398252] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Synchronous transmission of packets
sendMessage [2019-Dec-02 03:02:37.406000] {goby::acomms::modemdriver::in::1}: D: $CACFG,SRC,0*32
sendMessage [2019-Dec-02 03:02:37.406165] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Default Source Address
sendMessage [2019-Dec-02 03:02:37.416070] {goby::acomms::modemdriver::in::1}: D: $CACFG,TAT,50*04
sendMessage [2019-Dec-02 03:02:37.416250] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Navigation turn-around-time (msec)
sendMessage [2019-Dec-02 03:02:37.425095] {goby::acomms::modemdriver::in::1}: D: $CACFG,TOA,0*2A
sendMessage [2019-Dec-02 03:02:37.425264] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Display time of arrival of a packet (sec)
sendMessage [2019-Dec-02 03:02:37.435174] {goby::acomms::modemdriver::in::1}: D: $CACFG,TXD,600*3E
sendMessage [2019-Dec-02 03:02:37.435340] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Delay before transmit (ms)
sendMessage [2019-Dec-02 03:02:37.445235] {goby::acomms::modemdriver::in::1}: D: $CACFG,TXP,1*2D
sendMessage [2019-Dec-02 03:02:37.445416] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Turn on start of transmit message
sendMessage [2019-Dec-02 03:02:37.454252] {goby::acomms::modemdriver::in::1}: D: $CACFG,TXF,1*3B
sendMessage [2019-Dec-02 03:02:37.454420] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Turn on end of transmit message
sendMessage [2019-Dec-02 03:02:37.463253] {goby::acomms::modemdriver::in::1}: D: $CACFG,XST,1*2E
sendMessage [2019-Dec-02 03:02:37.463425] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  Turn on transmit stats message, CAXST
sendMessage [2019-Dec-02 03:02:37.479748] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.bitrate,19200*0A
sendMessage [2019-Dec-02 03:02:37.479978] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.495244] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.bitrate,19200*09
sendMessage [2019-Dec-02 03:02:37.495431] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.513047] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.bitrate,19200*08
sendMessage [2019-Dec-02 03:02:37.513259] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.530779] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.bitrate,19200*0F
sendMessage [2019-Dec-02 03:02:37.531011] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.545254] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.task,1*71
sendMessage [2019-Dec-02 03:02:37.545438] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.557509] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.task,1*72
sendMessage [2019-Dec-02 03:02:37.557691] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.570833] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.task,1*73
sendMessage [2019-Dec-02 03:02:37.571006] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.583221] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.task,1*74
sendMessage [2019-Dec-02 03:02:37.583441] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.597790] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.parse_gps,0*33
sendMessage [2019-Dec-02 03:02:37.597993] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.614334] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.parse_gps,0*30
sendMessage [2019-Dec-02 03:02:37.614552] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.628779] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.parse_gps,0*31
sendMessage [2019-Dec-02 03:02:37.628989] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.644325] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.parse_gps,0*36
sendMessage [2019-Dec-02 03:02:37.644515] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.658762] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.show_gps,0*45
sendMessage [2019-Dec-02 03:02:37.658939] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.673069] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.show_gps,0*46
sendMessage [2019-Dec-02 03:02:37.673236] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.688475] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.show_gps,0*47
sendMessage [2019-Dec-02 03:02:37.688645] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.702780] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.show_gps,0*40
sendMessage [2019-Dec-02 03:02:37.702947] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.719651] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.set_clk_GPS,0*3F
sendMessage [2019-Dec-02 03:02:37.719969] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.735565] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.set_clk_GPS,0*3C
sendMessage [2019-Dec-02 03:02:37.735817] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.753514] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.set_clk_GPS,0*3D
sendMessage [2019-Dec-02 03:02:37.753714] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.771359] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.set_clk_GPS,0*3A
sendMessage [2019-Dec-02 03:02:37.771577] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.789035] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.flowcontrol,0*08
sendMessage [2019-Dec-02 03:02:37.789209] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.806647] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.flowcontrol,0*0B
sendMessage [2019-Dec-02 03:02:37.806830] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.825334] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.flowcontrol,0*0A
sendMessage [2019-Dec-02 03:02:37.825506] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.842921] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.flowcontrol,0*0D
sendMessage [2019-Dec-02 03:02:37.843089] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.858327] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.rs485,0*40
sendMessage [2019-Dec-02 03:02:37.858498] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.870523] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.crc32,0*0E
sendMessage [2019-Dec-02 03:02:37.870703] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.883846] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart2.crc32,0*0D
sendMessage [2019-Dec-02 03:02:37.884017] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.897149] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart3.crc32,0*0C
sendMessage [2019-Dec-02 03:02:37.897329] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.911533] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart4.crc32,0*0B
sendMessage [2019-Dec-02 03:02:37.911700] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.933406] {goby::acomms::modemdriver::in::1}: D: $CACFG,uart1.iridium_hangup_minutes,0*62
sendMessage [2019-Dec-02 03:02:37.933573] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.952087] {goby::acomms::modemdriver::in::1}: D: $CACFG,sport3.bitrate,19200*70
sendMessage [2019-Dec-02 03:02:37.952292] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.967609] {goby::acomms::modemdriver::in::1}: D: $CACFG,log.nmea.level,0*65
sendMessage [2019-Dec-02 03:02:37.967800] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:37.983098] {goby::acomms::modemdriver::in::1}: D: $CACFG,log.nmea.location,1*0F
sendMessage [2019-Dec-02 03:02:37.983267] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.001800] {goby::acomms::modemdriver::in::1}: D: $CACFG,log.nmea.lastretrieval,0*7F
sendMessage [2019-Dec-02 03:02:38.001970] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.024898] {goby::acomms::modemdriver::in::1}: D: $CACFG,log.nmea.currentdbSize,00000000*69
sendMessage [2019-Dec-02 03:02:38.025118] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.042529] {goby::acomms::modemdriver::in::1}: D: $CACFG,log.nmea.output_rate,0*51
sendMessage [2019-Dec-02 03:02:38.042711] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.054800] {goby::acomms::modemdriver::in::1}: D: $CACFG,rec.state,0*5D
sendMessage [2019-Dec-02 03:02:38.054978] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.070292] {goby::acomms::modemdriver::in::1}: D: $CACFG,rec.start_time,-1*2C
sendMessage [2019-Dec-02 03:02:38.070491] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.083775] {goby::acomms::modemdriver::in::1}: D: $CACFG,rec.end_time,-1*23
sendMessage [2019-Dec-02 03:02:38.083989] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.103602] {goby::acomms::modemdriver::in::1}: D: $CACFG,fsk.packet.modulation,0*04
sendMessage [2019-Dec-02 03:02:38.103783] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.124452] {goby::acomms::modemdriver::in::1}: D: $CACFG,fsk.packet.bandwidth_Hz,4000*30
sendMessage [2019-Dec-02 03:02:38.124626] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.144208] {goby::acomms::modemdriver::in::1}: D: $CACFG,fsk.packet.carrier_Hz,25120*13
sendMessage [2019-Dec-02 03:02:38.144445] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.164035] {goby::acomms::modemdriver::in::1}: D: $CACFG,fsk.packet.nulltime_ms,200*4B
sendMessage [2019-Dec-02 03:02:38.164206] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.185986] {goby::acomms::modemdriver::in::1}: D: $CACFG,fsk.packet.legacy_addressing,0*5A
sendMessage [2019-Dec-02 03:02:38.186158] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.207894] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.mod_hdr_version,0*72
sendMessage [2019-Dec-02 03:02:38.208088] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.225543] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.modulation,0*12
sendMessage [2019-Dec-02 03:02:38.225737] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.246394] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.bandwidth_Hz,5000*27
sendMessage [2019-Dec-02 03:02:38.246589] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.267373] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.carrier_Hz,25000*06
sendMessage [2019-Dec-02 03:02:38.267585] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.288328] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.bandwidth0_Hz,5000*17
sendMessage [2019-Dec-02 03:02:38.288561] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.309221] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.carrier0_Hz,25000*36
sendMessage [2019-Dec-02 03:02:38.309406] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.328954] {goby::acomms::modemdriver::in::1}: D: $CACFG,psk.packet.nulltime_ms,250*58
sendMessage [2019-Dec-02 03:02:38.329128] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.349749] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector.power_thresh,-20*6B
sendMessage [2019-Dec-02 03:02:38.349922] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.368396] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector.noise_thresh,50*40
sendMessage [2019-Dec-02 03:02:38.368599] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.382933] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.recv,0*77
sendMessage [2019-Dec-02 03:02:38.383116] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.402936] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.channel_mask,1*5C
sendMessage [2019-Dec-02 03:02:38.403119] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.417510] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.type,0*6D
sendMessage [2019-Dec-02 03:02:38.417694] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.433181] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.fm_dir,0*5E
sendMessage [2019-Dec-02 03:02:38.433365] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.451922] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.length_sym,40*65
sendMessage [2019-Dec-02 03:02:38.452108] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.469592] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.fm_bw_Hz,4000*6D
sendMessage [2019-Dec-02 03:02:38.469765] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.490431] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.carrier_Hz,25120*60
sendMessage [2019-Dec-02 03:02:38.490603] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.505883] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector1.thresh,90*5C
sendMessage [2019-Dec-02 03:02:38.506080] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.520407] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.recv,1*75
sendMessage [2019-Dec-02 03:02:38.520636] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.541350] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.channel_mask,1*5F
sendMessage [2019-Dec-02 03:02:38.541534] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.555767] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.type,0*6E
sendMessage [2019-Dec-02 03:02:38.555940] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.571245] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.fm_dir,1*5C
sendMessage [2019-Dec-02 03:02:38.571415] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.590151] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.length_sym,200*50
sendMessage [2019-Dec-02 03:02:38.590424] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.609004] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.fm_bw_Hz,4000*6E
sendMessage [2019-Dec-02 03:02:38.609200] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.628821] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.carrier_Hz,25120*63
sendMessage [2019-Dec-02 03:02:38.628959] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.646394] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector2.thresh,90*5F
sendMessage [2019-Dec-02 03:02:38.646567] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.663012] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.recv,2*77
sendMessage [2019-Dec-02 03:02:38.663210] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.681763] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.channel_mask,1*5E
sendMessage [2019-Dec-02 03:02:38.681944] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.696194] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.type,1*6E
sendMessage [2019-Dec-02 03:02:38.696395] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.712778] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.fm_dir,0*5C
sendMessage [2019-Dec-02 03:02:38.712978] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.731488] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.length_sym,200*51
sendMessage [2019-Dec-02 03:02:38.731659] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.751227] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.fm_bw_Hz,4000*6F
sendMessage [2019-Dec-02 03:02:38.751395] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.771276] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.carrier_Hz,25120*62
sendMessage [2019-Dec-02 03:02:38.771462] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.787928] {goby::acomms::modemdriver::in::1}: D: $CACFG,detector3.thresh,120*64
sendMessage [2019-Dec-02 03:02:38.788113] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.802352] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.mca.gain,250*1B
sendMessage [2019-Dec-02 03:02:38.802537] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.822154] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.onboard_gain,250*7E
sendMessage [2019-Dec-02 03:02:38.822372] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.840868] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.onboard_gain_dB,32*31
sendMessage [2019-Dec-02 03:02:38.841056] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.859550] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.onboard_equalizer,0*10
sendMessage [2019-Dec-02 03:02:38.859734] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.875047] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.agn_legacy,1*7F
sendMessage [2019-Dec-02 03:02:38.875221] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.891566] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.p2b_chmask,1*3D
sendMessage [2019-Dec-02 03:02:38.891735] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.909304] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.agc_length_ms,100*3A
sendMessage [2019-Dec-02 03:02:38.909488] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.924978] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.agc_legacy,1*72
sendMessage [2019-Dec-02 03:02:38.925162] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.940659] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.digital_rcvr,0*6C
sendMessage [2019-Dec-02 03:02:38.940842] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.957294] {goby::acomms::modemdriver::in::1}: D: $CACFG,recv.base64data,0*5B
sendMessage [2019-Dec-02 03:02:38.957480] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.975972] {goby::acomms::modemdriver::in::1}: D: $CACFG,xmit.poweramp_gating,0*18
sendMessage [2019-Dec-02 03:02:38.976146] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:38.990436] {goby::acomms::modemdriver::in::1}: D: $CACFG,xmit.txinhibit,0*23
sendMessage [2019-Dec-02 03:02:38.990621] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.010461] {goby::acomms::modemdriver::in::1}: D: $CACFG,xmit.uart_disable_mask,15*10
sendMessage [2019-Dec-02 03:02:39.010714] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.027324] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.clock_source,2*66
sendMessage [2019-Dec-02 03:02:39.027541] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.043904] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.PPS_source,1*5E
sendMessage [2019-Dec-02 03:02:39.044079] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.059374] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.syncnav,0*30
sendMessage [2019-Dec-02 03:02:39.059546] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.076033] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.scg_timeout,0*1D
sendMessage [2019-Dec-02 03:02:39.076304] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.092813] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.pps_timeout,3*1A
sendMessage [2019-Dec-02 03:02:39.093036] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.110510] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.extpps_enable,1*0B
sendMessage [2019-Dec-02 03:02:39.110686] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.130237] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.extpps_en_after_n,0*0A
sendMessage [2019-Dec-02 03:02:39.130441] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.148902] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.setclk_after_n,0*42
sendMessage [2019-Dec-02 03:02:39.149091] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.170769] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.extpps_disable_after_n,0*75
sendMessage [2019-Dec-02 03:02:39.170957] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.185138] {goby::acomms::modemdriver::in::1}: D: $CACFG,timing.debug,0*3F
sendMessage [2019-Dec-02 03:02:39.185322] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.203800] {goby::acomms::modemdriver::in::1}: D: $CACFG,hibernate.wake_interval,0*6C
sendMessage [2019-Dec-02 03:02:39.203971] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.233142] {goby::acomms::modemdriver::in::1}: D: $CACFG,hibernate.wake_reference,1970-01-01T00:00:00Z*29
sendMessage [2019-Dec-02 03:02:39.233324] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.261575] {goby::acomms::modemdriver::in::1}: D: $CACFG,hibernate.hibernate_after,0*65
sendMessage [2019-Dec-02 03:02:39.261675] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.272710] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.soundspeed_mps,1430*24
sendMessage [2019-Dec-02 03:02:39.272822] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.283810] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.nst,0*4E
sendMessage [2019-Dec-02 03:02:39.283970] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.299239] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.mode,0*02
sendMessage [2019-Dec-02 03:02:39.299451] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.312580] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.dbg,0*60
sendMessage [2019-Dec-02 03:02:39.312796] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.329180] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_type,0*3F
sendMessage [2019-Dec-02 03:02:39.329366] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.351131] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs1_x_mm,-15*64
sendMessage [2019-Dec-02 03:02:39.351331] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.371964] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs1_y_mm,15*48
sendMessage [2019-Dec-02 03:02:39.372150] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.391712] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs1_z_mm,0*7F
sendMessage [2019-Dec-02 03:02:39.391878] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.413567] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs2_x_mm,15*4A
sendMessage [2019-Dec-02 03:02:39.413733] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.434373] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs2_y_mm,15*4B
sendMessage [2019-Dec-02 03:02:39.434546] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.455163] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs2_z_mm,0*7C
sendMessage [2019-Dec-02 03:02:39.455345] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.476022] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs3_x_mm,15*4B
sendMessage [2019-Dec-02 03:02:39.476206] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.497984] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs3_y_mm,-15*67
sendMessage [2019-Dec-02 03:02:39.498160] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.518995] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs3_z_mm,0*7D
sendMessage [2019-Dec-02 03:02:39.519244] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.540024] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs4_x_mm,-15*61
sendMessage [2019-Dec-02 03:02:39.540206] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.561945] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs4_y_mm,-15*60
sendMessage [2019-Dec-02 03:02:39.562114] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.581833] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.array_locs4_z_mm,0*7A
sendMessage [2019-Dec-02 03:02:39.582050] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.600692] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.usbl.channel_mask,30*1A
sendMessage [2019-Dec-02 03:02:39.600912] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.617263] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.mode,0*75
sendMessage [2019-Dec-02 03:02:39.617455] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.639240] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.carrier_Hz,13500*60
sendMessage [2019-Dec-02 03:02:39.639491] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.661230] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.cycles_per_sym,7*72
sendMessage [2019-Dec-02 03:02:39.661424] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.687392] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.data,0000000000000000*56
sendMessage [2019-Dec-02 03:02:39.687568] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.708146] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.sequence_len,47*62
sendMessage [2019-Dec-02 03:02:39.708350] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.731092] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.timing_mode,0*3A
sendMessage [2019-Dec-02 03:02:39.731258] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.748667] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.period,1*72
sendMessage [2019-Dec-02 03:02:39.748835] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.775083] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.reference_time,1449187200*63
sendMessage [2019-Dec-02 03:02:39.775364] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.799260] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.bandwidth_Hz,4000*40
sendMessage [2019-Dec-02 03:02:39.799468] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.823300] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.trackping.duration_msx10,35*66
sendMessage [2019-Dec-02 03:02:39.823473] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.837646] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.dt.mode,0*1A
sendMessage [2019-Dec-02 03:02:39.837818] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.850938] {goby::acomms::modemdriver::in::1}: D: $CACFG,nav.dt.type,1*00
sendMessage [2019-Dec-02 03:02:39.851110] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.869593] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.part_number,201005*2D
sendMessage [2019-Dec-02 03:02:39.869762] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.887165] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.serial_number,933*05
sendMessage [2019-Dec-02 03:02:39.887349] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.901538] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.board_rev,68*2A
sendMessage [2019-Dec-02 03:02:39.901706] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.919060] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.bom_variant,77*28
sendMessage [2019-Dec-02 03:02:39.919226] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.934526] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.bom_rev,1*0F
sendMessage [2019-Dec-02 03:02:39.934695] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.954239] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.fpga_version,2.0.21446*62
sendMessage [2019-Dec-02 03:02:39.954455] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.971910] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.fpga_api_level,3*4D
sendMessage [2019-Dec-02 03:02:39.972115] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:39.992782] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.fpga_flashrom_version,2*38
sendMessage [2019-Dec-02 03:02:39.992953] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.008312] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.build_oem,65*2D
sendMessage [2019-Dec-02 03:02:40.008486] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.023966] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.build_year,2018*4D
sendMessage [2019-Dec-02 03:02:40.024124] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.040625] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.build_month,9*00
sendMessage [2019-Dec-02 03:02:40.040810] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.057153] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.build_options,0*09
sendMessage [2019-Dec-02 03:02:40.057369] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.083546] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.coproc_version,0.30.0.56.18515 *5F
sendMessage [2019-Dec-02 03:02:40.083759] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.106561] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.firmware_version,2.0.27087*6C
sendMessage [2019-Dec-02 03:02:40.106739] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.126322] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.loader_version,17175*61
sendMessage [2019-Dec-02 03:02:40.126511] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.141744] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.booted_slot,1*1D
sendMessage [2019-Dec-02 03:02:40.141912] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.156100] {goby::acomms::modemdriver::in::1}: D: $CACFG,info.debugio,6*21
sendMessage [2019-Dec-02 03:02:40.156318] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.886935] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.batt_v,12.342000*17
sendMessage [2019-Dec-02 03:02:40.887146] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.909187] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.aux_adc_v,0.015000*73
sendMessage [2019-Dec-02 03:02:40.909392] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.926007] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.aux_adc_gain,1*2F
sendMessage [2019-Dec-02 03:02:40.926192] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.941681] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.aux_adc_res,12*78
sendMessage [2019-Dec-02 03:02:40.941867] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.956167] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.aux33V_on,1*40
sendMessage [2019-Dec-02 03:02:40.956417] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.971748] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.aux33V_fault,0*2A
sendMessage [2019-Dec-02 03:02:40.971939] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:40.986156] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.stack33V_on,1*42
sendMessage [2019-Dec-02 03:02:40.986341] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.004947] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.stack33V_fault,0*28
sendMessage [2019-Dec-02 03:02:41.005135] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.021754] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.Vpwramp_on,1*25
sendMessage [2019-Dec-02 03:02:41.021986] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.037399] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.Vpwramp_fault,0*4F
sendMessage [2019-Dec-02 03:02:41.037601] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.051828] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.Vpreamp_on,1*37
sendMessage [2019-Dec-02 03:02:41.052027] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.068358] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.Vpreamp_fault,0*5D
sendMessage [2019-Dec-02 03:02:41.068569] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.083000] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.VSDcard_on,0*2E
sendMessage [2019-Dec-02 03:02:41.083341] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.100907] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.VSDcard_fault,0*45
sendMessage [2019-Dec-02 03:02:41.101106] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.114265] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.gpio1,0*05
sendMessage [2019-Dec-02 03:02:41.114454] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.126477] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.gpio2,0*06
sendMessage [2019-Dec-02 03:02:41.126671] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.138811] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.gpio3,0*07
sendMessage [2019-Dec-02 03:02:41.138996] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.151166] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.gpio4,0*00
sendMessage [2019-Dec-02 03:02:41.151367] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.162381] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.gpio5,0*01
sendMessage [2019-Dec-02 03:02:41.162574] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.176806] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.txinhibit,2*52
sendMessage [2019-Dec-02 03:02:41.176976] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.192304] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.temp,32.562500*32
sendMessage [2019-Dec-02 03:02:41.192478] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.212117] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.mm_rom_valid,0*35
sendMessage [2019-Dec-02 03:02:41.212322] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.235137] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.mm_rom,0000000000000000*2C
sendMessage [2019-Dec-02 03:02:41.235332] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.253805] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.pa_rom_valid,0*24
sendMessage [2019-Dec-02 03:02:41.253975] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.276792] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.pa_rom,0000000000000000*3D
sendMessage [2019-Dec-02 03:02:41.277021] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.298716] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.pa_rom_boot_search,0*15
sendMessage [2019-Dec-02 03:02:41.298929] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.319626] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux1_rom_valid,0*68
sendMessage [2019-Dec-02 03:02:41.319801] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.344765] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux1_rom,0000000000000000*71
sendMessage [2019-Dec-02 03:02:41.344938] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.367781] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux1_rom_boot_search,0*59
sendMessage [2019-Dec-02 03:02:41.367991] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.387536] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux2_rom_valid,0*6B
sendMessage [2019-Dec-02 03:02:41.387724] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.411536] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux2_rom,0000000000000000*72
sendMessage [2019-Dec-02 03:02:41.411723] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.434481] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux2_rom_boot_search,0*5A
sendMessage [2019-Dec-02 03:02:41.434703] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.454262] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux3_rom_valid,0*6A
sendMessage [2019-Dec-02 03:02:41.454448] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.481454] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux3_rom,0000000000000000*73
sendMessage [2019-Dec-02 03:02:41.481638] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.504384] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux3_rom_boot_search,0*5B
sendMessage [2019-Dec-02 03:02:41.504549] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.524328] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux4_rom_valid,0*6D
sendMessage [2019-Dec-02 03:02:41.524566] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.549574] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux4_rom,0000000000000000*74
sendMessage [2019-Dec-02 03:02:41.549780] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.571533] {goby::acomms::modemdriver::in::1}: D: $CACFG,hwd.1wire.aux4_rom_boot_search,0*5C
sendMessage [2019-Dec-02 03:02:41.571706] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.595745] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.temperature_degC,27.937500*52
sendMessage [2019-Dec-02 03:02:41.595959] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.618847] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.vbat,12.824000*45
sendMessage [2019-Dec-02 03:02:41.619036] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.643972] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.vtransmit,0.606000*05
sendMessage [2019-Dec-02 03:02:41.644150] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.671294] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.iout_sense_amps,0.000000*1F
sendMessage [2019-Dec-02 03:02:41.671466] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.687905] {goby::acomms::modemdriver::in::1}: D: $CAREV,030241,AUV,2.0.27087*11
sendMessage [2019-Dec-02 03:02:41.688075] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:41.688327] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:02:41.706828] {goby::acomms::modemdriver::in::1}: D: $CAREV,030241,COPROC,0.30.0.56*47
sendMessage [2019-Dec-02 03:02:41.707018] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:41.721246] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.txlevel,0*2D
sendMessage [2019-Dec-02 03:02:41.721416] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.739935] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.stackpower_conf,1*1C
sendMessage [2019-Dec-02 03:02:41.740139] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.754393] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.VPS_on,1*5D
sendMessage [2019-Dec-02 03:02:41.754563] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.767679] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.gpio5,3*70
sendMessage [2019-Dec-02 03:02:41.767861] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.782257] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.gpio6,3*73
sendMessage [2019-Dec-02 03:02:41.782512] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.795688] {goby::acomms::modemdriver::in::1}: D: $CACFG,pwramp.fault,0*3D
sendMessage [2019-Dec-02 03:02:41.795865] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.810135] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.active,0*5D
sendMessage [2019-Dec-02 03:02:41.810325] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.826693] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.comports,15*6E
sendMessage [2019-Dec-02 03:02:41.826865] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.837865] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v0,0*17
sendMessage [2019-Dec-02 03:02:41.838053] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.850110] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v1,0*16
sendMessage [2019-Dec-02 03:02:41.850292] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.862344] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v2,0*15
sendMessage [2019-Dec-02 03:02:41.862529] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.874550] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v3,0*14
sendMessage [2019-Dec-02 03:02:41.874719] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.875991] {goby::acomms::modemdriver::out::1}: D: resending last command; no serial ack in 5 second(s). 
sendMessage [2019-Dec-02 03:02:41.876210] {goby::acomms::modemdriver::out::1}: D: $CCCYC,0,0,8,0,0,1*50
sendMessage [2019-Dec-02 03:02:41.876402] {goby::acomms::modemdriver::out::1}: ^ Network Cycle Initialization Command
sendMessage [2019-Dec-02 03:02:41.886324] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v4,0*13
sendMessage [2019-Dec-02 03:02:41.886507] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.898557] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v5,0*12
sendMessage [2019-Dec-02 03:02:41.898725] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.909686] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v6,0*11
sendMessage [2019-Dec-02 03:02:41.909853] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.921917] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v7,0*10
sendMessage [2019-Dec-02 03:02:41.922107] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.934164] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v8,0*1F
sendMessage [2019-Dec-02 03:02:41.934348] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.946431] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.v9,0*1E
sendMessage [2019-Dec-02 03:02:41.946606] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.957588] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vA,0*66
sendMessage [2019-Dec-02 03:02:41.957756] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.969819] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vB,0*65
sendMessage [2019-Dec-02 03:02:41.969988] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.982039] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vC,0*64
sendMessage [2019-Dec-02 03:02:41.982206] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:41.994297] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vD,0*63
sendMessage [2019-Dec-02 03:02:41.994494] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:42.005509] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vE,0*62
sendMessage [2019-Dec-02 03:02:42.005679] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:42.017781] {goby::acomms::modemdriver::in::1}: D: $CACFG,script.vF,0*61
sendMessage [2019-Dec-02 03:02:42.017963] {goby::acomms::modemdriver::in::1}: ^ Echo of NVRAM configuration parameter, modem to host:  
sendMessage [2019-Dec-02 03:02:42.030179] {goby::acomms::modemdriver::in::1}: D: $CACYC,0,0,8,0,0,1*52
sendMessage [2019-Dec-02 03:02:42.030423] {goby::acomms::modemdriver::in::1}: ^ Echo of Network Cycle Initialization command
sendMessage [2019-Dec-02 03:02:42.031726] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:02:42.031900] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:42.042960] {goby::acomms::modemdriver::in::1}: D: $CACYC,0,0,8,0,0,1*52
sendMessage [2019-Dec-02 03:02:42.043140] {goby::acomms::modemdriver::in::1}: ^ Echo of Network Cycle Initialization command
sendMessage [2019-Dec-02 03:02:42.049862] {goby::acomms::modemdriver::in::1}: D: $CATXP,0*42
sendMessage [2019-Dec-02 03:02:42.050032] {goby::acomms::modemdriver::in::1}: ^ Start of packet transmission, modem to host
sendMessage [2019-Dec-02 03:02:43.466482] {goby::acomms::modemdriver::in::1}: D: (Warning): Failed to handle message: NMEASentence: bad talker length '$ERROR_system,16,7,error.c,361,4597c,45ade,45e80,52c9a,0,0,Queue busy
sendMessage [2019-Dec-02 03:02:43.466705] {goby::acomms::modemdriver::in::1}: $CAREV,030243,INIT,2.0.27087'.
sendMessage [2019-Dec-02 03:02:43.484142] {goby::acomms::modemdriver::in::1}: D: $CAREV,030243,SLOT1,2.0.27087*64
sendMessage [2019-Dec-02 03:02:43.484351] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:43.500722] {goby::acomms::modemdriver::in::1}: D: $CAREV,030243,AUV,2.0.27087*13
sendMessage [2019-Dec-02 03:02:43.500906] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:43.501124] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:02:43.519607] {goby::acomms::modemdriver::in::1}: D: $CAREV,030243,COPROC,0.30.0.56*45
sendMessage [2019-Dec-02 03:02:43.519776] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:43.540543] {goby::acomms::modemdriver::in::1}: D: $CATMG,2019-12-02T03:02:43Z,RTC,RTC*73
sendMessage [2019-Dec-02 03:02:43.540760] {goby::acomms::modemdriver::in::1}: ^ Informational message about timing source, printed when timing sources change (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:47.032724] {goby::acomms::modemdriver::out::1}: D: resending last command; no serial ack in 5 second(s). 
sendMessage [2019-Dec-02 03:02:47.033004] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:02:47.033171] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:47.062744] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:02:47Z,RTC,RTC*61
sendMessage [2019-Dec-02 03:02:47.062988] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:47.063748] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.436847
sendMessage [2019-Dec-02 03:02:47.063922] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:02:49.000938] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:02:49.001158] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:49.030908] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:02:49Z,RTC,RTC*6F
sendMessage [2019-Dec-02 03:02:49.031110] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:49.031793] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.468742
sendMessage [2019-Dec-02 03:02:49.031965] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:02:53.454862] {goby::acomms::modemdriver::in::1}: D: $CAREV,030253,AUV,2.0.27087*12
sendMessage [2019-Dec-02 03:02:53.455081] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:53.455289] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:02:53.472865] {goby::acomms::modemdriver::in::1}: D: $CAREV,030253,COPROC,0.30.0.56*44
sendMessage [2019-Dec-02 03:02:53.473052] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:02:59.000454] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:02:59.000680] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:59.030134] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:02:59Z,RTC,RTC*6E
sendMessage [2019-Dec-02 03:02:59.030323] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:02:59.031033] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.469531
sendMessage [2019-Dec-02 03:02:59.031207] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:03:03.456678] {goby::acomms::modemdriver::in::1}: D: $CAREV,030303,AUV,2.0.27087*16
sendMessage [2019-Dec-02 03:03:03.456939] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:03.457213] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:03:03.474598] {goby::acomms::modemdriver::in::1}: D: $CAREV,030303,COPROC,0.30.0.56*40
sendMessage [2019-Dec-02 03:03:03.474775] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:09.000927] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:03:09.001034] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:09.029818] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:03:09Z,RTC,RTC*6A
sendMessage [2019-Dec-02 03:03:09.029894] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:09.030173] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.470047
sendMessage [2019-Dec-02 03:03:09.030240] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:03:13.458934] {goby::acomms::modemdriver::in::1}: D: $CAREV,030313,AUV,2.0.27087*17
sendMessage [2019-Dec-02 03:03:13.459155] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:13.459400] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:03:13.476723] {goby::acomms::modemdriver::in::1}: D: $CAREV,030313,COPROC,0.30.0.56*41
sendMessage [2019-Dec-02 03:03:13.476908] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:19.001216] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:03:19.001441] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:19.030842] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:03:19Z,RTC,RTC*6B
sendMessage [2019-Dec-02 03:03:19.031030] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:19.031711] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.468823
sendMessage [2019-Dec-02 03:03:19.031900] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:03:23.460513] {goby::acomms::modemdriver::in::1}: D: $CAREV,030323,AUV,2.0.27087*14
sendMessage [2019-Dec-02 03:03:23.460751] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:23.460972] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:03:23.478346] {goby::acomms::modemdriver::in::1}: D: $CAREV,030323,COPROC,0.30.0.56*42
sendMessage [2019-Dec-02 03:03:23.478538] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:29.000190] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:03:29.000439] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:29.029005] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:03:29Z,RTC,RTC*68
sendMessage [2019-Dec-02 03:03:29.029194] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:29.029882] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.470658
sendMessage [2019-Dec-02 03:03:29.030056] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:03:33.461845] {goby::acomms::modemdriver::in::1}: D: $CAREV,030333,AUV,2.0.27087*15
sendMessage [2019-Dec-02 03:03:33.461972] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:33.462062] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:03:33.480214] {goby::acomms::modemdriver::in::1}: D: $CAREV,030333,COPROC,0.30.0.56*43
sendMessage [2019-Dec-02 03:03:33.480305] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:39.000929] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:03:39.001166] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:39.030619] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:03:39Z,RTC,RTC*69
sendMessage [2019-Dec-02 03:03:39.030818] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:39.031517] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.469025
sendMessage [2019-Dec-02 03:03:39.031700] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.
sendMessage [2019-Dec-02 03:03:43.463788] {goby::acomms::modemdriver::in::1}: D: $CAREV,030343,AUV,2.0.27087*12
sendMessage [2019-Dec-02 03:03:43.464014] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:43.464215] {goby::acomms::modemdriver::in::1}: D: Revision: 2.0.27087
sendMessage [2019-Dec-02 03:03:43.481800] {goby::acomms::modemdriver::in::1}: D: $CAREV,030343,COPROC,0.30.0.56*44
sendMessage [2019-Dec-02 03:03:43.482016] {goby::acomms::modemdriver::in::1}: ^ Software revision message, modem to host
sendMessage [2019-Dec-02 03:03:49.000403] {goby::acomms::modemdriver::out::1}: D: $CCTMQ,0*54
sendMessage [2019-Dec-02 03:03:49.000621] {goby::acomms::modemdriver::out::1}: ^ Query modem time command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:49.030177] {goby::acomms::modemdriver::in::1}: D: $CATMQ,2019-12-02T03:03:49Z,RTC,RTC*6E
sendMessage [2019-Dec-02 03:03:49.030284] {goby::acomms::modemdriver::in::1}: ^ Response to time query (CCTMQ) command (Micro-Modem 2)
sendMessage [2019-Dec-02 03:03:49.031095] {goby::acomms::modemdriver::in::1}: D: Time Difference: 00:00:00.469644
sendMessage [2019-Dec-02 03:03:49.031292] {goby::acomms::modemdriver::out::1}: D: Micro-Modem clock acceptably set.