Date   

locked Re: Control of an Arduino based TX using WSJT-X #Cat_RigControl

Peter E <elekessy@...>
 

Hi Karza,

That is very close to what I had in mind. I shall have a look at the ALL.TXT as you suggest. Unfortunately my programming skills are "basic" at best...

Michael,

Yes timing on push pull D class amps is a particular issue, as applying voltage on the FET's before a valid signal comes in can result in one gate being held high for too long and an over current condition occurring. However, if I can get WSJT-X to pass the relevant information to the Arduino, it can generate its own (slightly delayed) PTT signal - this is what my current Arduino WSPR code does.
No, I am not familiar with Python - I'm not really a programmer - but I suppose never too old to learn? I am also thinking all this may be easier with a Rasberry PI or something similar. I'm actually not very familiar with Hamlib either - I'll look into it.

I think direct Carrier control of a D or E class TX would be a worthwhile thing to add to WSJT-X as you could potentially avoid all the issues and intermods associated with driving a conventional USB transceiver, not to mention having it running all night.

Cheers and thanks for the suggestions.

Peter - VK2AN


locked Re: ICOM 7300 Rig Control Error #FT8 #Cat_RigControl #Icom #macOS

Bruce N7XGR
 

On Mon, Jul 25, 2022 at 3:13 PM <mitch@...> wrote:

Bruce,
I am using a Mac Mini M1.






locked Re: Control of an Arduino based TX using WSJT-X #Cat_RigControl

Reino Talarmo
 

Hi Peter,

Did you received my email to your gmail account? You can find my email at QRZ.com.

Interesting solution for FSK signals. Did you implemented the latest spectrum cleaning solution i.e. made smooth frequency changes or just made instance change from one frequency to another?

The current WSJT-X applied a Gaussian smooth frequency shift. You may have studied
https://www.physics.princeton.edu/pulsar/k1jt/FT4_FT8_QEX.pdf
I don't know whether the newer version of WSPR and FST4 applies the same principle.

I will be back on the "USB signal" generation later.

GN, Reino OH3mA


locked Re: How to get the operator's name in the log #logging

Bill, WB6JJJ
 

LOtW may not have the correct grid but the grid received from the other station in WSJT-X will override that data. At least it does when I am using JTAlert.
Bill
WB6JJJ

On Jul 25, 2022, at 12:45 PM, Roger <groups@...> wrote:

On 25/07/2022 16:40, Web - KC4WEB wrote:
I use WSJT-X with Ham Radio Deluxe (HRD). WSJT-X sends the log record to HRD and HRD updates the record with the name, locator and other data that it retrieves from QRZ.com (subscription). Good luck.
How do you know that QRZ has the correct up to date locator? Does HRD overside the locator received over the air?

73
Roger
GW4HZA





locked Audio Devices Not Showing #WSJTX_config #linux

Harold K7ILO
 

#Ubuntu 18.04 and WSJT-X 2.5.4

Hello all.

So I decided to move back down to Ubuntu 18.04 and just finished installing WSJT-X directly from source and there are no audio devices listed.
I do see them via the Pulse Audio Volume Control app but nothing in WSJT-X drop downs.
Any ideas?

Thanks all

Harold
K7ILO


locked Re: Problem CAT and frequency #Cat_RigControl

Helge Juch, DL3SDN
 

Believe it, or not.
I was in VFO mode. But I switched to Memory mode and back to VFO mode - and it works. But I do not understand.
Thanks for all the suggestions here in this group.
I'm happy again.

73 de Helge, DL3SDN


locked Re: How to get the operator's name in the log #logging

Roger
 

On 25/07/2022 16:40, Web - KC4WEB wrote:
I use WSJT-X with Ham Radio Deluxe (HRD). WSJT-X sends the log record to HRD and HRD updates the record with the name, locator and other data that it retrieves from QRZ.com (subscription). Good luck.
How do you know that QRZ has the correct up to date locator? Does HRD overside the locator received over the air?

73
Roger
GW4HZA


locked Re: ICOM 7300 Rig Control Error #FT8 #Cat_RigControl #Icom #macOS

Ed Radlo
 

I had a similar rig control problem with my Windows 10 - IC 7300 combination when using WSJT-X.  First it was working, then it wasn't working.
I think the basic problem is that the single USB cable from the rig to the computer is being asked to do too much -- CAT control plus the sending of the intelligence itself.
I was able to solve my problem by inserting a MicroKeyer III between the rig and the computer.
73,  Ed  AJ6V

On Sunday, July 24, 2022 at 10:06:28 PM PDT, Bruce N7XGR <n7xgr1@...> wrote:

Mitch, Did you try this?
Start here, Open Device Manager and click on the arrow for the
Human Interface Devices, double click on every one for their properties.
Click on the Power Management tab, if it is checked where it says,
Allow the computer to turn off this device to save power, then uncheck
it and click OK.
Next, Expand the Ports tree, again one by one double click on every one,
Power Management tab and uncheck Allow this computer and click OK.
Next, Expand the Universal Serial Bus Controllers tree and again double
click
on every one, Power tab, uncheck and click OK.
On the Desktop, right click and select Personalize, Click on Change power
settings (Screen Saver)
next window, click on Change plan settings, next window, Change advanced
power settings.
Next window click on, Change settings that are currently unavailable, click
the plus sign
at USB settings, expand USB selective suspend settings, click on settings,
Select Disabled, click OK.  If there are any HDMI settings then make sure
that there is
no setting to put the HDMI port to sleep.
Report results.

Bruce  N7XGR

On Sun, Jul 24, 2022 at 4:24 PM <mitch@...> wrote:

Reino,
Thanks for the response!  This happens whether I am transmitting or
receiving.  I can put it back into a usable state and leave it, come back
later, and it has the error.  I guess it could be the USB cable itself,
although unlikely.  It has operated flawlessly for months without issue.  I
even moved the USB cable away from transmission lines, but like it said it
can have the problem without transmitting.






locked Re: Control of an Arduino based TX using WSJT-X #Cat_RigControl

Jim Brown
 

On 7/24/2022 4:11 PM, Peter E wrote:
it is customary to run transmissions on the low bands all night
To TRANSMIT all night? In my part of the world, that would be illegal if the control operator was not awake and present. To RECEIVE all night is quite common.

73, Jim K9YC


locked Re: ICOM 7300 Rig Control Error #FT8 #Cat_RigControl #Icom #macOS

mitch@...
 

Bruce,
I am using a Mac Mini M1.


locked Re: ICOM 7300 Rig Control Error #FT8 #Cat_RigControl #Icom #macOS

mitch@...
 

I'll check but this issue just started randomly a couple weeks ago.


locked Re: How to get the operator's name in the log #logging

Web - KC4WEB
 

I use WSJT-X with Ham Radio Deluxe (HRD). WSJT-X sends the log record to HRD and HRD updates the record with the name, locator and other data that it retrieves from QRZ.com (subscription). Good luck.


locked Re: Control of an Arduino based TX using WSJT-X #Cat_RigControl

Karza
 

Hi Peter,

...
I would like to be able to get WSJT-X to be able to send out a string of freq
changes when running FST-4, FT8 etc and use this to directly control the
Arduino and SI5351. Maybe this is not easily possible.
Are you familiar with the *code -programs of WSJT-X suite:
ft8code jt4code jt65code jt9code msk144code and q65code ?

These allow you to enter a message as a parameter and see the
generated bits and symbols.
For example: ./ft8code "CQ OH2GQC KP20" will generate this:

Message Decoded Err i3.n3
----------------------------------------------------------------------------------------------------
1. CQ OH2GQC KP20 CQ OH2GQC KP20 1. Standard msg

Source-encoded message, 77 bits:
00000000000000000000000000100101100100010010001111010000100100110001000000001

14-bit CRC:
11110001000100

83 Parity bits:
01100111100011010001110001110010101101001111100011111011000010100000000011011101101

Channel symbols (79 tones):
Sync Data Sync Data Sync
3140652 00000000112105524511153002705 3140652 315752314143661752

Perhaps, on the PC running WSJT-X, you could read the ALL.TXT file,
extract the required "plain text", call *code to get channel symbols and send those over
to Arduino using serial link. Arduino could then drive SI5351 accordingly.

There might be issues with timing if trying something like this though.

I don't know if this is even remotely what you are looking for.
If not, please forgive me for stepping in.

73's de Kari, oh2gqc


locked Re: Problem CAT and frequency #Cat_RigControl

Michael Black
 

Are you in VFO memory mode perhaps?
Mike W9MDB

On Monday, July 25, 2022 at 12:02:40 AM CDT, Helge Juch, DL3SDN <dl3sdn@...> wrote:

Am 24.07.22 um 15:24 schrieb Michael Black via groups.io:
Please place this file as described below
https://www.dropbox.com/s/t52ngcalsgnpm8m/wsjtx_log_config.ini?dl=0


      C:\Users\[username]\AppData\Local\WSJT-X
      The WSJT-X_Rigcontrol.log file will be in the same location
     
For Linux put it in
      ~/.config
      The WSJT-X_Rigcontrol.log file will be here:
      ~/.local/share/WSJT-X
     
Restart WSJT-X and duplicate the problem.
Shut down WSJT-X


Then send me the WSJT-X_RigControl.log file
Mike W9MDB


 
On Sunday, July 24, 2022 at 08:15:40 AM CDT, <dl3sdn@...> wrote:

 
Hi Guys,
this is my first post here and I hope you will forgive me if I did something wrong.

