Re: Black Michael via wsjt-devel
> So if you do an "ldd" on the executables they all point to the same libhamlib
> ?
$ ldd /usr/bin/wsjtx | grep hamlib
libhamlib.so.4 => /lib/x86_64-linux-gnu/libhamlib.so.4
(0x00007f556f2a0000)
$ ldd /usr/bin/rigctl* | grep hamlib
libhamlib.so.4 => /lib/x86_64-linux-gnu/libhamlib.so.4
(0x00007f54323ba000)
libhamlib.so.4 => /lib/x86_64-linux-gnu/libhamlib.so.4
(0x00007f348d105000)
libhamlib.so.4 => /lib/x86_64-linux-gnu/libhamlib.so.4
(0x00007ffa08c89000)
> If that's true please provide some debug info from rigctld so we can see the
> problem. What I suspect you'll see is it's asking for "VFO_SUB" which is the
> behavior we've seen with the problem....that's the common problem with the
> structure realignment.
$ /usr/bin/rigctld -m 3009 -r /dev/ttyUSBICOM -p /dev/ttyUSBPTT -vvvvv
Recommend using --vfo switch for rigctld if client supports it
rigctl and netrigctl will automatically detect vfo mode
rigctld Hamlib 4.0
Last commit was Sa Jan 02 00:47:50 2021 +0000 SHA=5f4cc3
Report bugs to <[email protected]>
rig_init called
initrigs4_icom: _init called
rig_register called
rig_register: rig_register (3055)
rig_register called
rig_register: rig_register (3085)
rig_register called
rig_register: rig_register (3009)
rig_register called
rig_register: rig_register (3010)
rig_register called
[...]
rig_register called
rig_register: rig_register (3076)
icom_init called
icom_init: done
main: twiddle=0, uplink=0
rig_open called
port_open called
serial_open called
serial_setup called
serial_setup: tcgetattr
serial_setup: cfmakeraw
serial_setup: cfsetispeed=19200,0x000e
serial_setup: cfsetospeed=19200,0x000e
serial_setup: data_bits=8
serial_setup: parity=0
serial_setup: tcsetattr TCSANOW
serial_flush called
tcflush
icom_rig_open 757
icom_rig_open: IC-706 v20201219.0
icom_get_usb_echo_off called
icom_get_usb_echo_off: retry temp set to 1
icom_transaction: cmd=0x03, subcmd=0xffffffff, payload_len=0, data_len=80
rig_flush: called for serial device
serial_flush called
tcflush
write_block called
write_block(): TX 6 bytes
0000 fe fe 48 e0 03 fd ..H...
read_string called, rxmax=80
read_string(): RX 6 characters
0000 fe fe 48 e0 03 fd ..H...
read_string called, rxmax=80
read_string(): RX 11 characters
0000 fe fe e0 48 03 00 70 35 05 00 fd ...H..p5...
icom_get_usb_echo_off: ack_len=6
icom_get_usb_echo_off: USB echo on detected
rig_get_vfo called
rig_get_vfo: no get_vfo
rig_open: Icom rig so default vfo = currVFO
Opened rig model 3009, 'IC-706'
Backend version: 20201219.0, Status: Stable
main: Using IPV4
... clicking on "Test CAT" in wsjtx 2.3.0~rc3:
Connection opened from localhost:54898
sync_callback: client lock engaged
sync_callback: client lock disengaged
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd=\(5c)
rigctl_parse: cmd=chk_vfo
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): ð 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rigctl_parse: vfo_opt=0
rigctl_parse: retcode=0
sync_callback: client lock disengaged
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd=\(5c)
rigctl_parse: cmd=dump_state
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rigctl_parse: vfo_opt=0
rigctl_parse: retcode=0
sync_callback: client lock disengaged
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd=v(76)
rigctl_parse: cmd==0x76
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): v 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rig_get_vfo called
rig_get_vfo: no get_vfo
rigctl_parse: vfo_opt=0
rigctl_parse: return#1 RPRT -11
rigctl_parse: retcode=-11
sync_callback: client lock disengaged
handle_socket: rigctl_parse retcode=-11
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd==0x0a
rigctl_parse: cmd=v(76)
rigctl_parse: cmd==0x76
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): v 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rig_get_vfo called
rig_get_vfo: no get_vfo
rigctl_parse: vfo_opt=0
rigctl_parse: return#1 RPRT -11
rigctl_parse: retcode=-11
sync_callback: client lock disengaged
handle_socket: rigctl_parse retcode=-11
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd==0x0a
rigctl_parse: cmd=f(66)
rigctl_parse: cmd==0x66
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): f 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rig_get_freq called vfo=currVFO
vfo_fixup: vfo=currVFO
vfo_fixup: Leaving currVFO alone
get_cache_freq: vfo=currVFO, freq=0
elapsed_ms: start = 0,0
rig_get_freq: cache check age=1000000ms
rig_get_freq: cache miss age=1000000ms, cached_vfo=None, asked_vfo=currVFO
icom_get_freq called for currVFO, curr_vfo=currVFO
set_vfo_curr: vfo=currVFO, curr_vfo=currVFO
set_vfo_curr: Asking for currVFO, currVFO=currVFO
set_vfo_curr: using curr_vfo=currVFO
set_vfo_curr: curr_vfo now=currVFO
icom_get_freq: using vfo=currVFO
icom_transaction: cmd=0x03, subcmd=0xffffffff, payload_len=0,
data_len=1485719584
rig_flush: called for serial device
serial_flush called
tcflush
write_block called
write_block(): TX 6 bytes
0000 fe fe 48 e0 03 fd ..H...
read_string called, rxmax=80
read_string(): RX 6 characters
0000 fe fe 48 e0 03 fd ..H...
read_string called, rxmax=80
read_string(): RX 11 characters
0000 fe fe e0 48 03 00 70 35 05 00 fd ...H..p5...
from_bcd called
icom_get_freq exit vfo=currVFO, curr_vfo=currVFO
elapsed_ms: start = 0,0
elapsed_ms: after gettime, start = 1609964100,803773113
elapsed_ms: start = 0,0
elapsed_ms: after gettime, start = 1609964100,803796357
rig_get_freq: cache reset age=999000ms, vfo=currVFO, freq=5357000
elapsed_ms: start = 0,0
elapsed_ms: after gettime, start = 1609964100,803841719
rigctl_parse: vfo_opt=0
rigctl_parse: retcode=0
sync_callback: client lock disengaged
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd==0x0a
rigctl_parse: cmd=m(6d)
rigctl_parse: cmd==0x6d
rigctl_parse: vfo_opt=0
rigctl_parse: debug1
rigctl_parse: debug5
rigctl_parse: debug10
sync_callback: client lock engaged
rigctl(d): m 'currVFO' '' '' ''
rigctl_parse: vfo_opt=0
rig_get_mode called
elapsed_ms: start = 0,0
rig_get_mode: cache check age=1000000ms
rig_get_mode: cache miss age=1000000ms
icom_get_mode called vfo=currVFO
icom_transaction: cmd=0x04, subcmd=0xffffffff, payload_len=0, data_len=0
rig_flush: called for serial device
serial_flush called
tcflush
write_block called
write_block(): TX 6 bytes
0000 fe fe 48 e0 04 fd ..H...
read_string called, rxmax=80
read_string(): RX 6 characters
0000 fe fe 48 e0 04 fd ..H...
read_string called, rxmax=80
read_string(): RX 8 characters
0000 fe fe e0 48 04 01 01 fd ...H....
icom_get_mode: modebuf[0]=0x04, modebuf[1]=0x01, modebuf[2]=0x01, mode_len=3,
filter=1
icom2rig_mode: mode=0x01, pd=1
rig_passband_wide called
rig_passband_narrow called
icom_get_dsp_flt called
icom_transaction: cmd=0x1a, subcmd=0x03, payload_len=0, data_len=0
rig_flush: called for serial device
serial_flush called
tcflush
write_block called
write_block(): TX 7 bytes
0000 fe fe 48 e0 1a 03 fd ..H....
read_string called, rxmax=80
read_string(): RX 7 characters
0000 fe fe 48 e0 1a 03 fd ..H....
read_string called, rxmax=80
read_string(): RX 6 characters
0000 fe fe e0 48 fa fd ...H..
icom_transaction: failed: Command rejected by the rig
icom_get_mode: vfo=currVFO returning mode=USB, width not available
rig_get_mode: retcode after get_mode=0
rig_get_mode(1894): debug
rig_get_mode(1901): debug
rig_passband_normal called
rig_passband_normal: return filter#0, width=2400
elapsed_ms: start = 0,0
elapsed_ms: after gettime, start = 1609964100,845259727
rigctl_parse: vfo_opt=0
rigctl_parse: retcode=0
sync_callback: client lock disengaged
handle_socket: vfo_mode=0
rigctl_parse: called, interactive=1
rigctl_parse: cmd==0x0a
rigctl_parse: cmd=q(71)
rigctl_parse: cmd==0x71
rigctl_parse: vfo_opt=0
rigctl_parse: quit returning NETRIGCTL_RET 0
handle_socket: rigctl_parse retcode=1
Connection closed from localhost:54898
... and the "Hamlib error: Invalid parameter while exchanging VFOs" popup.
Perhaps one detail about the 3.3 hamlib used before, it had a small
vfo_ops patch to support the IC706, but I believe that was the same
that went into 4.0. Possibly the error is in that area:
https://salsa.debian.org/debian-hamradio-team/hamlib/-/commit/695c71fd71205857d0ef84daf8d09c7eaa6bff5d
Thanks,
Christoph DF7CB
_______________________________________________
wsjt-devel mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/wsjt-devel
