ok2cqr / cqrlog

Linux logging program for amateur radio operators
https://www.cqrlog.com
GNU General Public License v2.0
131 stars 54 forks source link

Can not set frequency for FT-897D from CQRLOG (readout works) #536

Closed Yume303 closed 2 years ago

Yume303 commented 2 years ago

Can not set frequency/mode from CQRLOG for my rig (readout works nicely). Also tested with flrig and wsjtx with the same settings and it works (also tested under windows with flrig, and it works there too). rigctld/hamlib version: 4.3.1

OH1KH commented 2 years ago

There is difference with wsjtx and flrig. Wsjtx uses Hamlib API and flrig uses it's own procedure (if not configured to use Hamlib, when it uses Hamlib API).

Cqrlog uses rigctld string commands that you can simulate making telnet connection to localhost:4532 Set preferences/TRXConsole/Show communication with TRX in console checkbox checked. Close Cqrlog and start it from command console typing: cqrlog

When you see what Cqrlog sends and how rig answers you can test it with telnet localhost 4532 manually if needed. It may be wise to set poll rate to something like 2000 to get more time to see what happens.

Report the problem you see.

Yume303 commented 2 years ago

Thanks for the quick answer. Some additional information for the above: i tested flrig with hamlib (hamlib api as I see for now). Also, executed a new test now with rigctld and gpredict, it works and sets frequency / mode correctly with the same cli arguments as the cqrlog's rigctld instance(except the -vvvv for debugging).

Messages from CQRLOG:

RigCtldPath:rigctld RigCtldArgs:-m 1043 -r /dev/ttyUSB0 -t 4532 -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF RunRigCtld: TRUE RigDevice: /dev/ttyUSB0 RigCtldPort:4532 RigCtldHost:localhost RigPoll: 2000 RigSendCWR: FALSE RigId: 1043

Starting RigCtld ... rigProcess.Executable: rigctld Parameters: -m 1043 -r /dev/ttyUSB0 -t 4532 -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF

rigctld started! Connected to rigctld @ localhost:4532 Sending: � 1

Msg from rig: RPRT 0 Sending: fmv

Msg from rig: 145889340 Msg from rig: PKTUSB 0 Msg from rig: VFOA Sending: fmv

Msg from rig: 145889340 PKTUSB 0 Msg from rig: VFOA Sending: fmv

Msg from rig: 145889340 PKTUSB 0 Msg from rig: VFOA Sending: fmv

Msg from rig: 145889340 Msg from rig: PKTUSB 0 Msg from rig: VFOA Sending: fmv

From command line with gpredict:

yume@csotanyodu:~ $ rigctld -m 1043 -r /dev/ttyUSB0 -t 4532 -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF -vvvv ../../tests/rigctld.c(581) Startup: rigctld -m 1043 -r /dev/ttyUSB0 -t 4532 -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF -vvvv rigctld Hamlib 4.3.1 Mon Sep 13 23:12:03 2021 +0000 SHA=c2ed3d Report bugs to hamlib-developer@lists.sourceforge.net