I'm using wsjt-x v.2-1-2 and former versions for a long time and it works great.
My OS is Linux Mint 20.3.
Few days ago I updated to wsjt-x 2.5.4 and suddenly a problem occured. Everything works fine, but the Box for the Frequency shows 5,77005 on red background and the menu for the predefined frequencies shows "Out of Band" on red background. After cklicking on this menu and clicking on a desired frequency my transceiver (yaesu ft-1000mp") switches correct to this frequency. After one second (this is predefiend in "Settings/Radio/PollInterval") the display changes back to 5,77005. No matter which frequency I choose, the TRX switches to this frequency and after one second the display shows the 5,77005.

I removed the 2.5.4 and reinstalled the 2.1.2 and everything worked fine.
I installed the 2.6.0rc2 and found the same problem again.

I think the problem is in CAT in the direction TRX -> PC. But I have no idea how to fix it.

I look forward to any helpful answer

vy 73 de Helge, DL3SDN


Hi Mike,

I did, as you told me.

After starting wsjt-x 2.6.0rc2 I switched to qrg 10136000. Then I shut
down wsjt-x and in the following is the logfile you asked for.

Thank you and 73 Helge, DL3SDN

---------------------------------------------------------------------------------------------------------

[2022-07-24 19:42:12.834738][00:00:00.000533][SYSLOG:info] Read logging
configuration file: /home/helge/.config/wsjtx_log_config.ini
[2022-07-24 19:42:12.834779][00:00:00.000574][SYSLOG:info] WSJT-X
v2.6.0-rc2  by K1JT et al. - Program startup
[2022-07-24 19:42:12.838683][00:00:00.004478][SYSLOG:info] locale:
language: German script: Latin country: Germany ui-languages: de-DE
[2022-07-24 19:42:12.851815][00:00:00.017609][SYSLOG:info] shmem size:
48275260
[2022-07-24 19:42:12.885179][00:00:00.050976][RIGCTRL:info] Hamlib
version: Hamlib 4.5~git Sat Jul 16 15:53:03 2022 +0000 SHA=cc7c59
[2022-07-24 19:42:12.885446][00:00:00.051241][RIGCTRL:debug]
initrigs4_dummy: _init called
[2022-07-24 19:42:12.885482][00:00:00.051277][RIGCTRL:debug] yaesu:
initrigs4_yaesu called
[2022-07-24 19:42:12.885538][00:00:00.051333][RIGCTRL:debug]
initrigs4_icom: _init called
[2022-07-24 19:42:12.885568][00:00:00.051362][RIGCTRL:debug]
initrigs4_icmarine: _init called
[2022-07-24 19:42:12.885585][00:00:00.051379][RIGCTRL:debug]
initrigs4_pcr: init called
[2022-07-24 19:42:12.885601][00:00:00.051396][RIGCTRL:debug]
initrigs4_aor: _init called
[2022-07-24 19:42:12.885615][00:00:00.051410][RIGCTRL:debug]
initrigs4_jrc: _init called
[2022-07-24 19:42:12.885628][00:00:00.051423][RIGCTRL:debug]
initrigs4_uniden: _init called
[2022-07-24 19:42:12.885647][00:00:00.051442][RIGCTRL:debug]
initrigs4_drake: _init called
[2022-07-24 19:42:12.885660][00:00:00.051454][RIGCTRL:debug]
initrigs4_lowe: _init called
[2022-07-24 19:42:12.885672][00:00:00.051467][RIGCTRL:debug]
initrigs4_racal: _init called
[2022-07-24 19:42:12.885685][00:00:00.051480][RIGCTRL:debug]
initrigs4_wj: _init called
[2022-07-24 19:42:12.885699][00:00:00.051493][RIGCTRL:debug]
initrigs4_skanti: _init called
[2022-07-24 19:42:12.885711][00:00:00.051506][RIGCTRL:debug]
initrigs4_winradio: _init called
[2022-07-24 19:42:12.885726][00:00:00.051521][RIGCTRL:debug]
initrigs4_tentec: _init called
[2022-07-24 19:42:12.885742][00:00:00.051536][RIGCTRL:debug]
initrigs4_kachina: _init called
[2022-07-24 19:42:12.885755][00:00:00.051550][RIGCTRL:debug]
initrigs4_tapr: _init called
[2022-07-24 19:42:12.885773][00:00:00.051567][RIGCTRL:trace]
initrigs4_flexradio called
[2022-07-24 19:42:12.885786][00:00:00.051581][RIGCTRL:debug]
initrigs4_rft: _init called
[2022-07-24 19:42:12.885799][00:00:00.051595][RIGCTRL:debug]
initrigs4_kit: _init called
[2022-07-24 19:42:12.885819][00:00:00.051614][RIGCTRL:debug]
initrigs4_tuner: _init called
[2022-07-24 19:42:12.885834][00:00:00.051629][RIGCTRL:debug]
initrigs4_rs: _init called
[2022-07-24 19:42:12.885847][00:00:00.051641][RIGCTRL:debug]
initrigs4_prm80: _init called
[2022-07-24 19:42:12.885861][00:00:00.051655][RIGCTRL:debug]
initrigs4_dorji: _init called
[2022-07-24 19:42:12.885874][00:00:00.051669][RIGCTRL:debug]
initrigs4_barrett: _init called
[2022-07-24 19:42:12.885889][00:00:00.051684][RIGCTRL:debug]
initrigs4_barrett: _init back from rig_register
[2022-07-24 19:42:12.885904][00:00:00.051699][RIGCTRL:debug]
initrigs4_elad called
[2022-07-24 19:42:12.885918][00:00:00.051712][RIGCTRL:debug]
initrigs4_codan: _init called
[2022-07-24 19:42:12.885931][00:00:00.051727][RIGCTRL:debug]
initrigs4_codan: _init back from rig_register
[2022-07-24 19:42:12.885946][00:00:00.051740][RIGCTRL:debug]
initrigs4_gomspace: _init called
[2022-07-24 19:42:14.280014][00:00:01.445809][RIGCTRL:trace]
rig_check_rig_caps: p1=0x555ad052a0e0, p2=0x555ad0530660,
rig_model=0x555ad052a0e0, macro_name=0x555ad0530660
[2022-07-24 19:42:14.280084][00:00:01.445888][RIGCTRL:debug]
rig_init(555): 0x555ad2223ddc rs->comm_state==0?=0
[2022-07-24 19:42:14.280111][00:00:01.445910][RIGCTRL:debug] rig_init:
rig has VFO_A
[2022-07-24 19:42:14.280130][00:00:01.445925][RIGCTRL:debug] rig_init:
rig has VFO_B
[2022-07-24 19:42:14.280154][00:00:01.445949][RIGCTRL:debug]
1:ft1000mp.c(743):ft1000mp_init entered
[2022-07-24 19:42:14.280177][00:00:01.445983][RIGCTRL:debug]
1:ft1000mp.c(759):ft1000mp_init returning(0)
[2022-07-24 19:42:14.280226][00:00:01.446021][RIGCTRL:debug]
rig_token_lookup called for rig_pathname
[2022-07-24 19:42:14.280500][00:00:01.446296][RIGCTRL:debug]
rig_confparam_lookup called for rig_pathname
[2022-07-24 19:42:14.280514][00:00:01.446310][RIGCTRL:debug]
rig_set_conf called
[2022-07-24 19:42:14.280526][00:00:01.446321][RIGCTRL:debug]
rig_confparam_lookup called for 1073741834
[2022-07-24 19:42:14.280537][00:00:01.446341][RIGCTRL:debug]
rig_set_conf: rig_pathname='/dev/ttyS0'
[2022-07-24 19:42:14.280562][00:00:01.446358][RIGCTRL:debug]
rig_token_lookup called for serial_speed
[2022-07-24 19:42:14.280572][00:00:01.446370][RIGCTRL:debug]
rig_confparam_lookup called for serial_speed
[2022-07-24 19:42:14.280593][00:00:01.446388][RIGCTRL:debug]
rig_set_conf called
[2022-07-24 19:42:14.280602][00:00:01.446401][RIGCTRL:debug]
rig_confparam_lookup called for 1073741844
[2022-07-24 19:42:14.280622][00:00:01.446420][RIGCTRL:debug]
rig_set_conf: serial_speed='4800'
[2022-07-24 19:42:14.280643][00:00:01.446439][RIGCTRL:debug]
rig_token_lookup called for no_xchg
[2022-07-24 19:42:14.280653][00:00:01.446452][RIGCTRL:debug]
rig_confparam_lookup called for no_xchg
[2022-07-24 19:42:14.283899][00:00:01.449694][RIGCTRL:trace] #: 1
[2022-07-24 19:42:14.283939][00:00:01.449734][RIGCTRL:trace] shutdown
[2022-07-24 19:42:14.283944][00:00:01.449739][RIGCTRL:trace] force
signal: false
[2022-07-24 19:42:14.283950][00:00:01.449745][RIGCTRL:trace] startup
[2022-07-24 19:42:14.283956][00:00:01.449750][RIGCTRL:trace] starting:
Yaesu: FT-1000MP
[2022-07-24 19:42:14.283977][00:00:01.449771][RIGCTRL:debug]
1:rig.c(805):rig_open entered
[2022-07-24 19:42:14.284010][00:00:01.449805][RIGCTRL:trace]
rig_settings_get_path: path=/home/helge/.config/hamlib_settings
[2022-07-24 19:42:14.284044][00:00:01.449838][RIGCTRL:debug]
rig_settings_load_all: settings_file
(/home/helge/.config/hamlib_settings): No such file or directory
[2022-07-24 19:42:14.284061][00:00:01.449855][RIGCTRL:debug] rig_open:
cwd=/home/helge
[2022-07-24 19:42:14.284077][00:00:01.449872][RIGCTRL:debug] rig_open:
/home/helge/(null) does not exist
[2022-07-24 19:42:14.284088][00:00:01.449883][RIGCTRL:debug]
serial_open: /dev/ttyS0
[2022-07-24 19:42:14.284241][00:00:01.450036][RIGCTRL:trace]
serial_setup: tcgetattr
[2022-07-24 19:42:14.284254][00:00:01.450049][RIGCTRL:trace]
serial_setup: cfmakeraw
[2022-07-24 19:42:14.284267][00:00:01.450061][RIGCTRL:trace]
serial_setup: cfsetispeed=4800,0x000c
[2022-07-24 19:42:14.284276][00:00:01.450070][RIGCTRL:trace]
serial_setup: cfsetospeed=4800,0x000c
[2022-07-24 19:42:14.284288][00:00:01.450083][RIGCTRL:trace]
serial_setup: data_bits=8
[2022-07-24 19:42:14.284299][00:00:01.450094][RIGCTRL:trace]
serial_setup: parity=0
[2022-07-24 19:42:14.284307][00:00:01.450102][RIGCTRL:trace]
serial_setup: Handshake=None
[2022-07-24 19:42:14.284317][00:00:01.450112][RIGCTRL:trace]
serial_setup: tcsetattr TCSANOW
[2022-07-24 19:42:14.284357][00:00:01.450152][RIGCTRL:trace]
read_string_generic called, rxmax=4095 direct=1
[2022-07-24 19:42:14.335549][00:00:01.501348][RIGCTRL:debug]
2:rig.c(7161):async_data_handler_start entered
[2022-07-24 19:42:14.335598][00:00:01.501406][RIGCTRL:trace]
async_data_handler_start: async data support disabled
[2022-07-24 19:42:14.335632][00:00:01.501427][RIGCTRL:debug]
2:rig.c(7166):async_data_handler_start returning(0)
[2022-07-24 19:42:14.335655][00:00:01.501450][RIGCTRL:debug]
rig.c(254):add_opened_rig returning2(0)
[2022-07-24 19:42:14.335683][00:00:01.501482][RIGCTRL:debug] rig_open:
0x555ad2223ddc rs->comm_state==1?=1
[2022-07-24 19:42:14.335705][00:00:01.501504][RIGCTRL:debug]
2:ft1000mp.c(795):ft1000mp_open entered
[2022-07-24 19:42:14.335721][00:00:01.501517][RIGCTRL:trace]
ft1000mp_open: rig_open: write_delay = 5 msec
[2022-07-24 19:42:14.335734][00:00:01.501529][RIGCTRL:trace]
ft1000mp_open: rig_open: post_write_delay = 5 msec
[2022-07-24 19:42:14.335744][00:00:01.501543][RIGCTRL:trace]
ft1000mp_open: read pacing = 0
[2022-07-24 19:42:14.361105][00:00:01.526901][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.361144][00:00:01.526940][RIGCTRL:trace] 0000    00
00 00 00 0e                                      .....
[2022-07-24 19:42:14.366225][00:00:01.532020][RIGCTRL:debug]
3:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:14.366262][00:00:01.532058][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.366282][00:00:01.532077][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.391683][00:00:01.557480][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.391728][00:00:01.557585][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:14.396904][00:00:01.562702][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.396955][00:00:01.562749][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.410723][00:00:01.576519][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:14.410822][00:00:01.576618][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:14.410848][00:00:01.576642][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:14.410864][00:00:01.576663][RIGCTRL:trace]
ft1000mp_get_vfo: no get_vfo, defaulting to VFOA
[2022-07-24 19:42:14.410884][00:00:01.576682][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 8 10
[2022-07-24 19:42:14.410906][00:00:01.576712][RIGCTRL:debug]
3:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:14.410955][00:00:01.576750][RIGCTRL:debug]
2:ft1000mp.c(820):ft1000mp_open returning(0)
[2022-07-24 19:42:14.410965][00:00:01.576761][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1260)
trace
[2022-07-24 19:42:14.410983][00:00:01.576778][RIGCTRL:debug]
2:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:14.410994][00:00:01.576793][RIGCTRL:trace]
rig_get_vfo: cache check age=1000000ms
[2022-07-24 19:42:14.411017][00:00:01.576819][RIGCTRL:trace]
rig_get_vfo: cache miss age=1000000ms
[2022-07-24 19:42:14.411060][00:00:01.576856][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:14.411072][00:00:01.576875][RIGCTRL:debug]
3:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:14.411097][00:00:01.576892][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.411112][00:00:01.576911][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.436498][00:00:01.602304][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.436579][00:00:01.602375][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:14.441680][00:00:01.607477][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.441724][00:00:01.607520][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.455244][00:00:01.621041][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:14.455307][00:00:01.621102][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:14.455334][00:00:01.621137][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:14.455365][00:00:01.621159][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 8 10
[2022-07-24 19:42:14.455379][00:00:01.621185][RIGCTRL:debug]
3:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:14.455438][00:00:01.621237][RIGCTRL:trace]
2:rig_get_vfo: elapsed=44ms
[2022-07-24 19:42:14.455471][00:00:01.621283][RIGCTRL:debug]
2:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:14.455506][00:00:01.621305][RIGCTRL:debug]
rig_get_freq(1926) called vfo=VFOA
[2022-07-24 19:42:14.455542][00:00:01.621348][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=VFOA, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.455571][00:00:01.621370][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=VFOA, curr_vfo=VFOA
[2022-07-24 19:42:14.455613][00:00:01.621409][RIGCTRL:trace]
rig_get_freq: cache miss age=1000000ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:14.455627][00:00:01.621426][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:14.455644][00:00:01.621439][RIGCTRL:debug]
2:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:14.455656][00:00:01.621455][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:14.455681][00:00:01.621476][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.455694][00:00:01.621493][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.481067][00:00:01.646892][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.481141][00:00:01.646935][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:14.486235][00:00:01.652042][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.486288][00:00:01.652083][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.555927][00:00:01.721725][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:14.555977][00:00:01.721771][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:14.555991][00:00:01.721793][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:14.556013][00:00:01.721812][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:14.556045][00:00:01.721844][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:14.556088][00:00:01.721884][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:14.556115][00:00:01.721910][RIGCTRL:debug]
2:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:14.556171][00:00:01.721967][RIGCTRL:trace]
1:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:14.556196][00:00:01.721991][RIGCTRL:debug]
rig_get_freq(1926) called vfo=VFOB
[2022-07-24 19:42:14.556218][00:00:01.722021][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=VFOB, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.556243][00:00:01.722038][RIGCTRL:trace] vfo_fixup:
final vfo=VFOB
[2022-07-24 19:42:14.556256][00:00:01.722050][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=VFOB, curr_vfo=VFOA
[2022-07-24 19:42:14.556293][00:00:01.722091][RIGCTRL:trace]
rig_get_freq: cache miss age=1000000ms, cached_vfo=VFOB, asked_vfo=VFOB
[2022-07-24 19:42:14.556310][00:00:01.722105][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:14.556322][00:00:01.722117][RIGCTRL:debug]
2:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:14.556335][00:00:01.722129][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:14.556347][00:00:01.722143][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.556361][00:00:01.722160][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.581728][00:00:01.747524][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.581773][00:00:01.747568][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:14.586853][00:00:01.752659][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.586901][00:00:01.752696][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.656462][00:00:01.822261][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:14.656525][00:00:01.822321][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:14.656554][00:00:01.822349][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:14.656569][00:00:01.822373][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:14.656605][00:00:01.822400][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:14.656649][00:00:01.822444][RIGCTRL:trace]
ft1000mp_get_freq: freq = 28074000 Hz for VFO [2]
[2022-07-24 19:42:14.656662][00:00:01.822457][RIGCTRL:debug]
2:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:14.656730][00:00:01.822526][RIGCTRL:trace]
1:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:14.656744][00:00:01.822538][RIGCTRL:debug]
2:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:14.656763][00:00:01.822562][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=VFOA, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.656797][00:00:01.822593][RIGCTRL:trace]
rig_get_mode: VFOA cache check age=201ms
[2022-07-24 19:42:14.656819][00:00:01.822614][RIGCTRL:trace]
rig_get_mode: cache miss age mode=201ms, width=201ms
[2022-07-24 19:42:14.656838][00:00:01.822644][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:14.656862][00:00:01.822657][RIGCTRL:debug]
3:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:14.656874][00:00:01.822673][RIGCTRL:debug]
4:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:14.656889][00:00:01.822688][RIGCTRL:debug]
5:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.656921][00:00:01.822726][RIGCTRL:debug]
6:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.685457][00:00:01.851267][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.685525][00:00:01.851321][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:14.690687][00:00:01.856484][RIGCTRL:debug]
6:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.690751][00:00:01.856546][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.759592][00:00:01.925392][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:14.759657][00:00:01.925483][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:14.759715][00:00:01.925510][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:14.759734][00:00:01.925528][RIGCTRL:debug]
5:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:14.759747][00:00:01.925541][RIGCTRL:debug]
4:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:14.759758][00:00:01.925559][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:14.759785][00:00:01.925590][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:14.759811][00:00:01.925613][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:14.759836][00:00:01.925630][RIGCTRL:debug]
3:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:14.759852][00:00:01.925647][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:14.759883][00:00:01.925679][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:14.759910][00:00:01.925705][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:14.759931][00:00:01.925726][RIGCTRL:debug]
3:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:14.759942][00:00:01.925736][RIGCTRL:debug]
3:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:14.759953][00:00:01.925752][RIGCTRL:debug]
3:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:14.759975][00:00:01.925769][RIGCTRL:debug]
3:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:14.760003][00:00:01.925805][RIGCTRL:debug]
3:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:14.760040][00:00:01.925835][RIGCTRL:trace]
2:rig_get_mode: elapsed=103ms
[2022-07-24 19:42:14.760054][00:00:01.925850][RIGCTRL:debug]
2:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:14.760071][00:00:01.925869][RIGCTRL:debug]
2:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:14.760093][00:00:01.925895][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=VFOB, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.760116][00:00:01.925915][RIGCTRL:trace] vfo_fixup:
final vfo=VFOB
[2022-07-24 19:42:14.760152][00:00:01.925947][RIGCTRL:trace]
rig_get_mode: VFOB cache check age=203ms
[2022-07-24 19:42:14.760173][00:00:01.925968][RIGCTRL:trace]
rig_get_mode: cache miss age mode=203ms, width=203ms
[2022-07-24 19:42:14.760191][00:00:01.925987][RIGCTRL:trace]
rig_get_mode(2385): vfo=VFOB, curr_vfo=VFOA
[2022-07-24 19:42:14.760202][00:00:01.926001][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2387)
trace
[2022-07-24 19:42:14.760222][00:00:01.926021][RIGCTRL:debug]
3:ft1000mp.c(1188):ft1000mp_set_vfo entered
[2022-07-24 19:42:14.760241][00:00:01.926040][RIGCTRL:trace]
ft1000mp_set_vfo: called VFOB
[2022-07-24 19:42:14.760260][00:00:01.926065][RIGCTRL:debug]
3:ft1000mp.c(1238):ft1000mp_set_vfo returning(0)
[2022-07-24 19:42:14.760296][00:00:01.926090][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2397)
trace
[2022-07-24 19:42:14.760312][00:00:01.926110][RIGCTRL:debug]
3:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:14.760332][00:00:01.926127][RIGCTRL:debug]
4:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:14.760348][00:00:01.926147][RIGCTRL:debug]
5:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.760365][00:00:01.926159][RIGCTRL:debug]
6:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.785738][00:00:01.951536][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.785788][00:00:01.951582][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:14.790890][00:00:01.956685][RIGCTRL:debug]
6:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.790931][00:00:01.956743][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.860497][00:00:02.026293][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:14.860548][00:00:02.026364][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:14.860591][00:00:02.026385][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:14.860607][00:00:02.026402][RIGCTRL:debug]
5:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:14.860641][00:00:02.026443][RIGCTRL:debug]
4:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:14.860666][00:00:02.026465][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 2 (before)
[2022-07-24 19:42:14.860683][00:00:02.026478][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 2 (after)
[2022-07-24 19:42:14.860696][00:00:02.026490][RIGCTRL:trace]
ft1000mp_get_mode: mode = CWR
[2022-07-24 19:42:14.860709][00:00:02.026503][RIGCTRL:debug]
3:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:14.860721][00:00:02.026516][RIGCTRL:debug]
3:ft1000mp.c(1188):ft1000mp_set_vfo entered
[2022-07-24 19:42:14.860733][00:00:02.026528][RIGCTRL:trace]
ft1000mp_set_vfo: called VFOA
[2022-07-24 19:42:14.860746][00:00:02.026540][RIGCTRL:debug]
3:ft1000mp.c(1238):ft1000mp_set_vfo returning(0)
[2022-07-24 19:42:14.860757][00:00:02.026552][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:14.860770][00:00:02.026569][RIGCTRL:debug]
3:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:14.860788][00:00:02.026582][RIGCTRL:debug]
3:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:14.860800][00:00:02.026594][RIGCTRL:debug]
3:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:14.860813][00:00:02.026607][RIGCTRL:debug]
3:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:14.860848][00:00:02.026647][RIGCTRL:debug]
3:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:14.860878][00:00:02.026673][RIGCTRL:trace]
2:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:14.860891][00:00:02.026697][RIGCTRL:debug]
2:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:14.860921][00:00:02.026717][RIGCTRL:debug]
1:rig.c(1330):rig_open returning(0)
[2022-07-24 19:42:14.860936][00:00:02.026731][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:14.860947][00:00:02.026745][RIGCTRL:trace]
rig_get_vfo: cache check age=405ms
[2022-07-24 19:42:14.860961][00:00:02.026760][RIGCTRL:trace]
rig_get_vfo: cache hit age=405ms
[2022-07-24 19:42:14.860980][00:00:02.026782][RIGCTRL:trace]
1:rig_get_vfo: elapsed=0ms
[2022-07-24 19:42:14.861007][00:00:02.026801][RIGCTRL:debug]
1:rig.c(2795):rig_get_vfo returning(0)
[2022-07-24 19:42:14.861026][00:00:02.026828][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:14.861050][00:00:02.026845][RIGCTRL:trace]
rig_get_vfo: cache check age=405ms
[2022-07-24 19:42:14.861066][00:00:02.026861][RIGCTRL:trace]
rig_get_vfo: cache hit age=405ms
[2022-07-24 19:42:14.861084][00:00:02.026880][RIGCTRL:trace]
1:rig_get_vfo: elapsed=0ms
[2022-07-24 19:42:14.861098][00:00:02.026894][RIGCTRL:debug]
1:rig.c(2795):rig_get_vfo returning(0)
[2022-07-24 19:42:14.861108][00:00:02.026910][RIGCTRL:trace] rig_get_vfo
current VFO=VFOA
[2022-07-24 19:42:14.861129][00:00:02.026924][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:14.861143][00:00:02.026945][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.861165][00:00:02.026964][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:14.861201][00:00:02.026995][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=101ms
[2022-07-24 19:42:14.861220][00:00:02.027015][RIGCTRL:trace]
rig_get_mode: cache hit age mode=101ms, width=101ms
[2022-07-24 19:42:14.861237][00:00:02.027032][RIGCTRL:trace]
1:rig_get_mode: elapsed=0ms
[2022-07-24 19:42:14.861249][00:00:02.027053][RIGCTRL:debug]
1:rig.c(2356):rig_get_mode returning(0)
[2022-07-24 19:42:14.861268][00:00:02.027062][RIGCTRL:trace]
rig_get_mode current mode=AM bw=2400
[2022-07-24 19:42:14.861278][00:00:02.027073][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:14.861295][00:00:02.027089][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:14.861321][00:00:02.027116][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.861333][00:00:02.027128][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:14.861354][00:00:02.027149][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:14.861394][00:00:02.027199][RIGCTRL:trace]
rig_get_freq: VFOA cache hit age=305ms, freq=5577005
[2022-07-24 19:42:14.861429][00:00:02.027234][RIGCTRL:trace]
0:rig_get_freq: elapsed=0ms
[2022-07-24 19:42:14.861471][00:00:02.027266][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:14.861493][00:00:02.027289][RIGCTRL:trace]
rig_get_vfo: cache check age=406ms
[2022-07-24 19:42:14.861506][00:00:02.027305][RIGCTRL:trace]
rig_get_vfo: cache hit age=406ms
[2022-07-24 19:42:14.861550][00:00:02.027352][RIGCTRL:trace]
1:rig_get_vfo: elapsed=0ms
[2022-07-24 19:42:14.861574][00:00:02.027369][RIGCTRL:debug]
1:rig.c(2795):rig_get_vfo returning(0)
[2022-07-24 19:42:14.861582][00:00:02.027384][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:14.861614][00:00:02.027422][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:14.861641][00:00:02.027440][RIGCTRL:trace]
rig_get_split_vfo: cache check age=1000000ms
[2022-07-24 19:42:14.861662][00:00:02.027457][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=1000000ms
[2022-07-24 19:42:14.861672][00:00:02.027469][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:14.861710][00:00:02.027505][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:14.861722][00:00:02.027517][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:14.861732][00:00:02.027531][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:14.887102][00:00:02.052898][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:14.887150][00:00:02.052946][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:14.892232][00:00:02.058055][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:14.892300][00:00:02.058105][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:14.906105][00:00:02.071903][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:14.906156][00:00:02.071952][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:14.906173][00:00:02.071968][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:14.906200][00:00:02.071996][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:14.906212][00:00:02.072010][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:14.906247][00:00:02.072041][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:14.906285][00:00:02.072079][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:14.906292][00:00:02.072095][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:14.906893][00:00:02.072688][RIGCTRL:trace] state: false
[2022-07-24 19:42:14.906918][00:00:02.072721][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:14.906957][00:00:02.072752][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.906988][00:00:02.072783][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:14.906998][00:00:02.072793][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:14.907038][00:00:02.072847][RIGCTRL:trace]
rig_get_freq: VFOA cache hit age=350ms, freq=5577005
[2022-07-24 19:42:14.907077][00:00:02.072871][RIGCTRL:trace]
0:rig_get_freq: elapsed=0ms
[2022-07-24 19:42:14.907095][00:00:02.072889][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:14.907109][00:00:02.072908][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:14.907129][00:00:02.072924][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:14.907144][00:00:02.072940][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:14.907156][00:00:02.072951][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:14.907190][00:00:02.072984][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=147ms
[2022-07-24 19:42:14.907220][00:00:02.073015][RIGCTRL:trace]
rig_get_mode: cache hit age mode=147ms, width=147ms
[2022-07-24 19:42:14.907241][00:00:02.073040][RIGCTRL:trace]
1:rig_get_mode: elapsed=0ms
[2022-07-24 19:42:14.907260][00:00:02.073062][RIGCTRL:debug]
1:rig.c(2356):rig_get_mode returning(0)
[2022-07-24 19:42:14.907281][00:00:02.073076][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:14.907290][00:00:02.073084][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:14.907296][00:00:02.073092][RIGCTRL:trace] finished
start Transceiver::TransceiverState(online: yes Frequency {5577005Hz,
0Hz} Mode: AM; SPLIT: off; PTT: off) reversed=false resolution=0
[2022-07-24 19:42:14.907330][00:00:02.073126][RIGCTRL:trace] force
signal: true
[2022-07-24 19:42:15.913485][00:00:03.079282][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:15.913542][00:00:03.079337][RIGCTRL:trace]
rig_get_vfo: cache check age=1458ms
[2022-07-24 19:42:15.913561][00:00:03.079355][RIGCTRL:trace]
rig_get_vfo: cache miss age=1458ms
[2022-07-24 19:42:15.913577][00:00:03.079372][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:15.913597][00:00:03.079392][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:15.913619][00:00:03.079413][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:15.913636][00:00:03.079430][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:15.939098][00:00:03.104894][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:15.939146][00:00:03.104941][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:15.944269][00:00:03.110065][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:15.944310][00:00:03.110106][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:15.957791][00:00:03.123588][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:15.957839][00:00:03.123634][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:15.957868][00:00:03.123662][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:15.957892][00:00:03.123687][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:15.957915][00:00:03.123710][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:15.957949][00:00:03.123744][RIGCTRL:trace]
1:rig_get_vfo: elapsed=44ms
[2022-07-24 19:42:15.957978][00:00:03.123772][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:15.957995][00:00:03.123789][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:15.958020][00:00:03.123815][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:15.958041][00:00:03.123835][RIGCTRL:trace]
rig_get_split_vfo: cache check age=1051ms
[2022-07-24 19:42:15.958064][00:00:03.123859][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=1051ms
[2022-07-24 19:42:15.958084][00:00:03.123879][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:15.958106][00:00:03.123901][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:15.958133][00:00:03.123927][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:15.958158][00:00:03.123953][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:15.983593][00:00:03.149389][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:15.983639][00:00:03.149434][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:15.988758][00:00:03.154554][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:15.988801][00:00:03.154596][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:16.002235][00:00:03.168031][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:16.002288][00:00:03.168083][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:16.002315][00:00:03.168110][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:16.002342][00:00:03.168137][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:16.002365][00:00:03.168160][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:16.002398][00:00:03.168192][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=44ms
[2022-07-24 19:42:16.002427][00:00:03.168222][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:16.002448][00:00:03.168243][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:16.002468][00:00:03.168263][RIGCTRL:trace] state: false
[2022-07-24 19:42:16.002488][00:00:03.168282][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:16.002533][00:00:03.168328][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:16.002557][00:00:03.168351][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:16.002579][00:00:03.168374][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:16.002655][00:00:03.168449][RIGCTRL:trace]
rig_get_freq: cache miss age=1446ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:16.002685][00:00:03.168480][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:16.002708][00:00:03.168502][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:16.002728][00:00:03.168523][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:16.002750][00:00:03.168544][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:16.002771][00:00:03.168566][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:16.028160][00:00:03.193958][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:16.028209][00:00:03.194004][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:16.033325][00:00:03.199120][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:16.033356][00:00:03.199151][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:16.102862][00:00:03.268658][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:16.102912][00:00:03.268707][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:16.102938][00:00:03.268733][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:16.102967][00:00:03.268762][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:16.102991][00:00:03.268786][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:16.103025][00:00:03.268820][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:16.103055][00:00:03.268850][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:16.103171][00:00:03.268966][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:16.103193][00:00:03.268988][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:16.103209][00:00:03.269004][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:16.103226][00:00:03.269020][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:16.103251][00:00:03.269046][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:16.103270][00:00:03.269065][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:16.103328][00:00:03.269123][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=1343ms
[2022-07-24 19:42:16.103375][00:00:03.269169][RIGCTRL:trace]
rig_get_mode: cache miss age mode=1343ms, width=1343ms
[2022-07-24 19:42:16.103396][00:00:03.269190][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:16.103419][00:00:03.269214][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:16.103439][00:00:03.269234][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:16.103461][00:00:03.269255][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:16.103493][00:00:03.269288][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:16.103519][00:00:03.269314][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:16.128967][00:00:03.294764][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:16.129013][00:00:03.294808][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:16.134133][00:00:03.299929][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:16.134174][00:00:03.299969][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:16.203520][00:00:03.369318][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:16.203586][00:00:03.369382][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:16.203615][00:00:03.369410][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:16.203642][00:00:03.369437][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:16.203684][00:00:03.369479][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:16.203708][00:00:03.369503][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:16.203728][00:00:03.369523][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:16.203749][00:00:03.369544][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:16.203781][00:00:03.369576][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:16.203806][00:00:03.369601][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:16.203853][00:00:03.369648][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:16.203895][00:00:03.369689][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:16.203917][00:00:03.369712][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:16.203940][00:00:03.369735][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:16.203962][00:00:03.369757][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:16.203983][00:00:03.369778][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:16.204047][00:00:03.369841][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:16.204096][00:00:03.369891][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:16.204121][00:00:03.369916][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:16.204138][00:00:03.369933][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:16.204153][00:00:03.369948][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:16.912975][00:00:04.078772][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:16.913037][00:00:04.078831][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:16.913056][00:00:04.078851][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:16.913078][00:00:04.078873][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:16.913103][00:00:04.078898][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:16.913126][00:00:04.078921][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:16.913148][00:00:04.078943][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:16.938634][00:00:04.104431][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:16.938680][00:00:04.104476][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:16.943790][00:00:04.109587][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:16.943830][00:00:04.109624][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:16.957629][00:00:04.123425][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:16.957676][00:00:04.123471][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:16.957704][00:00:04.123499][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:16.957729][00:00:04.123523][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:16.957752][00:00:04.123546][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:16.957790][00:00:04.123585][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:16.957818][00:00:04.123613][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:16.957835][00:00:04.123630][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:16.957861][00:00:04.123656][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:16.957887][00:00:04.123682][RIGCTRL:trace]
rig_get_split_vfo: cache check age=955ms
[2022-07-24 19:42:16.957910][00:00:04.123705][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=955ms
[2022-07-24 19:42:16.957931][00:00:04.123726][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:16.957953][00:00:04.123747][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:16.957973][00:00:04.123768][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:16.957994][00:00:04.123789][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:16.983442][00:00:04.149238][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:16.983486][00:00:04.149281][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:16.988608][00:00:04.154404][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:16.988650][00:00:04.154445][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:17.002406][00:00:04.168203][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:17.002456][00:00:04.168252][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:17.002485][00:00:04.168280][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:17.002510][00:00:04.168305][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:17.002532][00:00:04.168327][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:17.002562][00:00:04.168357][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:17.002590][00:00:04.168385][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:17.002612][00:00:04.168406][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:17.002632][00:00:04.168427][RIGCTRL:trace] state: false
[2022-07-24 19:42:17.002654][00:00:04.168449][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:17.002703][00:00:04.168498][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:17.002727][00:00:04.168521][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:17.002747][00:00:04.168541][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:17.002824][00:00:04.168619][RIGCTRL:trace]
rig_get_freq: cache miss age=899ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:17.002851][00:00:04.168645][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:17.002876][00:00:04.168671][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:17.002898][00:00:04.168693][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:17.002924][00:00:04.168722][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:17.002952][00:00:04.168747][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:17.028376][00:00:04.194174][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:17.028433][00:00:04.194228][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:17.033554][00:00:04.199350][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:17.033590][00:00:04.199385][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:17.102833][00:00:04.268629][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:17.102904][00:00:04.268699][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:17.102933][00:00:04.268728][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:17.102961][00:00:04.268756][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:17.102985][00:00:04.268780][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:17.103022][00:00:04.268817][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:17.103059][00:00:04.268854][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:17.103172][00:00:04.268967][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:17.103187][00:00:04.268981][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:17.103199][00:00:04.268994][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:17.103210][00:00:04.269005][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:17.103227][00:00:04.269021][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:17.103251][00:00:04.269045][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:17.103311][00:00:04.269106][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=899ms
[2022-07-24 19:42:17.103358][00:00:04.269153][RIGCTRL:trace]
rig_get_mode: cache miss age mode=899ms, width=899ms
[2022-07-24 19:42:17.103380][00:00:04.269174][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:17.103402][00:00:04.269198][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:17.103423][00:00:04.269217][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:17.103447][00:00:04.269242][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:17.103464][00:00:04.269259][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:17.103482][00:00:04.269276][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:17.128903][00:00:04.294700][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:17.128952][00:00:04.294747][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:17.134082][00:00:04.299878][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:17.134125][00:00:04.299920][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:17.203995][00:00:04.369792][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:17.204124][00:00:04.369919][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:17.204182][00:00:04.369977][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:17.204237][00:00:04.370032][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:17.204290][00:00:04.370085][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:17.204337][00:00:04.370132][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:17.204383][00:00:04.370178][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:17.204412][00:00:04.370207][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:17.204440][00:00:04.370235][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:17.204464][00:00:04.370259][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:17.204539][00:00:04.370334][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:17.204587][00:00:04.370382][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:17.204614][00:00:04.370409][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:17.204667][00:00:04.370462][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:17.204697][00:00:04.370491][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:17.204719][00:00:04.370514][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:17.204781][00:00:04.370576][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:17.204832][00:00:04.370627][RIGCTRL:trace]
1:rig_get_mode: elapsed=102ms
[2022-07-24 19:42:17.204858][00:00:04.370653][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:17.204878][00:00:04.370673][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:17.204893][00:00:04.370688][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:17.912704][00:00:05.078501][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:17.912763][00:00:05.078558][RIGCTRL:trace]
rig_get_vfo: cache check age=954ms
[2022-07-24 19:42:17.912783][00:00:05.078578][RIGCTRL:trace]
rig_get_vfo: cache miss age=954ms
[2022-07-24 19:42:17.912805][00:00:05.078600][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:17.912829][00:00:05.078624][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:17.912854][00:00:05.078649][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:17.912877][00:00:05.078672][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:17.938335][00:00:05.104131][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:17.938381][00:00:05.104176][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:17.943504][00:00:05.109300][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:17.943547][00:00:05.109342][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:17.957232][00:00:05.123028][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:17.957280][00:00:05.123075][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:17.957308][00:00:05.123103][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:17.957332][00:00:05.123127][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:17.957356][00:00:05.123151][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:17.957391][00:00:05.123185][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:17.957419][00:00:05.123214][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:17.957437][00:00:05.123231][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:17.957461][00:00:05.123256][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:17.957483][00:00:05.123278][RIGCTRL:trace]
rig_get_split_vfo: cache check age=954ms
[2022-07-24 19:42:17.957506][00:00:05.123301][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=954ms
[2022-07-24 19:42:17.957526][00:00:05.123320][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:17.957548][00:00:05.123343][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:17.957574][00:00:05.123368][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:17.957598][00:00:05.123393][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:17.983056][00:00:05.148852][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:17.983102][00:00:05.148897][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:17.988221][00:00:05.154017][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:17.988263][00:00:05.154058][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:18.001812][00:00:05.167609][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:18.001865][00:00:05.167660][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:18.001894][00:00:05.167688][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:18.001920][00:00:05.167714][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:18.001940][00:00:05.167735][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:18.001970][00:00:05.167765][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:18.002001][00:00:05.167796][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:18.002020][00:00:05.167815][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:18.002037][00:00:05.167831][RIGCTRL:trace] state: false
[2022-07-24 19:42:18.002054][00:00:05.167849][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:18.002098][00:00:05.167893][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:18.002118][00:00:05.167913][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:18.002145][00:00:05.167940][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:18.002227][00:00:05.168022][RIGCTRL:trace]
rig_get_freq: cache miss age=899ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:18.002253][00:00:05.168048][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:18.002275][00:00:05.168070][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:18.002298][00:00:05.168093][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:18.002321][00:00:05.168116][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:18.002342][00:00:05.168137][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:18.027774][00:00:05.193573][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:18.027822][00:00:05.193616][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:18.032949][00:00:05.198745][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:18.032994][00:00:05.198789][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:18.102576][00:00:05.268372][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:18.102626][00:00:05.268422][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:18.102655][00:00:05.268450][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:18.102684][00:00:05.268479][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:18.102709][00:00:05.268503][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:18.102744][00:00:05.268539][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:18.102773][00:00:05.268568][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:18.102889][00:00:05.268684][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:18.102911][00:00:05.268706][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:18.102927][00:00:05.268722][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:18.102944][00:00:05.268739][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:18.102970][00:00:05.268765][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:18.102990][00:00:05.268785][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:18.103050][00:00:05.268845][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=898ms
[2022-07-24 19:42:18.103096][00:00:05.268891][RIGCTRL:trace]
rig_get_mode: cache miss age mode=898ms, width=898ms
[2022-07-24 19:42:18.103121][00:00:05.268916][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:18.103143][00:00:05.268938][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:18.103163][00:00:05.268958][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:18.103185][00:00:05.268980][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:18.103206][00:00:05.269002][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:18.103228][00:00:05.269023][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:18.128696][00:00:05.294492][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:18.128742][00:00:05.294537][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:18.133867][00:00:05.299663][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:18.133910][00:00:05.299705][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:18.204104][00:00:05.369902][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:18.204173][00:00:05.369968][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:18.204201][00:00:05.369996][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:18.204228][00:00:05.370022][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:18.204252][00:00:05.370047][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:18.204294][00:00:05.370089][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:18.204322][00:00:05.370117][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:18.204347][00:00:05.370141][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:18.204372][00:00:05.370167][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:18.204402][00:00:05.370196][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:18.204453][00:00:05.370248][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:18.204499][00:00:05.370294][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:18.204527][00:00:05.370322][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:18.204549][00:00:05.370343][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:18.204573][00:00:05.370367][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:18.204594][00:00:05.370389][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:18.204653][00:00:05.370448][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:18.204703][00:00:05.370498][RIGCTRL:trace]
1:rig_get_mode: elapsed=102ms
[2022-07-24 19:42:18.204728][00:00:05.370523][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:18.204744][00:00:05.370539][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:18.204760][00:00:05.370554][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:18.204773][00:00:05.370567][RIGCTRL:trace] force
signal: true
[2022-07-24 19:42:18.912601][00:00:06.078399][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:18.912667][00:00:06.078461][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:18.912687][00:00:06.078523][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:18.912794][00:00:06.078589][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:18.912820][00:00:06.078615][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:18.912847][00:00:06.078641][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:18.912870][00:00:06.078665][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:18.938358][00:00:06.104154][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:18.938404][00:00:06.104199][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:18.943514][00:00:06.109310][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:18.943552][00:00:06.109347][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:18.957023][00:00:06.122819][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:18.957072][00:00:06.122867][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:18.957102][00:00:06.122897][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:18.957124][00:00:06.122918][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:18.957147][00:00:06.122942][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:18.957188][00:00:06.122983][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:18.957215][00:00:06.123010][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:18.957232][00:00:06.123026][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:18.957256][00:00:06.123051][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:18.957279][00:00:06.123073][RIGCTRL:trace]
rig_get_split_vfo: cache check age=955ms
[2022-07-24 19:42:18.957302][00:00:06.123096][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=955ms
[2022-07-24 19:42:18.957323][00:00:06.123117][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:18.957348][00:00:06.123143][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:18.957370][00:00:06.123165][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:18.957398][00:00:06.123192][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:18.982842][00:00:06.148638][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:18.982887][00:00:06.148682][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:18.987998][00:00:06.153794][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:18.988037][00:00:06.153832][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:19.001690][00:00:06.167486][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:19.001740][00:00:06.167535][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:19.001769][00:00:06.167564][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:19.001796][00:00:06.167591][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:19.001817][00:00:06.167612][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:19.001846][00:00:06.167641][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:19.001874][00:00:06.167669][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:19.001891][00:00:06.167686][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:19.001913][00:00:06.167708][RIGCTRL:trace] state: false
[2022-07-24 19:42:19.001933][00:00:06.167728][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:19.001977][00:00:06.167772][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:19.002000][00:00:06.167795][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:19.002021][00:00:06.167816][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:19.002098][00:00:06.167893][RIGCTRL:trace]
rig_get_freq: cache miss age=899ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:19.002124][00:00:06.167919][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:19.002147][00:00:06.167942][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:19.002174][00:00:06.167970][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:19.002202][00:00:06.167996][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:19.002225][00:00:06.168019][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:19.027703][00:00:06.193500][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:19.027748][00:00:06.193543][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:19.032874][00:00:06.198670][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:19.032915][00:00:06.198710][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:19.102000][00:00:06.267798][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:19.102070][00:00:06.267865][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:19.102097][00:00:06.267892][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:19.102125][00:00:06.267919][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:19.102148][00:00:06.267943][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:19.102185][00:00:06.267980][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:19.102214][00:00:06.268009][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:19.102331][00:00:06.268126][RIGCTRL:trace]
0:rig_get_freq: elapsed=100ms
[2022-07-24 19:42:19.102353][00:00:06.268148][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:19.102370][00:00:06.268165][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:19.102389][00:00:06.268184][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:19.102413][00:00:06.268208][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:19.102433][00:00:06.268228][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:19.102495][00:00:06.268290][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=897ms
[2022-07-24 19:42:19.102540][00:00:06.268335][RIGCTRL:trace]
rig_get_mode: cache miss age mode=897ms, width=897ms
[2022-07-24 19:42:19.102562][00:00:06.268357][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:19.102584][00:00:06.268379][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:19.102605][00:00:06.268399][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:19.102628][00:00:06.268423][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:19.102654][00:00:06.268449][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:19.102677][00:00:06.268471][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:19.128141][00:00:06.293937][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:19.128188][00:00:06.293983][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:19.133311][00:00:06.299107][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:19.133353][00:00:06.299149][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:19.203434][00:00:06.369232][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:19.203497][00:00:06.369292][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:19.203522][00:00:06.369316][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:19.203546][00:00:06.369340][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:19.203577][00:00:06.369372][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:19.203603][00:00:06.369397][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:19.203624][00:00:06.369419][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:19.203646][00:00:06.369441][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:19.203689][00:00:06.369484][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:19.203713][00:00:06.369507][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:19.203763][00:00:06.369557][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:19.203801][00:00:06.369596][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:19.203824][00:00:06.369619][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:19.203858][00:00:06.369653][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:19.203885][00:00:06.369680][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:19.203911][00:00:06.369706][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:19.203973][00:00:06.369768][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:19.204025][00:00:06.369819][RIGCTRL:trace]
1:rig_get_mode: elapsed=102ms
[2022-07-24 19:42:19.204054][00:00:06.369848][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:19.204073][00:00:06.369868][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:19.204092][00:00:06.369887][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:19.912903][00:00:07.078701][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:19.912961][00:00:07.078756][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:19.912982][00:00:07.078776][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:19.913004][00:00:07.078799][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:19.913027][00:00:07.078822][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:19.913050][00:00:07.078845][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:19.913072][00:00:07.078867][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:19.938532][00:00:07.104329][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:19.938593][00:00:07.104388][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:19.943741][00:00:07.109537][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:19.943783][00:00:07.109578][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:19.957552][00:00:07.123348][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:19.957599][00:00:07.123394][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:19.957628][00:00:07.123422][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:19.957652][00:00:07.123446][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:19.957675][00:00:07.123470][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:19.957711][00:00:07.123506][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:19.957740][00:00:07.123534][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:19.957759][00:00:07.123554][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:19.957787][00:00:07.123581][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:19.957809][00:00:07.123604][RIGCTRL:trace]
rig_get_split_vfo: cache check age=955ms
[2022-07-24 19:42:19.957832][00:00:07.123627][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=955ms
[2022-07-24 19:42:19.957852][00:00:07.123647][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:19.957876][00:00:07.123671][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:19.957898][00:00:07.123693][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:19.957923][00:00:07.123718][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:19.983357][00:00:07.149153][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:19.983398][00:00:07.149193][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:19.988522][00:00:07.154318][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:19.988565][00:00:07.154360][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:20.002514][00:00:07.168311][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:20.002566][00:00:07.168361][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:20.002594][00:00:07.168389][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:20.002620][00:00:07.168415][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:20.002641][00:00:07.168436][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:20.002673][00:00:07.168467][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:20.002701][00:00:07.168496][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:20.002718][00:00:07.168513][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:20.002740][00:00:07.168535][RIGCTRL:trace] state: false
[2022-07-24 19:42:20.002760][00:00:07.168555][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:20.002804][00:00:07.168599][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:20.002829][00:00:07.168623][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:20.002853][00:00:07.168648][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:20.002934][00:00:07.168729][RIGCTRL:trace]
rig_get_freq: cache miss age=900ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:20.002961][00:00:07.168756][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:20.002989][00:00:07.168783][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:20.003015][00:00:07.168809][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:20.003041][00:00:07.168835][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:20.003063][00:00:07.168858][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:20.028466][00:00:07.194263][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:20.028510][00:00:07.194305][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:20.033631][00:00:07.199427][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:20.033670][00:00:07.199465][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:20.103065][00:00:07.268862][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:20.103119][00:00:07.268915][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:20.103149][00:00:07.268944][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:20.103176][00:00:07.268971][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:20.103200][00:00:07.268995][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:20.103236][00:00:07.269031][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:20.103266][00:00:07.269060][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:20.103380][00:00:07.269174][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:20.103403][00:00:07.269197][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:20.103421][00:00:07.269216][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:20.103438][00:00:07.269233][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:20.103463][00:00:07.269257][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:20.103487][00:00:07.269282][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:20.103548][00:00:07.269342][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=899ms
[2022-07-24 19:42:20.103593][00:00:07.269387][RIGCTRL:trace]
rig_get_mode: cache miss age mode=899ms, width=899ms
[2022-07-24 19:42:20.103619][00:00:07.269413][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:20.103645][00:00:07.269439][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:20.103688][00:00:07.269482][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:20.103716][00:00:07.269511][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:20.103745][00:00:07.269540][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:20.103773][00:00:07.269568][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:20.129236][00:00:07.295032][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:20.129281][00:00:07.295077][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:20.134419][00:00:07.300215][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:20.134461][00:00:07.300256][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:20.204192][00:00:07.369990][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:20.204260][00:00:07.370055][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:20.204286][00:00:07.370080][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:20.204314][00:00:07.370109][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:20.204338][00:00:07.370133][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:20.204360][00:00:07.370155][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:20.204380][00:00:07.370175][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:20.204400][00:00:07.370195][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:20.204433][00:00:07.370228][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:20.204458][00:00:07.370253][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:20.204505][00:00:07.370300][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:20.204546][00:00:07.370341][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:20.204570][00:00:07.370365][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:20.204592][00:00:07.370387][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:20.204614][00:00:07.370409][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:20.204640][00:00:07.370434][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:20.204703][00:00:07.370497][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:20.204754][00:00:07.370549][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:20.204779][00:00:07.370574][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:20.204795][00:00:07.370590][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:20.204811][00:00:07.370606][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:20.912609][00:00:08.078406][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:20.912667][00:00:08.078461][RIGCTRL:trace]
rig_get_vfo: cache check age=954ms
[2022-07-24 19:42:20.912687][00:00:08.078482][RIGCTRL:trace]
rig_get_vfo: cache miss age=954ms
[2022-07-24 19:42:20.912715][00:00:08.078510][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:20.912738][00:00:08.078533][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:20.912761][00:00:08.078556][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:20.912781][00:00:08.078575][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:20.938246][00:00:08.104043][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:20.938292][00:00:08.104087][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:20.943414][00:00:08.109210][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:20.943456][00:00:08.109251][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:20.957094][00:00:08.122890][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:20.957141][00:00:08.122936][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:20.957170][00:00:08.122965][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:20.957194][00:00:08.122989][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:20.957218][00:00:08.123013][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:20.957251][00:00:08.123046][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:20.957279][00:00:08.123074][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:20.957296][00:00:08.123091][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:20.957322][00:00:08.123117][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:20.957343][00:00:08.123138][RIGCTRL:trace]
rig_get_split_vfo: cache check age=954ms
[2022-07-24 19:42:20.957367][00:00:08.123161][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=954ms
[2022-07-24 19:42:20.957386][00:00:08.123181][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:20.957407][00:00:08.123203][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:20.957431][00:00:08.123226][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:20.957456][00:00:08.123251][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:20.982916][00:00:08.148712][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:20.982962][00:00:08.148757][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:20.988083][00:00:08.153879][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:20.988125][00:00:08.153921][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:21.001875][00:00:08.167672][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:21.001929][00:00:08.167725][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:21.001957][00:00:08.167751][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:21.001982][00:00:08.167777][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:21.002007][00:00:08.167802][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:21.002038][00:00:08.167832][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:21.002066][00:00:08.167861][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:21.002087][00:00:08.167882][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:21.002107][00:00:08.167901][RIGCTRL:trace] state: false
[2022-07-24 19:42:21.002125][00:00:08.167920][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:21.002170][00:00:08.167965][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:21.002195][00:00:08.167990][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:21.002215][00:00:08.168010][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:21.002292][00:00:08.168087][RIGCTRL:trace]
rig_get_freq: cache miss age=898ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:21.002316][00:00:08.168111][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:21.002344][00:00:08.168138][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:21.002366][00:00:08.168161][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:21.002387][00:00:08.168182][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:21.002413][00:00:08.168208][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:21.027828][00:00:08.193625][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:21.027875][00:00:08.193670][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:21.033008][00:00:08.198804][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:21.033043][00:00:08.198837][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:21.102215][00:00:08.268013][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:21.102280][00:00:08.268075][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:21.102315][00:00:08.268110][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:21.102338][00:00:08.268133][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:21.102359][00:00:08.268154][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:21.102392][00:00:08.268186][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:21.102427][00:00:08.268222][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:21.102541][00:00:08.268336][RIGCTRL:trace]
0:rig_get_freq: elapsed=100ms
[2022-07-24 19:42:21.102562][00:00:08.268356][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:21.102578][00:00:08.268372][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:21.102593][00:00:08.268388][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:21.102618][00:00:08.268413][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:21.102637][00:00:08.268431][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:21.102694][00:00:08.268489][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=898ms
[2022-07-24 19:42:21.102736][00:00:08.268531][RIGCTRL:trace]
rig_get_mode: cache miss age mode=898ms, width=898ms
[2022-07-24 19:42:21.102761][00:00:08.268555][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:21.102781][00:00:08.268576][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:21.102801][00:00:08.268596][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:21.102822][00:00:08.268617][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:21.102842][00:00:08.268637][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:21.102869][00:00:08.268664][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:21.128325][00:00:08.294121][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:21.128370][00:00:08.294166][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:21.133493][00:00:08.299289][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:21.133536][00:00:08.299331][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:21.202621][00:00:08.368417][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:21.202672][00:00:08.368467][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:21.202700][00:00:08.368495][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:21.202727][00:00:08.368522][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:21.202751][00:00:08.368546][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:21.202775][00:00:08.368570][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:21.202799][00:00:08.368594][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:21.202826][00:00:08.368620][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:21.202851][00:00:08.368646][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:21.202875][00:00:08.368670][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:21.202918][00:00:08.368713][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:21.202959][00:00:08.368755][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:21.202983][00:00:08.368777][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:21.203005][00:00:08.368799][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:21.203027][00:00:08.368821][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:21.203048][00:00:08.368843][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:21.203110][00:00:08.368905][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:21.203159][00:00:08.368954][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:21.203184][00:00:08.368979][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:21.203200][00:00:08.368995][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:21.203213][00:00:08.369008][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:21.913102][00:00:09.078899][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:21.913163][00:00:09.078958][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:21.913184][00:00:09.078979][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:21.913207][00:00:09.079001][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:21.913230][00:00:09.079025][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:21.913253][00:00:09.079049][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:21.913276][00:00:09.079070][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:21.938776][00:00:09.104574][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:21.938837][00:00:09.104632][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:21.943955][00:00:09.109751][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:21.943991][00:00:09.109786][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:21.957812][00:00:09.123608][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:21.957855][00:00:09.123650][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:21.957883][00:00:09.123678][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:21.957906][00:00:09.123701][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:21.957928][00:00:09.123723][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:21.957961][00:00:09.123756][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:21.957988][00:00:09.123783][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:21.958004][00:00:09.123799][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:21.958028][00:00:09.123822][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:21.958048][00:00:09.123842][RIGCTRL:trace]
rig_get_split_vfo: cache check age=956ms
[2022-07-24 19:42:21.958066][00:00:09.123860][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=956ms
[2022-07-24 19:42:21.958084][00:00:09.123880][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:21.958110][00:00:09.123904][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:21.958134][00:00:09.123929][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:21.958158][00:00:09.123953][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:21.983639][00:00:09.149435][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:21.983698][00:00:09.149493][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:21.988824][00:00:09.154620][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:21.988867][00:00:09.154662][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:22.002499][00:00:09.168296][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:22.002549][00:00:09.168345][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:22.002578][00:00:09.168373][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:22.002603][00:00:09.168398][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:22.002624][00:00:09.168419][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:22.002655][00:00:09.168450][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:22.002684][00:00:09.168478][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:22.002704][00:00:09.168498][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:22.002720][00:00:09.168515][RIGCTRL:trace] state: false
[2022-07-24 19:42:22.002738][00:00:09.168533][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:22.002782][00:00:09.168577][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:22.002806][00:00:09.168601][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:22.002827][00:00:09.168621][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:22.002904][00:00:09.168699][RIGCTRL:trace]
rig_get_freq: cache miss age=900ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:22.002930][00:00:09.168725][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:22.002954][00:00:09.168749][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:22.002980][00:00:09.168774][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:22.003007][00:00:09.168801][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:22.003030][00:00:09.168825][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:22.028441][00:00:09.194238][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:22.028487][00:00:09.194282][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:22.033617][00:00:09.199413][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:22.033658][00:00:09.199453][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:22.103117][00:00:09.268913][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:22.103169][00:00:09.268964][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:22.103199][00:00:09.268993][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:22.103224][00:00:09.269019][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:22.103248][00:00:09.269043][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:22.103282][00:00:09.269077][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:22.103317][00:00:09.269112][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:22.103437][00:00:09.269232][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:22.103460][00:00:09.269254][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:22.103476][00:00:09.269271][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:22.103494][00:00:09.269288][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:22.103535][00:00:09.269331][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:22.103560][00:00:09.269355][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:22.103621][00:00:09.269416][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=900ms
[2022-07-24 19:42:22.103682][00:00:09.269477][RIGCTRL:trace]
rig_get_mode: cache miss age mode=900ms, width=900ms
[2022-07-24 19:42:22.103709][00:00:09.269504][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:22.103731][00:00:09.269526][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:22.103752][00:00:09.269547][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:22.103774][00:00:09.269569][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:22.103796][00:00:09.269591][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:22.103820][00:00:09.269615][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:22.129282][00:00:09.295078][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:22.129327][00:00:09.295122][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:22.134451][00:00:09.300247][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:22.134494][00:00:09.300289][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:22.203943][00:00:09.369739][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:22.203994][00:00:09.369789][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:22.204024][00:00:09.369819][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:22.204049][00:00:09.369844][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:22.204095][00:00:09.369890][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:22.204123][00:00:09.369918][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:22.204148][00:00:09.369943][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:22.204169][00:00:09.369964][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:22.204192][00:00:09.369987][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:22.204221][00:00:09.370016][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:22.204267][00:00:09.370062][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:22.204309][00:00:09.370104][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:22.204332][00:00:09.370126][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:22.204357][00:00:09.370152][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:22.204379][00:00:09.370176][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:22.204406][00:00:09.370201][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:22.204469][00:00:09.370263][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:22.204517][00:00:09.370311][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:22.204542][00:00:09.370336][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:22.204559][00:00:09.370353][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:22.204573][00:00:09.370367][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:22.567581][00:00:09.733377][RIGCTRL:trace] #:
Transceiver::TransceiverState(online: yes Frequency {10136000Hz, 0Hz}
Mode: UNK; SPLIT: off; PTT: off)
[2022-07-24 19:42:22.567626][00:00:09.733421][RIGCTRL:trace] f: 10136000
mode: UNK reversed: false
[2022-07-24 19:42:22.567688][00:00:09.733483][RIGCTRL:debug]
rig_set_freq called vfo=currVFO, freq=10136000
[2022-07-24 19:42:22.567743][00:00:09.733537][RIGCTRL:trace]
vfo_fixup:(from rig_set_freq:1730) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:22.567769][00:00:09.733566][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:22.567795][00:00:09.733590][RIGCTRL:trace]
rig_set_freq: TARGETABLE_FREQ vfo=currVFO
[2022-07-24 19:42:22.567820][00:00:09.733615][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1758)
trace
[2022-07-24 19:42:22.567848][00:00:09.733643][RIGCTRL:debug]
1:ft1000mp.c(831):ft1000mp_set_freq entered
[2022-07-24 19:42:22.567879][00:00:09.733674][RIGCTRL:trace]
ft1000mp_set_freq: requested freq on currVFO = 10136000 Hz
[2022-07-24 19:42:22.567903][00:00:09.733698][RIGCTRL:debug] to_bcd called
[2022-07-24 19:42:22.567925][00:00:09.733720][RIGCTRL:debug] from_bcd called
[2022-07-24 19:42:22.567952][00:00:09.733747][RIGCTRL:debug] from_bcd called
[2022-07-24 19:42:22.567975][00:00:09.733769][RIGCTRL:trace]
ft1000mp_set_freq: freq = 10136000 Hz
[2022-07-24 19:42:22.593459][00:00:09.759256][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:22.593509][00:00:09.759304][RIGCTRL:trace] 0000    00
36 01 01 0a                                      .6...
[2022-07-24 19:42:22.598618][00:00:09.764416][RIGCTRL:debug]
1:ft1000mp.c(879):ft1000mp_set_freq returning(0)
[2022-07-24 19:42:22.598683][00:00:09.764478][RIGCTRL:trace]
0:rig_set_freq: elapsed=31ms
[2022-07-24 19:42:22.598700][00:00:09.764495][RIGCTRL:debug]
rig.c(1885):rig_set_freq returning2(0)
[2022-07-24 19:42:22.598711][00:00:09.764506][RIGCTRL:trace] frequency:
10136000
[2022-07-24 19:42:22.598725][00:00:09.764519][RIGCTRL:trace] force
signal: true
[2022-07-24 19:42:22.912217][00:00:10.078014][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:22.912273][00:00:10.078068][RIGCTRL:trace]
rig_get_vfo: cache check age=954ms
[2022-07-24 19:42:22.912380][00:00:10.078177][RIGCTRL:trace]
rig_get_vfo: cache miss age=954ms
[2022-07-24 19:42:22.912409][00:00:10.078204][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:22.912439][00:00:10.078234][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:22.912467][00:00:10.078262][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:22.912491][00:00:10.078286][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:22.937957][00:00:10.103753][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:22.938001][00:00:10.103796][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:22.943123][00:00:10.108919][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:22.943165][00:00:10.108960][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:22.956643][00:00:10.122440][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:22.956690][00:00:10.122485][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:22.956718][00:00:10.122513][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:22.956741][00:00:10.122536][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:22.956765][00:00:10.122560][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:22.956797][00:00:10.122592][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:22.956826][00:00:10.122621][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:22.956849][00:00:10.122643][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:22.956872][00:00:10.122667][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:22.956898][00:00:10.122693][RIGCTRL:trace]
rig_get_split_vfo: cache check age=954ms
[2022-07-24 19:42:22.956921][00:00:10.122715][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=954ms
[2022-07-24 19:42:22.956941][00:00:10.122736][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:22.956963][00:00:10.122757][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:22.956990][00:00:10.122785][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:22.957015][00:00:10.122810][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:22.982528][00:00:10.148324][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:22.982572][00:00:10.148367][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:22.987712][00:00:10.153508][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:22.987754][00:00:10.153549][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:23.001155][00:00:10.166952][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:23.001203][00:00:10.166998][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:23.001232][00:00:10.167027][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:23.001257][00:00:10.167052][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:23.001285][00:00:10.167080][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:23.001313][00:00:10.167108][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=44ms
[2022-07-24 19:42:23.001344][00:00:10.167139][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:23.001364][00:00:10.167159][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:23.001383][00:00:10.167178][RIGCTRL:trace] state: false
[2022-07-24 19:42:23.001403][00:00:10.167198][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:23.001453][00:00:10.167248][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:23.001476][00:00:10.167272][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:23.001497][00:00:10.167292][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:23.001577][00:00:10.167372][RIGCTRL:trace]
rig_get_freq: VFOA cache hit age=402ms, freq=10136000
[2022-07-24 19:42:23.001607][00:00:10.167402][RIGCTRL:trace]
0:rig_get_freq: elapsed=0ms
[2022-07-24 19:42:23.001627][00:00:10.167422][RIGCTRL:trace]
rig_get_freq frequency=10136000
[2022-07-24 19:42:23.001645][00:00:10.167439][RIGCTRL:trace] frequency:
10136000
[2022-07-24 19:42:23.001663][00:00:10.167457][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:23.001686][00:00:10.167480][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:23.001709][00:00:10.167504][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:23.001768][00:00:10.167562][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=797ms
[2022-07-24 19:42:23.001812][00:00:10.167607][RIGCTRL:trace]
rig_get_mode: cache miss age mode=797ms, width=797ms
[2022-07-24 19:42:23.001837][00:00:10.167632][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:23.001861][00:00:10.167655][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:23.001887][00:00:10.167681][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:23.001913][00:00:10.167707][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:23.001939][00:00:10.167733][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:23.001964][00:00:10.167759][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:23.027428][00:00:10.193226][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:23.027491][00:00:10.193287][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:23.032593][00:00:10.198389][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:23.032628][00:00:10.198423][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:23.101780][00:00:10.267579][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:23.101849][00:00:10.267644][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:23.101884][00:00:10.267679][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:23.101909][00:00:10.267704][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:23.101932][00:00:10.267726][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:23.101974][00:00:10.267769][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:23.102009][00:00:10.267804][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:23.102033][00:00:10.267828][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:23.102058][00:00:10.267853][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:23.102078][00:00:10.267873][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:23.102128][00:00:10.267922][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:23.102169][00:00:10.267963][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:23.102192][00:00:10.267986][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:23.102214][00:00:10.268008][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:23.102255][00:00:10.268050][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:23.102287][00:00:10.268082][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:23.102350][00:00:10.268145][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:23.102402][00:00:10.268197][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:23.102430][00:00:10.268225][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:23.102452][00:00:10.268246][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:23.102471][00:00:10.268266][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:23.102486][00:00:10.268281][RIGCTRL:trace] force
signal: true
[2022-07-24 19:42:23.913423][00:00:11.079220][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:23.913467][00:00:11.079262][RIGCTRL:trace]
rig_get_vfo: cache check age=956ms
[2022-07-24 19:42:23.913479][00:00:11.079273][RIGCTRL:trace]
rig_get_vfo: cache miss age=956ms
[2022-07-24 19:42:23.913489][00:00:11.079284][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:23.913501][00:00:11.079296][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:23.913512][00:00:11.079306][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:23.913522][00:00:11.079317][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:23.938945][00:00:11.104746][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:23.938994][00:00:11.104788][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:23.944087][00:00:11.109883][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:23.944117][00:00:11.109911][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:23.957915][00:00:11.123712][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:23.957952][00:00:11.123747][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:23.957972][00:00:11.123766][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:23.957988][00:00:11.123783][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:23.958004][00:00:11.123798][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:23.958045][00:00:11.123840][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:23.958065][00:00:11.123860][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:23.958077][00:00:11.123872][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:23.958095][00:00:11.123889][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:23.958109][00:00:11.123904][RIGCTRL:trace]
rig_get_split_vfo: cache check age=956ms
[2022-07-24 19:42:23.958122][00:00:11.123916][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=956ms
[2022-07-24 19:42:23.958137][00:00:11.123931][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:23.958152][00:00:11.123947][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:23.958168][00:00:11.123963][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:23.958184][00:00:11.123978][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:23.983720][00:00:11.149516][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:23.983763][00:00:11.149558][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:23.988881][00:00:11.154677][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:23.988925][00:00:11.154720][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:24.002397][00:00:11.168194][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:24.002448][00:00:11.168243][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:24.002463][00:00:11.168258][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:24.002476][00:00:11.168270][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:24.002487][00:00:11.168281][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:24.002506][00:00:11.168300][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=44ms
[2022-07-24 19:42:24.002517][00:00:11.168311][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:24.002526][00:00:11.168320][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:24.002538][00:00:11.168332][RIGCTRL:trace] state: false
[2022-07-24 19:42:24.002549][00:00:11.168343][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:24.002570][00:00:11.168365][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:24.002590][00:00:11.168385][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:24.002610][00:00:11.168404][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:24.002645][00:00:11.168441][RIGCTRL:trace]
rig_get_freq: cache miss age=1403ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:24.002660][00:00:11.168454][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:24.002671][00:00:11.168465][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:24.002681][00:00:11.168476][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:24.002700][00:00:11.168495][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:24.002714][00:00:11.168508][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:24.028143][00:00:11.193940][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:24.028196][00:00:11.193991][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:24.033321][00:00:11.199118][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:24.033378][00:00:11.199173][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:24.103151][00:00:11.268948][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:24.103218][00:00:11.269013][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:24.103253][00:00:11.269047][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:24.103277][00:00:11.269072][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:24.103299][00:00:11.269094][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:24.103331][00:00:11.269126][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:24.103358][00:00:11.269153][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:24.103478][00:00:11.269273][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:24.103500][00:00:11.269295][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:24.103536][00:00:11.269330][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:24.103553][00:00:11.269355][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:24.103587][00:00:11.269381][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:24.103608][00:00:11.269404][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:24.103675][00:00:11.269470][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=1001ms
[2022-07-24 19:42:24.103718][00:00:11.269512][RIGCTRL:trace]
rig_get_mode: cache miss age mode=1001ms, width=1001ms
[2022-07-24 19:42:24.103740][00:00:11.269534][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:24.103764][00:00:11.269558][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:24.103784][00:00:11.269580][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:24.103809][00:00:11.269603][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:24.103832][00:00:11.269626][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:24.103855][00:00:11.269649][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:24.129255][00:00:11.295052][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:24.129298][00:00:11.295092][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:24.134395][00:00:11.300191][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:24.134425][00:00:11.300220][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:24.204430][00:00:11.370226][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:24.204481][00:00:11.370276][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:24.204507][00:00:11.370302][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:24.204532][00:00:11.370328][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:24.204555][00:00:11.370350][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:24.204576][00:00:11.370370][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:24.204595][00:00:11.370390][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:24.204614][00:00:11.370409][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:24.204648][00:00:11.370443][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:24.204671][00:00:11.370466][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:24.204716][00:00:11.370511][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:24.204755][00:00:11.370550][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:24.204778][00:00:11.370573][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:24.204799][00:00:11.370594][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:24.204841][00:00:11.370636][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:24.204868][00:00:11.370663][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:24.204927][00:00:11.370722][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:24.204976][00:00:11.370770][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:24.204999][00:00:11.370793][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:24.205016][00:00:11.370811][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:24.205031][00:00:11.370825][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:24.205046][00:00:11.370841][RIGCTRL:trace] force
signal: true
[2022-07-24 19:42:24.912852][00:00:12.078649][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:24.912909][00:00:12.078704][RIGCTRL:trace]
rig_get_vfo: cache check age=954ms
[2022-07-24 19:42:24.912931][00:00:12.078726][RIGCTRL:trace]
rig_get_vfo: cache miss age=954ms
[2022-07-24 19:42:24.912953][00:00:12.078748][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:24.912976][00:00:12.078773][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:24.913001][00:00:12.078795][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:24.913023][00:00:12.078818][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:24.938507][00:00:12.104303][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:24.938553][00:00:12.104348][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:24.943644][00:00:12.109440][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:24.943674][00:00:12.109469][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:24.957284][00:00:12.123081][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:24.957338][00:00:12.123133][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:24.957366][00:00:12.123161][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:24.957390][00:00:12.123187][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:24.957416][00:00:12.123211][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:24.957453][00:00:12.123248][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:24.957481][00:00:12.123276][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:24.957499][00:00:12.123294][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:24.957524][00:00:12.123320][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:24.957546][00:00:12.123341][RIGCTRL:trace]
rig_get_split_vfo: cache check age=955ms
[2022-07-24 19:42:24.957570][00:00:12.123365][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=955ms
[2022-07-24 19:42:24.957591][00:00:12.123385][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:24.957629][00:00:12.123423][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:24.957657][00:00:12.123452][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:24.957680][00:00:12.123475][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:24.983134][00:00:12.148930][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:24.983179][00:00:12.148974][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:24.988301][00:00:12.154097][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:24.988343][00:00:12.154138][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:25.001904][00:00:12.167702][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:25.001957][00:00:12.167752][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:25.001985][00:00:12.167779][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:25.002011][00:00:12.167806][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:25.002032][00:00:12.167827][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:25.002064][00:00:12.167859][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:25.002092][00:00:12.167888][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:25.002113][00:00:12.167907][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:25.002129][00:00:12.167924][RIGCTRL:trace] state: false
[2022-07-24 19:42:25.002150][00:00:12.167944][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:25.002195][00:00:12.167989][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:25.002218][00:00:12.168013][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:25.002239][00:00:12.168033][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:25.002317][00:00:12.168112][RIGCTRL:trace]
rig_get_freq: cache miss age=898ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:25.002344][00:00:12.168138][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:25.002367][00:00:12.168162][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:25.002389][00:00:12.168184][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:25.002416][00:00:12.168211][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:25.002440][00:00:12.168235][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:25.027885][00:00:12.193683][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:25.027944][00:00:12.193739][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:25.033083][00:00:12.198880][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:25.033132][00:00:12.198927][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:25.102506][00:00:12.268302][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:25.102557][00:00:12.268352][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:25.102586][00:00:12.268380][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:25.102613][00:00:12.268408][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:25.102660][00:00:12.268455][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:25.102702][00:00:12.268497][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:25.102729][00:00:12.268524][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:25.102849][00:00:12.268644][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:25.102872][00:00:12.268667][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:25.102888][00:00:12.268683][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:25.102907][00:00:12.268702][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:25.102931][00:00:12.268726][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:25.102951][00:00:12.268746][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:25.103011][00:00:12.268805][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=898ms
[2022-07-24 19:42:25.103056][00:00:12.268850][RIGCTRL:trace]
rig_get_mode: cache miss age mode=898ms, width=898ms
[2022-07-24 19:42:25.103077][00:00:12.268872][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:25.103100][00:00:12.268895][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:25.103119][00:00:12.268914][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:25.103161][00:00:12.268956][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:25.103189][00:00:12.268984][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:25.103212][00:00:12.269007][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:25.128666][00:00:12.294463][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:25.128729][00:00:12.294524][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:25.133858][00:00:12.299656][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:25.133907][00:00:12.299702][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:25.203820][00:00:12.369617][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:25.203872][00:00:12.369667][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:25.203899][00:00:12.369694][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:25.203927][00:00:12.369722][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:25.203951][00:00:12.369746][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:25.203972][00:00:12.369767][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:25.203992][00:00:12.369807][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:25.204048][00:00:12.369843][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:25.204079][00:00:12.369874][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:25.204101][00:00:12.369897][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:25.204152][00:00:12.369947][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:25.204194][00:00:12.369988][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:25.204216][00:00:12.370011][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:25.204239][00:00:12.370034][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:25.204285][00:00:12.370081][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:25.204318][00:00:12.370113][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:25.204380][00:00:12.370175][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:25.204432][00:00:12.370227][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:25.204456][00:00:12.370251][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:25.204474][00:00:12.370268][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:25.204489][00:00:12.370283][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:25.913324][00:00:13.079121][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:25.913385][00:00:13.079180][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:25.913407][00:00:13.079201][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:25.913428][00:00:13.079223][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:25.913451][00:00:13.079246][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:25.913477][00:00:13.079271][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:25.913499][00:00:13.079293][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:25.938993][00:00:13.104790][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:25.939045][00:00:13.104840][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:25.944151][00:00:13.109947][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:25.944193][00:00:13.109988][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:25.957857][00:00:13.123653][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:25.957903][00:00:13.123698][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:25.957933][00:00:13.123728][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:25.957956][00:00:13.123751][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:25.957980][00:00:13.123774][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:25.958014][00:00:13.123809][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:25.958043][00:00:13.123837][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:25.958060][00:00:13.123855][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:25.958087][00:00:13.123882][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:25.958108][00:00:13.123903][RIGCTRL:trace]
rig_get_split_vfo: cache check age=956ms
[2022-07-24 19:42:25.958131][00:00:13.123926][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=956ms
[2022-07-24 19:42:25.958151][00:00:13.123946][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:25.958174][00:00:13.123968][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:25.958204][00:00:13.123998][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:25.958228][00:00:13.124023][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:25.983708][00:00:13.149507][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:25.983768][00:00:13.149563][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:25.988901][00:00:13.154698][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:25.988943][00:00:13.154738][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:26.002325][00:00:13.168122][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:26.002377][00:00:13.168173][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:26.002406][00:00:13.168201][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:26.002431][00:00:13.168226][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:26.002455][00:00:13.168250][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:26.002492][00:00:13.168286][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=44ms
[2022-07-24 19:42:26.002514][00:00:13.168310][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:26.002538][00:00:13.168332][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:26.002558][00:00:13.168353][RIGCTRL:trace] state: false
[2022-07-24 19:42:26.002577][00:00:13.168372][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:26.002625][00:00:13.168420][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:26.002649][00:00:13.168444][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:26.002670][00:00:13.168465][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:26.002750][00:00:13.168545][RIGCTRL:trace]
rig_get_freq: cache miss age=899ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:26.002776][00:00:13.168570][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:26.002802][00:00:13.168597][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:26.002828][00:00:13.168623][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:26.002855][00:00:13.168650][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:26.002881][00:00:13.168675][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:26.028329][00:00:13.194127][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:26.028387][00:00:13.194182][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:26.033488][00:00:13.199284][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:26.033518][00:00:13.199313][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:26.103310][00:00:13.269106][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:26.103364][00:00:13.269159][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:26.103392][00:00:13.269187][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:26.103423][00:00:13.269218][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:26.103469][00:00:13.269264][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:26.103511][00:00:13.269306][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:26.103539][00:00:13.269334][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:26.103654][00:00:13.269449][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:26.103692][00:00:13.269487][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:26.103708][00:00:13.269503][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:26.103729][00:00:13.269524][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:26.103754][00:00:13.269549][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:26.103774][00:00:13.269569][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:26.103833][00:00:13.269628][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=899ms
[2022-07-24 19:42:26.103879][00:00:13.269674][RIGCTRL:trace]
rig_get_mode: cache miss age mode=899ms, width=899ms
[2022-07-24 19:42:26.103901][00:00:13.269695][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:26.103923][00:00:13.269718][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:26.103943][00:00:13.269741][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:26.103968][00:00:13.269763][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:26.103995][00:00:13.269790][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:26.104018][00:00:13.269813][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:26.129481][00:00:13.295277][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:26.129527][00:00:13.295322][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:26.134651][00:00:13.300448][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:26.134694][00:00:13.300489][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:26.204626][00:00:13.370422][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:26.204676][00:00:13.370471][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:26.204704][00:00:13.370498][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:26.204732][00:00:13.370527][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:26.204778][00:00:13.370573][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:26.204807][00:00:13.370602][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:26.204831][00:00:13.370626][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:26.204855][00:00:13.370649][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:26.204880][00:00:13.370675][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:26.204904][00:00:13.370699][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:26.204946][00:00:13.370740][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:26.204985][00:00:13.370781][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:26.205025][00:00:13.370819][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:26.205052][00:00:13.370847][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:26.205076][00:00:13.370871][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:26.205101][00:00:13.370896][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:26.205163][00:00:13.370958][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:26.205212][00:00:13.371007][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:26.205237][00:00:13.371031][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:26.205254][00:00:13.371050][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:26.205269][00:00:13.371064][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:26.913047][00:00:14.078844][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:26.913096][00:00:14.078890][RIGCTRL:trace]
rig_get_vfo: cache check age=955ms
[2022-07-24 19:42:26.913107][00:00:14.078901][RIGCTRL:trace]
rig_get_vfo: cache miss age=955ms
[2022-07-24 19:42:26.913116][00:00:14.078911][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:26.913135][00:00:14.078930][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:26.913146][00:00:14.078940][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:26.913156][00:00:14.078950][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:26.938510][00:00:14.104306][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:26.938546][00:00:14.104341][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:26.943627][00:00:14.109422][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:26.943654][00:00:14.109449][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:26.957687][00:00:14.123482][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:26.957716][00:00:14.123510][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:26.957731][00:00:14.123526][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:26.957745][00:00:14.123540][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:26.957757][00:00:14.123551][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:26.957774][00:00:14.123569][RIGCTRL:trace]
1:rig_get_vfo: elapsed=45ms
[2022-07-24 19:42:26.957794][00:00:14.123589][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:26.957806][00:00:14.123601][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:26.957819][00:00:14.123614][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:26.957829][00:00:14.123624][RIGCTRL:trace]
rig_get_split_vfo: cache check age=955ms
[2022-07-24 19:42:26.957838][00:00:14.123633][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=955ms
[2022-07-24 19:42:26.957849][00:00:14.123643][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:26.957861][00:00:14.123655][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:26.957871][00:00:14.123667][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:26.957884][00:00:14.123679][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:26.983295][00:00:14.149093][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:26.983337][00:00:14.149132][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:26.988457][00:00:14.154253][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:26.988493][00:00:14.154288][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:27.002193][00:00:14.167991][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:27.002247][00:00:14.168042][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:27.002281][00:00:14.168075][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:27.002303][00:00:14.168097][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:27.002321][00:00:14.168116][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:27.002360][00:00:14.168155][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=45ms
[2022-07-24 19:42:27.002380][00:00:14.168175][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:27.002405][00:00:14.168199][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:27.002422][00:00:14.168217][RIGCTRL:trace] state: false
[2022-07-24 19:42:27.002440][00:00:14.168234][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:27.002479][00:00:14.168273][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:27.002499][00:00:14.168294][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:27.002526][00:00:14.168320][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:27.002610][00:00:14.168405][RIGCTRL:trace]
rig_get_freq: cache miss age=898ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:27.002633][00:00:14.168428][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:27.002664][00:00:14.168459][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:27.002683][00:00:14.168478][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:27.002705][00:00:14.168499][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:27.002723][00:00:14.168517][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:27.028477][00:00:14.194274][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:27.028533][00:00:14.194327][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:27.033637][00:00:14.199433][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:27.033667][00:00:14.199462][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:27.103045][00:00:14.268843][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:27.103112][00:00:14.268907][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:27.103140][00:00:14.268935][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:27.103167][00:00:14.268962][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:27.103194][00:00:14.268988][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:27.103229][00:00:14.269024][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:27.103259][00:00:14.269054][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:27.103377][00:00:14.269171][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:27.103399][00:00:14.269194][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:27.103415][00:00:14.269210][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:27.103435][00:00:14.269230][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:27.103460][00:00:14.269255][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:27.103479][00:00:14.269274][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:27.103539][00:00:14.269334][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=898ms
[2022-07-24 19:42:27.103585][00:00:14.269379][RIGCTRL:trace]
rig_get_mode: cache miss age mode=898ms, width=898ms
[2022-07-24 19:42:27.103611][00:00:14.269406][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:27.103637][00:00:14.269431][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:27.103661][00:00:14.269471][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:27.103706][00:00:14.269501][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:27.103732][00:00:14.269526][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:27.103757][00:00:14.269552][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:27.129233][00:00:14.295032][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:27.129296][00:00:14.295091][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:27.134416][00:00:14.300213][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:27.134464][00:00:14.300259][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:27.204485][00:00:14.370281][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:27.204538][00:00:14.370333][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:27.204565][00:00:14.370360][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:27.204593][00:00:14.370388][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:27.204637][00:00:14.370432][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:27.204666][00:00:14.370461][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:27.204691][00:00:14.370486][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:27.204719][00:00:14.370514][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:27.204747][00:00:14.370542][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:27.204771][00:00:14.370566][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:27.204817][00:00:14.370612][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:27.204855][00:00:14.370650][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:27.204880][00:00:14.370675][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:27.204902][00:00:14.370696][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:27.204925][00:00:14.370720][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:27.204946][00:00:14.370741][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:27.205005][00:00:14.370801][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:27.205057][00:00:14.370852][RIGCTRL:trace]
1:rig_get_mode: elapsed=102ms
[2022-07-24 19:42:27.205085][00:00:14.370879][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:27.205101][00:00:14.370895][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:27.205118][00:00:14.370913][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:27.912338][00:00:15.078136][RIGCTRL:debug]
1:rig.c(2764):rig_get_vfo entered
[2022-07-24 19:42:27.912466][00:00:15.078261][RIGCTRL:trace]
rig_get_vfo: cache check age=954ms
[2022-07-24 19:42:27.912495][00:00:15.078290][RIGCTRL:trace]
rig_get_vfo: cache miss age=954ms
[2022-07-24 19:42:27.912515][00:00:15.078309][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2802)
trace
[2022-07-24 19:42:27.912538][00:00:15.078333][RIGCTRL:debug]
2:ft1000mp.c(1254):ft1000mp_get_vfo entered
[2022-07-24 19:42:27.912559][00:00:15.078354][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:27.912580][00:00:15.078375][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:27.937998][00:00:15.103795][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:27.938040][00:00:15.103834][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:27.943155][00:00:15.108951][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:27.943188][00:00:15.108983][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:27.956796][00:00:15.122592][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:27.956841][00:00:15.122636][RIGCTRL:trace] 0000    00
10 00 03 93                                      .....
[2022-07-24 19:42:27.956868][00:00:15.122663][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:27.956894][00:00:15.122688][RIGCTRL:trace]
ft1000mp_get_vfo: vfo status = 0 10
[2022-07-24 19:42:27.956919][00:00:15.122714][RIGCTRL:debug]
2:ft1000mp.c(1297):ft1000mp_get_vfo returning(0)
[2022-07-24 19:42:27.956955][00:00:15.122750][RIGCTRL:trace]
1:rig_get_vfo: elapsed=44ms
[2022-07-24 19:42:27.956979][00:00:15.122774][RIGCTRL:debug]
1:rig.c(2823):rig_get_vfo returning(0)
[2022-07-24 19:42:27.956995][00:00:15.122789][RIGCTRL:trace] VFO=VFOA
[2022-07-24 19:42:27.957019][00:00:15.122814][RIGCTRL:debug]
1:rig.c(4854):rig_get_split_vfo entered
[2022-07-24 19:42:27.957038][00:00:15.122833][RIGCTRL:trace]
rig_get_split_vfo: cache check age=954ms
[2022-07-24 19:42:27.957061][00:00:15.122855][RIGCTRL:trace]
rig_get_split_vfo: cache miss age=954ms
[2022-07-24 19:42:27.957082][00:00:15.122877][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(4905)
trace
[2022-07-24 19:42:27.957108][00:00:15.122903][RIGCTRL:debug]
2:ft1000mp.c(1762):ft1000mp_get_split_vfo entered
[2022-07-24 19:42:27.957130][00:00:15.122925][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:27.957151][00:00:15.122945][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:27.982547][00:00:15.148344][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:27.982591][00:00:15.148385][RIGCTRL:trace] 0000    00
00 00 00 fa                                      .....
[2022-07-24 19:42:27.987691][00:00:15.153487][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:27.987721][00:00:15.153516][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:28.001260][00:00:15.167057][RIGCTRL:trace]
read_block_generic(): RX 5 bytes, direct=1
[2022-07-24 19:42:28.001293][00:00:15.167088][RIGCTRL:trace] 0000    08
10 00 03 93                                      .....
[2022-07-24 19:42:28.001309][00:00:15.167103][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(5)
[2022-07-24 19:42:28.001322][00:00:15.167116][RIGCTRL:debug]
2:ft1000mp.c(1786):ft1000mp_get_split_vfo returning(0)
[2022-07-24 19:42:28.001333][00:00:15.167127][RIGCTRL:trace]
rig_get_split_vfo: cache.split=0
[2022-07-24 19:42:28.001352][00:00:15.167146][RIGCTRL:trace]
1:rig_get_split_vfo: elapsed=44ms
[2022-07-24 19:42:28.001375][00:00:15.167170][RIGCTRL:debug]
1:rig.c(4918):rig_get_split_vfo returning(0)
[2022-07-24 19:42:28.001386][00:00:15.167181][RIGCTRL:trace]
rig_get_split_vfo split=0 VFO=VFOA
[2022-07-24 19:42:28.001397][00:00:15.167192][RIGCTRL:trace] state: false
[2022-07-24 19:42:28.001409][00:00:15.167204][RIGCTRL:debug]
rig_get_freq(1926) called vfo=currVFO
[2022-07-24 19:42:28.001431][00:00:15.167225][RIGCTRL:trace]
vfo_fixup:(from rig_get_freq:1933) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:28.001442][00:00:15.167236][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:28.001451][00:00:15.167246][RIGCTRL:debug]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(1935)
vfo=currVFO, curr_vfo=VFOA
[2022-07-24 19:42:28.001487][00:00:15.167282][RIGCTRL:trace]
rig_get_freq: cache miss age=898ms, cached_vfo=VFOA, asked_vfo=VFOA
[2022-07-24 19:42:28.001498][00:00:15.167293][RIGCTRL:debug]
rig_get_freq(2017): vfo_opt=0, model=1024
[2022-07-24 19:42:28.001511][00:00:15.167306][RIGCTRL:debug]
1:ft1000mp.c(919):ft1000mp_get_freq entered
[2022-07-24 19:42:28.001523][00:00:15.167318][RIGCTRL:debug]
2:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:28.001535][00:00:15.167330][RIGCTRL:debug]
3:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:28.001546][00:00:15.167341][RIGCTRL:debug]
4:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:28.026998][00:00:15.192795][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:28.027046][00:00:15.192841][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:28.032153][00:00:15.197949][RIGCTRL:debug]
4:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:28.032186][00:00:15.197980][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:28.101953][00:00:15.267750][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:28.102012][00:00:15.267808][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:28.102040][00:00:15.267835][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:28.102068][00:00:15.267863][RIGCTRL:debug]
3:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:28.102092][00:00:15.267887][RIGCTRL:debug]
2:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:28.102128][00:00:15.267923][RIGCTRL:trace]
ft1000mp_get_freq: freq = 5577005 Hz for VFO [1]
[2022-07-24 19:42:28.102158][00:00:15.267953][RIGCTRL:debug]
1:ft1000mp.c(956):ft1000mp_get_freq returning(0)
[2022-07-24 19:42:28.102275][00:00:15.268070][RIGCTRL:trace]
0:rig_get_freq: elapsed=101ms
[2022-07-24 19:42:28.102297][00:00:15.268092][RIGCTRL:trace]
rig_get_freq frequency=5577005
[2022-07-24 19:42:28.102313][00:00:15.268108][RIGCTRL:trace] frequency:
5577005
[2022-07-24 19:42:28.102332][00:00:15.268127][RIGCTRL:debug]
1:rig.c(2307):rig_get_mode entered
[2022-07-24 19:42:28.102356][00:00:15.268152][RIGCTRL:trace]
vfo_fixup:(from rig_get_mode:2327) vfo=currVFO, vfo_curr=VFOA, split=0
[2022-07-24 19:42:28.102376][00:00:15.268171][RIGCTRL:trace] vfo_fixup:
Leaving currVFO alone
[2022-07-24 19:42:28.102437][00:00:15.268231][RIGCTRL:trace]
rig_get_mode: currVFO cache check age=897ms
[2022-07-24 19:42:28.102482][00:00:15.268277][RIGCTRL:trace]
rig_get_mode: cache miss age mode=897ms, width=897ms
[2022-07-24 19:42:28.102507][00:00:15.268301][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2368)
trace
[2022-07-24 19:42:28.102528][00:00:15.268323][RIGCTRL:debug]
2:ft1000mp.c(1095):ft1000mp_get_mode entered
[2022-07-24 19:42:28.102549][00:00:15.268344][RIGCTRL:trace]
ft1000mp_get_mode: current_vfo=VFOA
[2022-07-24 19:42:28.102570][00:00:15.268364][RIGCTRL:debug]
3:ft1000mp.c(886):ft1000mp_get_vfo_data entered
[2022-07-24 19:42:28.102594][00:00:15.268389][RIGCTRL:debug]
4:ft1000mp.c(1674):ft1000mp_get_update_data entered
[2022-07-24 19:42:28.102619][00:00:15.268414][RIGCTRL:debug]
5:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:28.128049][00:00:15.293846][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:28.128090][00:00:15.293885][RIGCTRL:trace] 0000    00
00 00 03 10                                      .....
[2022-07-24 19:42:28.133206][00:00:15.299002][RIGCTRL:debug]
5:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:28.133249][00:00:15.299044][RIGCTRL:debug]
read_block_generic called, direct=1
[2022-07-24 19:42:28.202517][00:00:15.368313][RIGCTRL:trace]
read_block_generic(): RX 32 bytes, direct=1
[2022-07-24 19:42:28.202568][00:00:15.368363][RIGCTRL:trace] 0000    09
00 88 28 48 00 00 03 22 00 11 22 11 91 11 a0    ...(H...".."....
[2022-07-24 19:42:28.202597][00:00:15.368392][RIGCTRL:trace] 0010    1b
02 ad 66 80 00 00 02 33 00 11 33 11 11 11 00    ...f....3..3....
[2022-07-24 19:42:28.202624][00:00:15.368418][RIGCTRL:debug]
4:ft1000mp.c(1690):ft1000mp_get_update_data returning(32)
[2022-07-24 19:42:28.202667][00:00:15.368462][RIGCTRL:debug]
3:ft1000mp.c(905):ft1000mp_get_vfo_data returning(32)
[2022-07-24 19:42:28.202699][00:00:15.368494][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (before)
[2022-07-24 19:42:28.202724][00:00:15.368519][RIGCTRL:trace]
ft1000mp_get_mode: mymode = 3 (after)
[2022-07-24 19:42:28.202747][00:00:15.368542][RIGCTRL:trace]
ft1000mp_get_mode: mode = AM
[2022-07-24 19:42:28.202771][00:00:15.368565][RIGCTRL:debug]
2:ft1000mp.c(1174):ft1000mp_get_mode returning(0)
[2022-07-24 19:42:28.202794][00:00:15.368589][RIGCTRL:trace]
rig_get_mode: retcode after get_mode=0
[2022-07-24 19:42:28.202836][00:00:15.368631][RIGCTRL:trace]
rig_get_mode(2412): debug
[2022-07-24 19:42:28.202878][00:00:15.368673][RIGCTRL:trace]
rig_get_mode(2420): debug
[2022-07-24 19:42:28.202902][00:00:15.368698][RIGCTRL:debug]
2:rig.c(2449):rig_passband_normal entered
[2022-07-24 19:42:28.202929][00:00:15.368724][RIGCTRL:debug]
2:rig_passband_normal: return filter#0, width=2400
[2022-07-24 19:42:28.202956][00:00:15.368751][RIGCTRL:debug]
2:rig.c(2470):rig_passband_normal returning(2400)
[2022-07-24 19:42:28.202980][00:00:15.368775][RIGCTRL:debug]
2:cache.c(35):rig_set_cache_mode entered
[2022-07-24 19:42:28.203042][00:00:15.368837][RIGCTRL:debug]
2:cache.c(106):rig_set_cache_mode returning(0)
[2022-07-24 19:42:28.203091][00:00:15.368886][RIGCTRL:trace]
1:rig_get_mode: elapsed=101ms
[2022-07-24 19:42:28.203119][00:00:15.368914][RIGCTRL:debug]
1:rig.c(2428):rig_get_mode returning(0)
[2022-07-24 19:42:28.203140][00:00:15.368935][RIGCTRL:trace]
rig_get_mode mode=AM bw=2400
[2022-07-24 19:42:28.203157][00:00:15.368953][RIGCTRL:trace] mode: AM
[2022-07-24 19:42:28.710456][00:00:15.876252][RIGCTRL:trace] stop
[2022-07-24 19:42:28.710496][00:00:15.876291][RIGCTRL:trace] shutdown
[2022-07-24 19:42:28.710506][00:00:15.876300][RIGCTRL:trace] PTT: false
Transceiver::TransceiverState(online: yes Frequency {5577005Hz, 0Hz}
Mode: AM; SPLIT: off; PTT: off) reversed=false
[2022-07-24 19:42:28.710524][00:00:15.876319][RIGCTRL:trace] rig_set_ptt
PTT=false
[2022-07-24 19:42:28.710556][00:00:15.876351][RIGCTRL:debug]
1:rig.c(2848):rig_set_ptt entered
[2022-07-24 19:42:28.710582][00:00:15.876377][RIGCTRL:trace]
/home/chet/Desktop/build2.6.0-rc2/build/hamlib-prefix/src/hamlib/src/rig.c(2881)
trace
[2022-07-24 19:42:28.710612][00:00:15.876407][RIGCTRL:debug]
2:ft1000mp.c(1645):ft1000mp_set_ptt entered
[2022-07-24 19:42:28.710633][00:00:15.876427][RIGCTRL:trace]
ft1000mp_set_ptt: called 0
[2022-07-24 19:42:28.710657][00:00:15.876452][RIGCTRL:debug]
3:ft1000mp.c(1703):ft1000mp_send_priv_cmd entered
[2022-07-24 19:42:28.736150][00:00:15.901946][RIGCTRL:trace]
write_block(): TX 5 bytes, method=1
[2022-07-24 19:42:28.736179][00:00:15.901974][RIGCTRL:trace] 0000    00
00 00 00 0f                                      .....
[2022-07-24 19:42:28.741290][00:00:15.907087][RIGCTRL:debug]
3:ft1000mp.c(1714):ft1000mp_send_priv_cmd returning(0)
[2022-07-24 19:42:28.741347][00:00:15.907142][RIGCTRL:debug]
2:ft1000mp.c(1652):ft1000mp_set_ptt returning(0)
[2022-07-24 19:42:28.791471][00:00:15.957269][RIGCTRL:trace]
1:rig_set_ptt: elapsed=81ms
[2022-07-24 19:42:28.791525][00:00:15.957319][RIGCTRL:debug]
1:rig.c(3117):rig_set_ptt returning(0)
[2022-07-24 19:42:28.791535][00:00:15.957329][RIGCTRL:trace] state: false
[2022-07-24 19:42:28.791548][00:00:15.957343][RIGCTRL:debug]
1:rig.c(1352):rig_close entered
[2022-07-24 19:42:28.791559][00:00:15.957354][RIGCTRL:debug]
2:rig.c(7203):async_data_handler_stop entered
[2022-07-24 19:42:28.791571][00:00:15.957365][RIGCTRL:debug]
2:rig.c(7233):async_data_handler_stop returning(0)
[2022-07-24 19:42:28.791581][00:00:15.957376][RIGCTRL:debug] ser_close:
restoring options
[2022-07-24 19:42:28.791734][00:00:15.957529][RIGCTRL:debug]
rig_close(1484): 0x555ad2223ddc rs->comm_state==0?=0
[2022-07-24 19:42:28.791748][00:00:15.957543][RIGCTRL:debug]
1:rig.c(1488):rig_close returning(0)
[2022-07-24 19:42:28.791765][00:00:15.957559][RIGCTRL:trace] state:
Transceiver::TransceiverState(online: yes Frequency {5577005Hz, 0Hz}
Mode: AM; SPLIT: off; PTT: off) reversed=false
[2022-07-24 19:42:28.791778][00:00:15.957572][RIGCTRL:trace] force
signal: false
[2022-07-24 19:42:28.791817][00:00:15.957611][RIGCTRL:debug]
1:ft1000mp.c(771):ft1000mp_cleanup entered
[2022-07-24 19:42:28.791851][00:00:15.957645][RIGCTRL:debug]
1:ft1000mp.c(780):ft1000mp_cleanup returning(0)
[2022-07-24 19:42:28.921873][00:00:16.087671][SYSLOG:info] Log Finish


locked Re: Control of an Arduino based TX using WSJT-X #Cat_RigControl

Michael Black
 

It's not really outside the scope of this list.  This is a particular rig configuration that would be nice to get working as we expand capabilities for WSJTX and Hamlib.
I have two questions....
#1 What does "instantaneous" mean?  Presumably you mean "before PTT is asserted" or can frequency change occur after PTT is asserted?  There is currently no mechanism built in but that can be accomplished via a virtual serial port intercepting commands and the handshake would then delay until frequency change on the secondary transceiver occurs.
#2 What programming languages are you familiar with?  There's a python implementation that uses the WSJTX broadcast messages but that doesn't provide any control.
I can imagine Hamlib could be modified to handle this by providing a port (serial or network) that would spit out frequency, mode, and PTT and perhaps provide some control so that PTT is not asserted until "permission" is granted from the client.
Mike W9MDB

On Monday, July 25, 2022 at 02:52:50 AM CDT, Reino Talarmo <reino.talarmo@...> wrote:

Hi Peter,

I am a bit lost what you try to achieve on the frequency control.
The CAT commands are intended only for setting VFO frequency before a transmission and with some rigs slowly moving transmit (VFO) frequency to compensate doppler in EME QSOs.
To my understanding there is no other output about audio frequency than the audio itself for any modulation purposes.

The problem seems to be:
1. The Arduino needs to decode the instantaneous freq changes.  (1500+ or -)
Could you explain your need for those frequency steps, please? As a band (VFO) change it would take 200 ms signaling time using WSJT-X CAT commands for the FT-847UNI.

2 the Arduino needs to stop and start transmissions at the correct times.
The PTT signaling can do that and will be done by WSJT-X, if you are using that e.g. for FST4 or WSPR transmissions.

The remaining problem is to convert the audio out to a string of commands to shift frequencies up or down. I may experiment with implementing a freq counter on the audio out and using that, but it may not be fast or accurate enough.
Do you need that for modulation generation?

73, Reino OH3mA

Peter, you may use may personal e-mail for further detailed discussions as it may drift outside the scope of this e-mail list, hi!


locked Re: CQ calling consistently stopped in a specific scenario #IssueReport #transmit

Zeev Stadler
 

It looks like I've not clarified the actual requested program change in my initial post.

I'd like to ask that this FT8 protocol limitation will be embedded in the WSJT-X "Auto Seq" code.

Since there is no way for two stations with a special/long callsign to complete a QSO, the program should ignore such an incoming CQ response from a special/long callsign when the local callsign is special/long. I've seen it ignoring special/long callsigns in another scenario (which I cannot remember now).

Perhaps all messages from special/long callsign to another special/long callsign should be ignored by the "Auto Seq" code.

Perhaps even more - WSJT-X would avoid sending any messages from special/long callsign to another special/long callsign and provide a short message explaining why.

Zeev 4X5ZS


locked Re: Xiegu X5105 #macOS #Xiegu

Sam Birnbaum
 

Hi Mike, 
The X5105 and the G90 are pretty much the same.

73,

Sam W2JDB

-----Original Message-----
From: Michael Black via groups.io <mdblack98@...>
To: main@WSJTX.groups.io <main@WSJTX.groups.io>
Sent: Mon, Jul 25, 2022 8:57 am
Subject: Re: [WSJTX] Xiegu X5105 #macOS #Xiegu

Have you tried the 3 Xiegu models listed to see if one of them works?
If can find one that works with Fake It and Rig Split I'll make it available in the list.
Please test the X108G and the G90 -- the X6100 does not do rig split.
Mike W9MDB



    On Monday, July 25, 2022 at 02:54:44 AM CDT, Norman Wald <norman@...> wrote: 

Can the Xiegu X5105 be added to the list of radios that show up under Rig: in the Radio Tab?
The Xiegu manual says that the X5105 is (allegedly) the same as the Icom 7000, but in reality, it absolutely won't work.
The only way I can get the X5105 to work on either Mac or Windows is to load the (very wacky) FLRig and jump through several hoops.
Please consider the X5105 is still a current radio as good as the G90 or 6100.

Thank you, Norman W9VQ
norman@...


locked Re: WSJT-X Logging into HRD issue #Icom #Windows10

Michael Black
 

JTAlert will log to HRD.You may want to consider using that.
Mike W9MDB

On Monday, July 25, 2022 at 12:04:20 AM CDT, Phil Atchison <patchison1@...> wrote:

My WSJT-X stopped entering in completed QSO's into HRD Logbook. I have to manually enter the QSO via the HRD "Add" system.
I am using the latest HRD and the most current WSJT-X software.
I am using Windows 10 and an ICOM IC7300. (WSJT-X is set up using HRD in lieu of IC-7300.


locked Re: Xiegu X5105 #macOS #Xiegu

Michael Black
 

Have you tried the 3 Xiegu models listed to see if one of them works?
If can find one that works with Fake It and Rig Split I'll make it available in the list.
Please test the X108G and the G90 -- the X6100 does not do rig split.
Mike W9MDB

On Monday, July 25, 2022 at 02:54:44 AM CDT, Norman Wald <norman@...> wrote:

Can the Xiegu X5105 be added to the list of radios that show up under Rig: in the Radio Tab?
The Xiegu manual says that the X5105 is (allegedly) the same as the Icom 7000, but in reality, it absolutely won't work.
The only way I can get the X5105 to work on either Mac or Windows is to load the (very wacky) FLRig and jump through several hoops.
Please consider the X5105 is still a current radio as good as the G90 or 6100.

Thank you, Norman W9VQ
norman@...


locked Re: CQ calling consistently stopped in a specific scenario #IssueReport #transmit

Michael Black
 

Somebody called you with a special callsign too.  Can't have two of them.  That's what the <....> is indicating. Anytime you see <...> means you have not ever decoded a plain message from the "unknown" callsign.You'll see in your messages TX 1 and TX 5 will both have your callsign without <> which means that is a "plain" message.  When your callsign is in <> means it is hashed in order to fit in the limited message length.Would be nice to have some message in the decode window explaining it though.
Mike W9MDB

On Monday, July 25, 2022 at 07:14:19 AM CDT, Zeev Stadler <zeev.stadler@...> wrote:

Hello,

I've been calling CQ with a Special callsign and the "Calling CQ forces Call 1st" was set as usual. At some point, I received a response from an unknown callsign.

As a result, "Enable TX" was turned-off, "Next T2" was enabled and there was no T2 message to transmit

See screenshot at https://user-images.githubusercontent.com/1304610/180768878-3263b31e-91a3-4db7-b706-daa80e1e400a.png

This repeated itself after every time I clicked "Enable TX".
The only workaround I could find is to turn-off the "Calling CQ forces Call 1st" settings.

It is strange that WSJT-X decided to initiate a response to the CQ while the program would be unable to respond to it.

Is there something else I could do?

73 de 4X5ZS

3901 - 3920 of 40097