yaesu: initrigs4_yaesu called rig_register called rig_register: rig_register (1021) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1027) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1010) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1005) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1006) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1007) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1039) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1009) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1020) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1001) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1022) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1023) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1011) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1015) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1013) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1014) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1028) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1031) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1016) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1003) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1024) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1004) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1025) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1029) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1037) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1032) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1030) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1017) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1019) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1018) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1026) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1033) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1034) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1035) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1036) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1038) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1040) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1041) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1042) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1043) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1044) register.c(225):rig_register return(0) rig_init: rig has VFO_A rig_init: rig has VFO_B ft897_init: called rigctl_parse.c(1931):set_conf entered rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: data_bits='8' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: stop_bits='1' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: serial_parity='None' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: rts_state='OFF' rigctl_parse.c(1965):set_conf return(0) rig.c(684):rig_open entered iofunc.c(68):port_open entered serial.c(144):serial_open entered serial_open: /dev/ttyUSB0 serial.c(291):serial_setup entered serial.c(631):serial_setup return(0) serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) serial.c(266):serial_open return(0) serial.c(859):ser_set_rts entered ser_set_rts: RTS=0 serial.c(899):ser_set_rts return(0) iofunc.c(186):port_open return(0) rig.c(220):add_opened_rig return(0) ft897_open: called rig.c(2753):rig_get_vfo entered ft857_get_vfo: called ft857_read_eeprom: called read_block called rig.c(2809):rig_get_vfo return(0) rig.c(1102):rig_open return(0) Opened rig model 1043, 'FT-897D' Backend version: 20210103.0, Status: Beta ../../src/network.c(554):network_multicast_server under development ../../src/network.c(556):ADDR=0.0.0.0, port=4532 Connection opened from localhost:54610 rigctld.c(1065):handle_socket entered sync_callback: client lock engaged sync_callback: client lock disengaged rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2911):rigctl_set_split_vfo entered rig_parse_vfo called rigctl_parse.c(2927):rigctl_set_split_vfo return(-1) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(-1) handle_socket: rigctl_parse retcode=-1 rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2457):rigctl_get_ptt entered rig.c(3123):rig_get_ptt entered ft897_get_ptt: called check_cache_timeout: cache invalid ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called rig.c(3174):rig_get_ptt return(0) rigctl_parse.c(2474):rigctl_get_ptt return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(1983):rigctl_set_freq entered rig_set_freq called vfo=currVFO, freq=145890658 ft897_set_freq: called ft897_set_freq: requested freq = 145890658 Hz to_bcd_be called rig_force_cache_timeout called ft897_send_icmd: called ft817_read_ack: called read_block called rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache invalid ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rig.c(1954):rig_set_freq return(0) rigctl_parse.c(1995):rigctl_set_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA rig.c(2063):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2457):rigctl_get_ptt entered rig.c(3123):rig_get_ptt entered ft897_get_ptt: called check_cache_timeout: cache timed out (139 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called rig.c(3174):rig_get_ptt return(0) rigctl_parse.c(2474):rigctl_get_ptt return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2744):rigctl_set_split_freq entered rig_set_split_freq called vfo=TX, curr_vfo=VFOA rig_set_freq called vfo=VFOA, freq=145889342 ft897_set_freq: called ft897_set_freq: requested freq = 145889342 Hz to_bcd_be called rig_force_cache_timeout called ft897_send_icmd: called ft817_read_ack: called read_block called rig_get_freq(1993) called vfo=VFOA ../../src/rig.c(2002) vfo=VFOA, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache invalid ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rig.c(1954):rig_set_freq return(0) rig.c(3854):rig_set_split_freq return(0) rigctl_parse.c(2748):rigctl_set_split_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2457):rigctl_get_ptt entered rig.c(3123):rig_get_ptt entered ft897_get_ptt: called check_cache_timeout: cache timed out (132 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called rig.c(3174):rig_get_ptt return(0) rigctl_parse.c(2474):rigctl_get_ptt return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA rig.c(2063):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2457):rigctl_get_ptt entered rig.c(3123):rig_get_ptt entered ft897_get_ptt: called check_cache_timeout: cache timed out (642 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called rig.c(3174):rig_get_ptt return(0) rigctl_parse.c(2474):rigctl_get_ptt return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache timed out (698 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2457):rigctl_get_ptt entered rig.c(3123):rig_get_ptt entered ft897_get_ptt: called check_cache_timeout: cache timed out (975 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called rig.c(3174):rig_get_ptt return(0) rigctl_parse.c(2474):rigctl_get_ptt return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache timed out (949 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(1983):rigctl_set_freq entered rig_set_freq called vfo=currVFO, freq=145889342 ft897_set_freq: called ft897_set_freq: requested freq = 145889342 Hz to_bcd_be called rig_force_cache_timeout called ft897_send_icmd: called ft817_read_ack: called read_block called rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache invalid ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rig.c(1954):rig_set_freq return(0) rigctl_parse.c(1995):rigctl_set_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA rig.c(2063):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2911):rigctl_set_split_vfo entered rig_parse_vfo called rigctl_parse.c(2927):rigctl_set_split_vfo return(-1) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(-1) handle_socket: rigctl_parse retcode=-1 rigctl_parse.c(651):rigctl_parse entered rigctl_parse.c(801):rigctl_parse return(1) handle_socket: rigctl_parse retcode=1 Connection closed from localhost:54610

Yume303 commented 2 years ago

Also cqrlog with debug (-vvvv) enabled:

`Settings:

RigCtldPath:rigctld RigCtldArgs:-m 1043 -r /dev/ttyUSB0 -t 4532 -vvvv -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF RunRigCtld: TRUE RigDevice: /dev/ttyUSB0 RigCtldPort:4532 RigCtldHost:localhost RigPoll: 2000 RigSendCWR: FALSE RigId: 1043

Starting RigCtld ... rigProcess.Executable: rigctld Parameters: -m 1043 -r /dev/ttyUSB0 -t 4532 -vvvv -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF

../../tests/rigctld.c(581) Startup: rigctld -m 1043 -r /dev/ttyUSB0 -t 4532 -vvvv -s 38400 --set-conf=data_bits=8,stop_bits=1,serial_parity=None,rts_state=OFF rigctld Hamlib 4.3.1 Mon Sep 13 23:12:03 2021 +0000 SHA=c2ed3d Report bugs to hamlib-developer@lists.sourceforge.net

yaesu: initrigs4_yaesu called rig_register called rig_register: rig_register (1021) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1027) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1010) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1005) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1006) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1007) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1039) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1009) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1020) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1001) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1022) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1023) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1011) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1015) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1013) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1014) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1028) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1031) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1016) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1003) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1024) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1004) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1025) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1029) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1037) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1032) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1030) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1017) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1019) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1018) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1026) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1033) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1034) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1035) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1036) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1038) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1040) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1041) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1042) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1043) register.c(225):rig_register return(0) rig_register called rig_register: rig_register (1044) register.c(225):rig_register return(0) rig_init: rig has VFO_A rig_init: rig has VFO_B ft897_init: called rigctl_parse.c(1931):set_conf entered rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: data_bits='8' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: stop_bits='1' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: serial_parity='None' rig_token_lookup called rig_confparam_lookup called rig_set_conf called rig_confparam_lookup called rig_set_conf: rts_state='OFF' rigctl_parse.c(1965):set_conf return(0) rig.c(684):rig_open entered iofunc.c(68):port_open entered serial.c(144):serial_open entered serial_open: /dev/ttyUSB0 serial.c(291):serial_setup entered serial.c(631):serial_setup return(0) serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) serial.c(266):serial_open return(0) serial.c(859):ser_set_rts entered ser_set_rts: RTS=0 serial.c(899):ser_set_rts return(0) iofunc.c(186):port_open return(0) rig.c(220):add_opened_rig return(0) ft897_open: called rig.c(2753):rig_get_vfo entered ft857_get_vfo: called ft857_read_eeprom: called read_block called rig.c(2809):rig_get_vfo return(0) rig.c(1102):rig_open return(0) Opened rig model 1043, 'FT-897D' Backend version: 20210103.0, Status: Beta ../../src/network.c(554):network_multicast_server under development ../../src/network.c(556):ADDR=0.0.0.0, port=4532 rigctld started! Connected to rigctld @ localhost:4532 Connection opened from localhost:46056 rigctld.c(1065):handle_socket entered sync_callback: client lock engaged sync_callback: client lock disengaged rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(4765):rigctl_set_powerstat entered rig.c(5556):rig_set_powerstat entered ft817_set_powerstat: called Sending: � 1

rig.c(5571):rig_set_powerstat return(0) rigctl_parse.c(4769):rigctl_set_powerstat return(0) sync_callback: client lock disengaged Msg from rig: RPRT 0 rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered Sending: fmv

sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache invalid ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) Msg from rig: 145889340 rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2144):rigctl_get_mode entered rig.c(2328):rig_get_mode entered ft897_get_mode: called check_cache_timeout: using cache (2 ms) rig.c(2455):rig_passband_normal entered rig_passband_normal: filter not found...return RIG_PASSBAND_NORMAL=0 rig.c(2482):rig_passband_normal return(0) rig.c(1407):set_cache_mode entered rig.c(1471):set_cache_mode return(0) rig.c(2434):rig_get_mode return(0) rigctl_parse.c(2167):rigctl_get_mode return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2218):rigctl_get_vfo entered rig.c(2753):rig_get_vfo entered ft857_get_vfo: called ft857_read_eeprom: called Msg from rig: PKTUSB 0 read_block called rig.c(2809):rig_get_vfo return(0) rigctl_parse.c(2234):rigctl_get_vfo return(0) sync_callback: client lock disengaged Msg from rig: VFOA rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered Sending: fmv

sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache timed out (1947 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged Msg from rig: 145889340 rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2144):rigctl_get_mode entered rig.c(2328):rig_get_mode entered ft897_get_mode: called check_cache_timeout: using cache (2 ms) rig.c(2455):rig_passband_normal entered rig_passband_normal: filter not found...return RIG_PASSBAND_NORMAL=0 rig.c(2482):rig_passband_normal return(0) rig.c(1407):set_cache_mode entered rig.c(1471):set_cache_mode return(0) rig.c(2434):rig_get_mode return(0) rigctl_parse.c(2167):rigctl_get_mode return(0) sync_callback: client lock disengaged Msg from rig: PKTUSB 0 rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2218):rigctl_get_vfo entered rig.c(2753):rig_get_vfo entered ft857_get_vfo: called ft857_read_eeprom: called read_block called rig.c(2809):rig_get_vfo return(0) rigctl_parse.c(2234):rigctl_get_vfo return(0) sync_callback: client lock disengaged Msg from rig: VFOA rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered Sending: fmv

sync_callback: client lock engaged rigctl_parse.c(2007):rigctl_get_freq entered rig_get_freq(1993) called vfo=currVFO ../../src/rig.c(2002) vfo=currVFO, curr_vfo=VFOA ft897_get_freq: called check_cache_timeout: cache timed out (1948 ms) ft897_get_status: called serial.c(642):serial_flush entered tcflush serial.c(674):serial_flush return(0) read_block called ft897_read_eeprom: called read_block called from_bcd_be called rig.c(2173):rig_get_freq return(0) rigctl_parse.c(2033):rigctl_get_freq return(0) sync_callback: client lock disengaged Msg from rig: 145889340 rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged rigctl_parse.c(2144):rigctl_get_mode entered rig.c(2328):rig_get_mode entered ft897_get_mode: called check_cache_timeout: using cache (2 ms) rig.c(2455):rig_passband_normal entered rig_passband_normal: filter not found...return RIG_PASSBAND_NORMAL=0 rig.c(2482):rig_passband_normal return(0) rig.c(1407):set_cache_mode entered rig.c(1471):set_cache_mode return(0) rig.c(2434):rig_get_mode return(0) rigctl_parse.c(2167):rigctl_get_mode return(0) sync_callback: client lock disengaged rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered sync_callback: client lock engaged Msg from rig: PKTUSB 0 rigctl_parse.c(2218):rigctl_get_vfo entered rig.c(2753):rig_get_vfo entered ft857_get_vfo: called ft857_read_eeprom: called read_block called rig.c(2809):rig_get_vfo return(0) rigctl_parse.c(2234):rigctl_get_vfo return(0) sync_callback: client lock disengaged Msg from rig: VFOA rigctl_parse.c(1758):rigctl_parse return(0) rigctl_parse.c(651):rigctl_parse entered 1 1a 2 3 4 5 6`

OH1KH commented 2 years ago

From Cqrlog part I can see it reads frequency and mode OK. As you said.

But let me see ONLY that part of debug where you try to SET frequency, if that is the defunct part.

What this have to do with gpredict? Are you trying to run Cqrlog and Gpredict at same time?

That does not work unless you set rig model in Gpredict to be 2 (Hamlib net rigctld). Two or more programs can not access same serial device without problems. Linux lets you do that (Windoze does not) but it does not work preperly. Please read this https://github.com/OH1KH/cqrlog/blob/loc_testing/compiled/setting_rigctld_for_all_programs.pdf

Yume303 commented 2 years ago

Just tested it with gpredict to rule out hw/cable problem. Also tested one after one, not at the same time. Trying to set from the freq from cqrlog does not "arrives" to rigctld as I see, nothing in the log (tried to grep through to find something like in the gpredict-test log, and checked manually too.)

OH1KH commented 2 years ago

You say Cqrlog can not set frequency.

I am not looking for long list of polling (reading freq,mode, vfo). I like to see only the part where you click band button or click frequency reading, type a new frequency and press enter using TRXControl window. I.E. setting new frequency via Cqrlog.

It should look like this: (NOTE: this is done with Cqrlog 2.6.0(001) using rig nr:1 Hamlib Dummy and looks a bit different than your older Cqrlog debug print)

Poll Sending: +f +m +v

Msg from rig:|GET_FREQ: FREQUENCY: 145000000 RPRT 0|

Msg from rig:|GET_MODE: MODE: FM PASSBAND: 15000 RPRT 0|

Msg from rig:|GET_VFO: VFO: VFOA RPRT 0| < -----------------Pressed here 6m band button of TRXControl Queue Sending: [0] +F 51300000

Queue Sending: [1] +M FM 2500

Msg from rig:|SET_FREQ: 51300000 RPRT 0|

Msg from rig:|SET_MODE: FM 2500 RPRT 0|

Poll Sending: +f +m +v

You should find similar dump when you try to set rig to another frequency.

Yume303 commented 2 years ago

That's where the problem is i think, tried again, only got these lines (tried to set from dropdown menu, entered freq manually, but at the next readout it reverted back on the gui to the original frequency(same as on the radio's lcd freq). Maybe the set command doesn't make through the socket to rigctld (dunno), and because of that, it does not appears in the log?

Msg from rig: 145893080 Msg from rig: FM 0 Msg from rig: VFOB Sending: fmv

Msg from rig: 145893080 FM 0 VFOB Sending: fmv

Msg from rig: 145893080 Msg from rig: FM 0 Msg from rig: VFOB Sending: fmv

Msg from rig: 145893080 Msg from rig: FM 0

OH1KH commented 2 years ago

Ahhhh.... That is not bug. Now I finally understood when you mentioned dropdown menu.

You can not drive rig from NewQSO window. It's purpose is just log the worked qso. You should open NewQSO/Window/TRXControl window. As the name says it is for controlling TRX.

Yume303 commented 2 years ago

Ohh... thanks for clarification, it wasn't clear for me, and the above method just works fine. Also sorry for wasting your time, regards and 73's ! Peter (HA1YME)

OH1KH commented 2 years ago

No problem! Main thing is that you got answer.

Sometimes, when time permits, look at the help section (NewQSO/Help/Help index) that open to your browser, please. You find also some videos I have made from https://www.youtube.com/channel/UC3yPCVYmfeBzDSwTosOe2fQ

Please close this issue if you agree it is solved. Thank you!