1. wsprdaemon@groups.io
  2. Messages
   Date   
Re: performance wsprdaemon on a RPI3

Bryan Klofas
 

Hey Rob--

Thanks for the tips on decreasing the "-o" flag if I run out of cycles. My current KF6ZEO spotting station is actually running on a Ubuntu 20.04 VM with 2 threads of a i3-5010U, so it's got enough horsepower. I'm building up a Pi for a remote site.

It might be helpful to add a bit more error logging if kiwirecorder can't access the SDR.

For instance, I just stopped wsprdaemon, git pull, started, and viewed the error logs. Nothing showed up using "-l e", but no spots were being uploaded.

It turns out that as soon as I stopped wsprdaemon, the KiwiSDR started to update itself, with no incoming connections allowed. Judging by htop, it appears that kiwirecorder is crashlooping. Running kiwirecorder by hand results in:

kiwi.client.KiwiDownError: 192.168.1.82: server is down atm

However, the recovery worked well. As soon as the server came back up, kiwirecorder stopped crashing and wsprdaemon started uploading spots. So maybe I'm getting a bit too into the weeds here.

Thanks for continuing to work on wsprdaemon, have a great weekend!
--
Bryan Klofas KF6ZEO

On 5/26/22 18:32, Rob Robinett wrote:
Hi Bryan,
I see from http://wspr.rocks/livequeries/ <http://wspr.rocks/livequeries/> that you are still running 3.0.2.3. You would benefit from updating your WD by running:
git pull
wd -z
wd -a
I have just installed Wd 3.0.2 at many of the top sites and have found how to use some of its features to ensure there is no CPU overloading on the WD server.  Logging is much improved in WD 3.0, so wsprd timeouts and other errors which were silently handled (tom some extent) by WD 2.10 are now much more visible.  To see log lines with ERROR execute:
wd -l e    (show Log errors)
You can ignore the "ERROR: only x o y spots accepted by wsprnet.org" lines, but any other error lines should be investigated.
If you see "ERROR: timeout..." lines, then you are running out of CPU cycles and you should try adding this line to your conf file:
WSPRD_CMD_FLAGS="-C 500 -o 3 -d"
At one especially challenged site I had to go down from the default '-o 4' to:
WSPRD_CMD_FLAGS="-C 500 -o 2 -d"
Even '-o 2' didn't seem to affect the number of decoded spots, so users with Pi 3bs may be able to scan 14+ bands.
Re: Memory leak (Bullseye)

Rob Robinett
 

The memory leak is in the Bash version 5.1.4 included in bullseye.  Gwyn has compiled Bash 5.1.16 on his bullseye Pi 3b and that fixes the problem.  I have no insight into if/when they will update the Bash is bullseye.

I switched my Pi4 to the 64 bit Ubuntu for the Pi which includes Bash 5.1.16 and it runs with no leak.  That version of Ubuntu is offered as an option in the 'Raspberry Pi Imager' which I run on my Mac to load microSD cards.  Burning the card and then setting it up in the Pi took me about 15 minutes, but I do have a lot of experience with that process.

Rob

On Fri, May 27, 2022 at 7:01 AM John <johnk5mo@...> wrote:
Rob mentions:

in your case the much bigger problem is a memory leak in the Bash 5.1.4 included in bullseye.  Gwyn G3ZIL identified that problem which leads the Pi to run out of memory in 1-5 days.

I now see this too, in my Pi4 install of 3.0.2 .  It's running great otherwise.  ("other than that, how did you like the play Mrs Lincoln?").   Do I understand this is an issue with Bash?

While I can restart my system every 5 days or so, does anyone know if this is likely to be fixed in a new release of Bash, or is it associated only with the combination of Bash and WD?

Thanks. It's probably a dumb question, but I'd rather wait and update Bash than build a new system.

John K5MO



--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Memory leak (Bullseye)

John
 

Rob mentions:

in your case the much bigger problem is a memory leak in the Bash 5.1.4 included in bullseye.  Gwyn G3ZIL identified that problem which leads the Pi to run out of memory in 1-5 days.

I now see this too, in my Pi4 install of 3.0.2 .  It's running great otherwise.  ("other than that, how did you like the play Mrs Lincoln?").   Do I understand this is an issue with Bash?

While I can restart my system every 5 days or so, does anyone know if this is likely to be fixed in a new release of Bash, or is it associated only with the combination of Bash and WD?

Thanks. It's probably a dumb question, but I'd rather wait and update Bash than build a new system.

John K5MO
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Bruce KX4AZ
 

On Thu, May 26, 2022 at 11:20 PM, Rob Robinett wrote:
... I have ordered one of those clones from ebay if only to compare it against my RP2.
...The big issue with using any of those SDRs for VHF/UHF WSPR is calibrating its frequency settings
Thanks Rob, looking forward to hearing how well it works.  I ordered one as well from Aliexpress - the one with five SMA filter inputs.  The main difference versus the single input with the DIP switches is bandwidth claimed (2 GHz versus 1 GHz for the 5 inputs).  Presumably all of those 5 SMA inputs add enough extra capacitance to roll things off at a lower frequency.  They claim there is a 0.5 ppm TXCO on board so perhaps after calibrating against a GPSDO the accuracy will be good enough for VHF/UHF WSPR.  Unless you can swamp out the TXCO by feeding it a stronger external clock, perhaps.  In any event, even given the outdated RSP1 design, it would be a significant upgrade from the RTL-SDR direct mode for HF, with those extra bits as well as the lack of aliasing for the >14.4 MHz region, not to mention the much wider bandwidth, and similar cost. 
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Erwin - PE3ES - F4VTQ
 

First of all these are clones of the way outdated version RSP1, not the later RSP1a. And also the "designer" tells it is a simplified design.
So I would not be to hopeful on performance.
If it will work with the needed latest official SDRplay API versions needs to be seen as well.

Well, one can always hope.

Cheers
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Rob Robinett
 

Perhaps  I could tune the RP1/2 to a carrier generated by a GPSDO on the bench next to the RP and then use the measured tuning error to adjust the WSPR tuning frequency.  That isn't nearly as good as driving the clock of the RP1/2, but no soldering required ;=)

On Thu, May 26, 2022 at 8:46 PM Glenn Elmore <n6gn@...> wrote:
Unfortunately upon surveying  > 30 OTA HDTV broadcasts here on Colorado
's Front Range with my GPSDO referenced 0-2 GHz Frequency Extender,
hearing HDTV ATSC pilot carriers from well South of Denver up to the
Wyoming border, I find almost *NONE* of them on the 'correct' ATSC spot.
They are generally within 1 kHz (FCC spec?) but they deliberately offset
in order to avoid QRMing each other. Unless you can get the
engineer-in-charge to tell you what their exact offset is (if they know
it) I don't think these signals are nearly as useful as first hoped.

So much for using ATSC for the truly accurate frequency information it
might otherwise provide. It's slated to disappear anyway...

On 5/26/22 21:20, Rob Robinett wrote:
> That RP clone doesn't appear to have an external clock input option,
> so I can use the "calibrate against a local ATSC pilot carrier' if
> those can be trusted.







--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Glenn Elmore
 

Unfortunately upon surveying  > 30 OTA HDTV broadcasts here on Colorado 's Front Range with my GPSDO referenced 0-2 GHz Frequency Extender, hearing HDTV ATSC pilot carriers from well South of Denver up to the Wyoming border, I find almost *NONE* of them on the 'correct' ATSC spot. They are generally within 1 kHz (FCC spec?) but they deliberately offset in order to avoid QRMing each other. Unless you can get the engineer-in-charge to tell you what their exact offset is (if they know it) I don't think these signals are nearly as useful as first hoped.

So much for using ATSC for the truly accurate frequency information it might otherwise provide. It's slated to disappear anyway...

On 5/26/22 21:20, Rob Robinett wrote:
That RP clone doesn't appear to have an external clock input option, so I can use the "calibrate against a local ATSC pilot carrier' if those can be trusted.
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Rob Robinett
 

Hi Bruce,

Thanks for that post.  I have ordered one of those clones from ebay if only to compare it against my RP2.

I had my RP2 working with WD 3.0 last year, and I will check to see if that code is still working.  

The big issue with using any of those SDRs for VHF/UHF WSPR is calibrating its frequency settings.  I can drive the RP2 from my Bodnar to get 1 hz accuracy and stability,  but even an RTL-SDR is stable enough to decode WSPR on 23 cm if I can calibrate its tuning.   That RP clone doesn't appear to have an external clock input option, so I can use the "calibrate against a local ATSC pilot carrier' if those can be trusted.


I have
Re: performance wsprdaemon on a RPI3

Rob Robinett
 

Hi Bryan,

I see from http://wspr.rocks/livequeries/ that you are still running 3.0.2.3.  You would benefit from updating your WD by running:

git pull
wd -z
wd -a

I have just installed Wd 3.0.2 at many of the top sites and have found how to use some of its features to ensure there is no CPU overloading on the WD server.  Logging is much improved in WD 3.0, so wsprd timeouts and other errors which were silently handled (tom some extent) by WD 2.10 are now much more visible.  To see log lines with ERROR execute:

wd -l e    (show Log errors)

You can ignore the "ERROR: only x o y spots accepted by wsprnet.org" lines, but any other error lines should be investigated.

If you see "ERROR: timeout..." lines, then you are running out of CPU cycles and you should try adding this line to your conf file:

WSPRD_CMD_FLAGS="-C 500 -o 3 -d"

At one especially challenged site I had to go down from the default '-o 4' to:

WSPRD_CMD_FLAGS="-C 500 -o 2 -d"

Even '-o 2' didn't seem to affect the number of decoded spots, so users with Pi 3bs may be able to scan 14+ bands.
Re: Rejected

Jim Lill
 

to date, nearly every misformed spot has been missing a grid, so that would be an easy filter I think

On 5/26/22 15:00, Rob Robinett wrote:
If you send me a list of rejected spots I will try to enhance the filtering I already do on spots before uploading them
thanks

On Thu, May 26, 2022 at 11:55 AM Jim Lill <jim@...> wrote:


I have started tracking which spots get rejected on wsprnet uploads. The wsprdaemon.sh -le command in v3.02 is useful for doing this. I have found 2 categories so far

  • bad decodes or otherwise misformed spots
  • dupes that come from uploads on the 60/60eu and 80/80eu bands. For example G4ZFQ on 60/60eu on the same upload cyles will result in one being thrown out as a dupe


-Jim

WA2ZKD








--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Re: Rejected

Jim Lill
 

I informed him.... and he is going to revise his scheme at some point

On 5/26/22 15:08, Rob Robinett wrote:
I think G4ZFQ is the only site transmitting on both 60M bands during the same WSPR cycle.
Perhaps he too doesn't know that 1/2 of such spots are being rejected by wsprnet.org

On Thu, May 26, 2022 at 12:01 PM Rob Robinett via groups.io <rob=robinett.us@groups.io> wrote:
If you send me a list of rejected spots I will try to enhance the filtering I already do on spots before uploading them
thanks

On Thu, May 26, 2022 at 11:55 AM Jim Lill <jim@...> wrote:


I have started tracking which spots get rejected on wsprnet uploads. The wsprdaemon.sh -le command in v3.02 is useful for doing this. I have found 2 categories so far

  • bad decodes or otherwise misformed spots
  • dupes that come from uploads on the 60/60eu and 80/80eu bands. For example G4ZFQ on 60/60eu on the same upload cyles will result in one being thrown out as a dupe


-Jim

WA2ZKD








--
Rob Robinett
AI6VN
mobile: +1 650 218 8896


--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Re: wsprdaemon with SDRplay devices on Raspberry Pi 4

Bruce KX4AZ
 

I happened to notice on Aliexpress (search for 'RSP1') there are a ton of RSP1 clones based on the msi2500 chip, that have either a single input with DIP switches for input filtering, or are equipped with 5 separate filtered inputs for different ranges (snapshots attached)....though for HF there is only a single "0-30 MHz" filter.  The pricing (generally <$20) would make them very competitive with the humble RTL-SDR dongles, though I haven't seen any performance tests for this new RSP1 clone "flavor".

If the new wspardaemon version happens to work with this variety of an RSP1 clone and if the performance at least matches that of the RTL-SDR, this could be a very interesting option for WSPR spotting.
Re: Rejected

Rob Robinett
 

I think G4ZFQ is the only site transmitting on both 60M bands during the same WSPR cycle.
Perhaps he too doesn't know that 1/2 of such spots are being rejected by wsprnet.org

On Thu, May 26, 2022 at 12:01 PM Rob Robinett via groups.io <rob=robinett.us@groups.io> wrote:
If you send me a list of rejected spots I will try to enhance the filtering I already do on spots before uploading them
thanks

On Thu, May 26, 2022 at 11:55 AM Jim Lill <jim@...> wrote:


I have started tracking which spots get rejected on wsprnet uploads. The wsprdaemon.sh -le command in v3.02 is useful for doing this. I have found 2 categories so far

  • bad decodes or otherwise misformed spots
  • dupes that come from uploads on the 60/60eu and 80/80eu bands. For example G4ZFQ on 60/60eu on the same upload cyles will result in one being thrown out as a dupe


-Jim

WA2ZKD








--
Rob Robinett
AI6VN
mobile: +1 650 218 8896



--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Re: Rejected

Rob Robinett
 

If you send me a list of rejected spots I will try to enhance the filtering I already do on spots before uploading them
thanks

On Thu, May 26, 2022 at 11:55 AM Jim Lill <jim@...> wrote:


I have started tracking which spots get rejected on wsprnet uploads. The wsprdaemon.sh -le command in v3.02 is useful for doing this. I have found 2 categories so far

  • bad decodes or otherwise misformed spots
  • dupes that come from uploads on the 60/60eu and 80/80eu bands. For example G4ZFQ on 60/60eu on the same upload cyles will result in one being thrown out as a dupe


-Jim

WA2ZKD








--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Rejected

Jim Lill
 


I have started tracking which spots get rejected on wsprnet uploads. The wsprdaemon.sh -le command in v3.02 is useful for doing this. I have found 2 categories so far

  • bad decodes or otherwise misformed spots
  • dupes that come from uploads on the 60/60eu and 80/80eu bands. For example G4ZFQ on 60/60eu on the same upload cyles will result in one being thrown out as a dupe


-Jim

WA2ZKD
New -A and -Z command line options in WD 3.0.2

Rob Robinett
 

I almost always execute 'wd -a' to start WD and 'wd -z' to stop it.

However if you want to have WD start automatically after power-up or reboot, then execute 'wd -A'.  It configures Linux to run WD at startup and then executes the 'systemctl start wsprdaemon' command which would run at that time.
After 'WD -A'  you can 'wd -s', 'wd -z' and 'wd -a' if you want to make changes to your config file.
'wd -Z' will disable the automatic startup by running 'systemctl stop wsprdaemon' and then 'systemctl disable wsprdaemon' so that WD will not run at startup
Re: FST4W and 22M now working in version 3.0.2

Rob Robinett
 

Hi Gerhard,

I think you may need to stop your WD 2.10 before starting WD 3.0.2
If you are already doing that, then I would need ssh access to your odroid to further debug the problem.  PM me if you want to give me remote access.

Rob


On Sat, May 21, 2022 at 1:34 PM <gerhard@...> wrote:

Hi Rob,


 

What I did since:

Installed WD 2.10 on  clean Odroid XU4 without problems and was runing 14 chanals over night.

Now changed to v3.0 and the problem with reconnection to the SDR happend again.


Found the following reports:


odroid@odroid:~/wsprdaemon$ ./wsprdaemon.sh -l e
wsprdaemon.sh Copyright (C) 2020 Robert S. Robinett
This program comes with ABSOLUTELY NO WARRANTY; for details type './wsprdaemon.sh -h'
This is free software, and you are welcome to redistribute it under certain conditions. execute'./wsprdaemon.sh -h' for details.
wsprdaemon depends heavily upon the 'wsprd' program and other technologies developed by Joe Taylor K1JT and others, to whom we are grateful.
Goto https://physics.princeton.edu/pulsar/K1JT/wsjtx.html to learn more about WSJT-x

Checking every 10 seconds for new ERROR lines in all the log files. Press <CONTROL C> to exit
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: odroid 2679 4.0 0.9 35400 19512 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3592.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: So executed 'kill 2679'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3592600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3592600_usb.wav 20220521T201900Z_3592600_usb.wav 20220521T201903Z_3592600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:36 UTC: kill_wav_recording_daemon() killed KIWI_0 80eu job which had pid 2602
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:06 UTC: kiwirecorder_manager_daemon() ERROR: 'ps 2524' reports kiwirecorder.py is running, but there is no log file of its output, so 'kill 2524' and try to restart it
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 3098
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() 'ps 3098' reports error:
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: PID TTY STAT TIME COMMAND
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 18435
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:35 UTC: kiwirecorder_manager_daemon_kill_handler() Killed kiwi_recorder_pid=18435
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: odroid 3098 4.5 0.9 35400 19488 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3568.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: So executed 'kill 3098'
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3568600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3568600_usb.wav 20220521T201900Z_3568600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:24 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:24 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: odroid 2089 3.8 0.9 35400 19724 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=474.2 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: So executed 'kill 2089'
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_474200_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 630 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 630 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_474200_usb.wav 20220521T201900Z_474200_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.60 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:25 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:25 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: odroid 3176 4.2 0.9 35400 19628 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=5364.7 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: So executed 'kill 3176'
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_5364700_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 60eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 60eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_5364700_usb.wav 20220521T201900Z_5364700_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.60 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: odroid 2953 4.0 0.9 35400 19528 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=5287.2 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: So executed 'kill 2953'
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_5287200_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 60 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 60 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_5287200_usb.wav 20220521T201900Z_5287200_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.09 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: odroid 3359 4.2 0.9 35400 19728 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=7038.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: So executed 'kill 3359'
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_7038600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 40 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 40 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_7038600_usb.wav 20220521T201900Z_7038600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:27 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:27 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: odroid 3551 4.4 0.9 35400 19540 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=10138.7 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: So executed 'kill 3551'
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_10138700_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 30 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 30 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_10138700_usb.wav 20220521T201900Z_10138700_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.73 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > odroid@odroid:~/wsprdaemon$ ./wsprdaemon.sh -l e
wsprdaemon.sh Copyright (C) 2020 Robert S. Robinett
This program comes with ABSOLUTELY NO WARRANTY; for details type './wsprdaemon.sh -h'
This is free software, and you are welcome to redistribute it under certain conditions. execute'./wsprdaemon.sh -h' for details.
wsprdaemon depends heavily upon the 'wsprd' program and other technologies developed by Joe Taylor K1JT and others, to whom we are grateful.
Goto https://physics.princeton.edu/pulsar/K1JT/wsjtx.html to learn more about WSJT-x

Checking every 10 seconds for new ERROR lines in all the log files. Press <CONTROL C> to exit
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: odroid 2679 4.0 0.9 35400 19512 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3592.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: So executed 'kill 2679'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3592600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3592600_usb.wav 20220521T201900Z_3592600_usb.wav 20220521T201903Z_3592600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:36 UTC: kill_wav_recording_daemon() killed KIWI_0 80eu job which had pid 2602
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:06 UTC: kiwirecorder_manager_daemon() ERROR: 'ps 2524' reports kiwirecorder.py is running, but there is no log file of its output, so 'kill 2524' and try to restart it
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 3098
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() 'ps 3098' reports error:
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: PID TTY STAT TIME COMMAND
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 18435
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 MSat 21 May 2022 20:22:48 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:48 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: odroid 1907 3.7 0.9 35400 19584 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=136.0 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: So executed 'kill 1907'
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_136000_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 2200 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 2200 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_136000_usb.wav 20220521T201900Z_136000_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > ay 2022 20:19:35 UTC: kiwirecorder_manager_daemon_kilSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: odroid 3834 4.4 0.9 35400 19664 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=14095.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: So executed 'kill 3834'
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_14095600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 20 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 20 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_14095600_usb.wav 20220521T201900Z_14095600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:02.91 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > l_handler() Killed kiwi_recorder_pid=18435
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: odroid 4067 4.4 0.9 35400 19508 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=18104.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: So executed 'kill 4067'
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_18104600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 17 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 17 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_18104600_usb.wav 20220521T201900Z_18104600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.55 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_aSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: odroid 2316 4.1 0.9 35400 19660 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=1836.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: So executed 'kill 2316'
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_1836600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 160 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 160 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_1836600_usb.wav 20220521T201900Z_1836600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.19 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > ll_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleeSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: odroid 4247 4.5 0.9 35400 19636 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=21094.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: So executed 'kill 4247'
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_21094600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 15 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 15 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_21094600_usb.wav 20220521T201900Z_21094600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.28 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > p_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: odroid 4422 4.5 0.9 35400 19624 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=24924.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: So executed 'kill 4422'
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_24924600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 12 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 12 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_24924600_usb.wav 20220521T201900Z_24924600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.55 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > :Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: odroid 4511 4.4 0.9 35400 19520 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=28124.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: So executed 'kill 4511'
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_28124600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 10 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 10 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_28124600_usb.wav 20220521T201900Z_28124600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.32 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > 01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tm

 




There seems to be a problem with the wav-file. I am using Ubuntu with eMMC and external SSD drive, but same problem was seen on a RPi4 with SD-card.

regards

Gerhard OE3GBB


Am 20.05.2022 16:21, schrieb Rob Robinett:

run 'wsprdaemon.sh -l e' and you will see all log lines with "ERROR ..."
they might give you a clue as to why your system isn't working.

On Fri, May 20, 2022 at 7:06 AM <gerhard@...> wrote:

Hi,

 

Have installed V3.0 first on the odroid XU4 (Ubuntu). Istallation seems to be OK, but did not work. The connection to the SDR is allways broken right after 2 minutes. Therefore no decoding and upload. SDR is a Flydog-SDR.

Then tried it on a RPi4, but unfortunatly same problem.

Had to stop now to go to a club reunion.

Will try it tomorrow with a Rasp_SDR.

73 Gerhard OE3GBB

 


Am 20.05.2022 15:23, schrieb Rob Robinett:

I know that in the recent past Jim WA2ZKD has installed WD on his odroid systems.
WD 3.0 includes the option for you to configure it to give me remote access if you need installation help.

On Fri, May 20, 2022 at 3:45 AM <gerhard@...> wrote:

Hello Rob,

great news! I am running the monitor at OE3XOE, at the moment using DigiSkimmer for WSPR and FT8. I will try V3, but I would like to use a Odroid XU4 instead a RPI4. Do you have instructions to install on this hardware?

73 de Gerhard OE3GBB

 


Am 20.05.2022 06:53, schrieb Rob Robinett:

The new Wsprdaemon version 3.0 software running on 20 sites from Maui to Europe is configured to simultaneously decode and report to wsprnet.org WSPR-2 and all of the FST4W-xxx modes on 630M and 160M. i.e. only one Kiwi rx channel is needed to decode all of the modes in every WSPR cycle.

While Spring and Summer are not optimal for those bands, I am seeing FST4W-120, -300 -900 and -1800 spots in Europe and on the East Coast.

On 2200M AI6VN/KH6 in Maui, N6GN in Colorado, and WA2TP in New York are decoding all the FST4W modes.

I expect that soon many the 50+ top spotting stations will be running Wsprdaemon Version 3.0 and extend FST4W listening coverage worldwide.

Hopefully that many FST4W listeners will encourage 2200/630/160 beacons to start transmitting in those modes

The Pi4 has just enough CPU to decode all 15 WSPR (i.e. 22M) bands and all of the FST4W modes on 2200/630/160M.

'git checkout 3.0.2' will get you the latest build (currently 3.0.2.4)
It is compatible with your existing config files, but to decode FST4W modes you will need to add specifications for them to your schedule.




 
--
Rob Robinett
AI6VN
mobile: +1 650 218 8896




 
--
Rob Robinett
AI6VN
mobile: +1 650 218 8896



--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Corrected and more informative wd_template.conf now available in 3.0.2

Rob Robinett
 

I have just checked in a revision of that file which (I hope) fixes a few errors and adds a much more detailed explanation of the settings in your wsprdaemon.conf

For those of you already running 3.0.2, execute 'git pull' to get the new wd_template.conf
'git pull' will never disturb your wsprdaemon.conf
Re: FST4W and 22M now working in version 3.0.2

@OE3GBB
 

Hi Rob,


 

What I did since:

Installed WD 2.10 on  clean Odroid XU4 without problems and was runing 14 chanals over night.

Now changed to v3.0 and the problem with reconnection to the SDR happend again.


Found the following reports:


odroid@odroid:~/wsprdaemon$ ./wsprdaemon.sh -l e
wsprdaemon.sh Copyright (C) 2020 Robert S. Robinett
This program comes with ABSOLUTELY NO WARRANTY; for details type './wsprdaemon.sh -h'
This is free software, and you are welcome to redistribute it under certain conditions. execute'./wsprdaemon.sh -h' for details.
wsprdaemon depends heavily upon the 'wsprd' program and other technologies developed by Joe Taylor K1JT and others, to whom we are grateful.
Goto https://physics.princeton.edu/pulsar/K1JT/wsjtx.html to learn more about WSJT-x

Checking every 10 seconds for new ERROR lines in all the log files. Press <CONTROL C> to exit
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: odroid 2679 4.0 0.9 35400 19512 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3592.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: So executed 'kill 2679'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3592600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3592600_usb.wav 20220521T201900Z_3592600_usb.wav 20220521T201903Z_3592600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:36 UTC: kill_wav_recording_daemon() killed KIWI_0 80eu job which had pid 2602
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:06 UTC: kiwirecorder_manager_daemon() ERROR: 'ps 2524' reports kiwirecorder.py is running, but there is no log file of its output, so 'kill 2524' and try to restart it
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 3098
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() 'ps 3098' reports error:
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: PID TTY STAT TIME COMMAND
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 18435
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:35 UTC: kiwirecorder_manager_daemon_kill_handler() Killed kiwi_recorder_pid=18435
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: odroid 3098 4.5 0.9 35400 19488 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3568.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: So executed 'kill 3098'
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3568600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3568600_usb.wav 20220521T201900Z_3568600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:24 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:24 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: odroid 2089 3.8 0.9 35400 19724 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=474.2 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: So executed 'kill 2089'
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_474200_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 630 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 630 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_474200_usb.wav 20220521T201900Z_474200_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/630/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.60 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:25 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:25 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: odroid 3176 4.2 0.9 35400 19628 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=5364.7 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: So executed 'kill 3176'
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_5364700_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 60eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 60eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_5364700_usb.wav 20220521T201900Z_5364700_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/60eu/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.60 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: odroid 2953 4.0 0.9 35400 19528 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=5287.2 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: So executed 'kill 2953'
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_5287200_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 60 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 60 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_5287200_usb.wav 20220521T201900Z_5287200_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/60/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.09 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:26 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: odroid 3359 4.2 0.9 35400 19728 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=7038.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: So executed 'kill 3359'
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_7038600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 40 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 40 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_7038600_usb.wav 20220521T201900Z_7038600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/40/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:27 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:27 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: odroid 3551 4.4 0.9 35400 19540 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=10138.7 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: So executed 'kill 3551'
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_10138700_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 30 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 30 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_10138700_usb.wav 20220521T201900Z_10138700_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/30/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.73 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > odroid@odroid:~/wsprdaemon$ ./wsprdaemon.sh -l e
wsprdaemon.sh Copyright (C) 2020 Robert S. Robinett
This program comes with ABSOLUTELY NO WARRANTY; for details type './wsprdaemon.sh -h'
This is free software, and you are welcome to redistribute it under certain conditions. execute'./wsprdaemon.sh -h' for details.
wsprdaemon depends heavily upon the 'wsprd' program and other technologies developed by Joe Taylor K1JT and others, to whom we are grateful.
Goto https://physics.princeton.edu/pulsar/K1JT/wsjtx.html to learn more about WSJT-x

Checking every 10 seconds for new ERROR lines in all the log files. Press <CONTROL C> to exit
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:04 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: odroid 2679 4.0 0.9 35400 19512 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=3592.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: So executed 'kill 2679'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_3592600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 80eu W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 80eu W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_3592600_usb.wav 20220521T201900Z_3592600_usb.wav 20220521T201903Z_3592600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/80eu/decoding_daemon.log: Sat 21 May 2022 20:19:36 UTC: kill_wav_recording_daemon() killed KIWI_0 80eu job which had pid 2602
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() Found 8 new ERROR: lines
Sat 21 May 2022 20:20:14 UTC: wd_logger_check_all_logs() There are 8 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:06 UTC: kiwirecorder_manager_daemon() ERROR: 'ps 2524' reports kiwirecorder.py is running, but there is no log file of its output, so 'kill 2524' and try to restart it
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:17:07 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 3098
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() 'ps 3098' reports error:
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: PID TTY STAT TIME COMMAND
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawning new /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 May 2022 20:19:04 UTC: kiwirecorder_manager_daemon() Spawned kiwirecorder.py job with PID 18435
/tmp/wsprdaemon/recording.d/KIWI_0/80/wav_recording_daemon.log: Sat 21 MSat 21 May 2022 20:22:48 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:48 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: odroid 1907 3.7 0.9 35400 19584 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=136.0 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: So executed 'kill 1907'
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_136000_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 2200 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 2200 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_136000_usb.wav 20220521T201900Z_136000_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/2200/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.14 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > ay 2022 20:19:35 UTC: kiwirecorder_manager_daemon_kilSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: odroid 3834 4.4 0.9 35400 19664 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=14095.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: So executed 'kill 3834'
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_14095600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 20 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 20 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_14095600_usb.wav 20220521T201900Z_14095600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/20/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:02.91 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > l_handler() Killed kiwi_recorder_pid=18435
Press <ENTER> to check the next log file >
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: odroid 4067 4.4 0.9 35400 19508 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=18104.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: So executed 'kill 4067'
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_18104600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 17 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 17 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_18104600_usb.wav 20220521T201900Z_18104600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/17/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.55 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > Sat 21 May 2022 20:20:21 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:20:21 UTC: wd_logger_check_aSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: odroid 2316 4.1 0.9 35400 19660 ? Sl 20:17 0:04 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=1836.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: So executed 'kill 2316'
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_1836600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 160 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 160 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_1836600_usb.wav 20220521T201900Z_1836600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/160/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.19 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > ll_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/80/decoding_daemon.log: Sat 21 May 2022 20:19:02 UTC: sleeSat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: odroid 4247 4.5 0.9 35400 19636 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=21094.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: So executed 'kill 4247'
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_21094600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 15 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 15 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_21094600_usb.wav 20220521T201900Z_21094600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/15/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.28 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > p_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: odroid 4422 4.5 0.9 35400 19624 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=24924.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: So executed 'kill 4422'
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_24924600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:03 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 12 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 12 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_24924600_usb.wav 20220521T201900Z_24924600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/12/decoding_daemon.log: Sat 21 May 2022 20:19:07 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:03.55 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > :Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() Found 13 new ERROR: lines
Sat 21 May 2022 20:22:49 UTC: wd_logger_check_all_logs() There are 13 new lines to be printed

/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: sleep_until_raw_file_is_full() ERROR: wav file stabilized at invalid too long duration 00:01:06.08, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: odroid 4511 4.4 0.9 35400 19520 ? Sl 20:17 0:05 python3 -u /home/odroid/wsprdaemon/kiwiclient/kiwirecorder.py --freq=28124.6 --server-host=192.168.1.196 --server-port=8073 --OV --user=wsprdaemon_v3.0.2 --password=NULL --agc-gain=60 --quiet --no_compression --modulation=usb --lp-cutoff=1340 --hp-cutoff=1660 --dt-sec=60
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: So executed 'kill 4511'
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: get_wav_file_list() Error while waiting for the first wav file to fill, 'sleep_until_raw_file_is_full 20220521T201800Z_28124600_usb.wav' => 1
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:04 UTC: decoding_daemon() Error 2 returned by 'get_wav_file_list mode_wav_file_list KIWI_0 10 W2'. 'sleep 1' and retry
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:05 UTC: get_wav_file_list() Start with args 'mode_seconds_files KIWI_0 10 W2', then receiver_modes => W2 => target_minutes=( 2 ) => target_seconds=( 120 )
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:06 UTC: get_wav_file_list() Found raw/wav files '20220521T201800Z_28124600_usb.wav 20220521T201900Z_28124600_usb.wav'
/tmp/wsprdaemon/recording.d/KIWI_0/10/decoding_daemon.log: Sat 21 May 2022 20:19:08 UTC: sleep_until_raw_file_is_full() The wav file stabilized at invalid too short duration 00:00:04.32 which almost always occurs at startup. Flush this file since it can't be used as part of a WSPR wav file
Press <ENTER> to check the next log file > 01:06.03, so there appear to be more than one instance of the KWR running. 'ps' output was:
/tm

 




There seems to be a problem with the wav-file. I am using Ubuntu with eMMC and external SSD drive, but same problem was seen on a RPi4 with SD-card.

regards

Gerhard OE3GBB


Am 20.05.2022 16:21, schrieb Rob Robinett:

run 'wsprdaemon.sh -l e' and you will see all log lines with "ERROR ..."
they might give you a clue as to why your system isn't working.

On Fri, May 20, 2022 at 7:06 AM <gerhard@...> wrote:

Hi,

 

Have installed V3.0 first on the odroid XU4 (Ubuntu). Istallation seems to be OK, but did not work. The connection to the SDR is allways broken right after 2 minutes. Therefore no decoding and upload. SDR is a Flydog-SDR.

Then tried it on a RPi4, but unfortunatly same problem.

Had to stop now to go to a club reunion.

Will try it tomorrow with a Rasp_SDR.

73 Gerhard OE3GBB

 


Am 20.05.2022 15:23, schrieb Rob Robinett:

I know that in the recent past Jim WA2ZKD has installed WD on his odroid systems.
WD 3.0 includes the option for you to configure it to give me remote access if you need installation help.

On Fri, May 20, 2022 at 3:45 AM <gerhard@...> wrote:

Hello Rob,

great news! I am running the monitor at OE3XOE, at the moment using DigiSkimmer for WSPR and FT8. I will try V3, but I would like to use a Odroid XU4 instead a RPI4. Do you have instructions to install on this hardware?

73 de Gerhard OE3GBB

 


Am 20.05.2022 06:53, schrieb Rob Robinett:

The new Wsprdaemon version 3.0 software running on 20 sites from Maui to Europe is configured to simultaneously decode and report to wsprnet.org WSPR-2 and all of the FST4W-xxx modes on 630M and 160M. i.e. only one Kiwi rx channel is needed to decode all of the modes in every WSPR cycle.

While Spring and Summer are not optimal for those bands, I am seeing FST4W-120, -300 -900 and -1800 spots in Europe and on the East Coast.

On 2200M AI6VN/KH6 in Maui, N6GN in Colorado, and WA2TP in New York are decoding all the FST4W modes.

I expect that soon many the 50+ top spotting stations will be running Wsprdaemon Version 3.0 and extend FST4W listening coverage worldwide.

Hopefully that many FST4W listeners will encourage 2200/630/160 beacons to start transmitting in those modes

The Pi4 has just enough CPU to decode all 15 WSPR (i.e. 22M) bands and all of the FST4W modes on 2200/630/160M.

'git checkout 3.0.2' will get you the latest build (currently 3.0.2.4)
It is compatible with your existing config files, but to decode FST4W modes you will need to add specifications for them to your schedule.




 
--
Rob Robinett
AI6VN
mobile: +1 650 218 8896




 
--
Rob Robinett
AI6VN
mobile: +1 650 218 8896
Re: WD 3.0.2.4 update adds improved support for 'noise level only' bands

Jim Lill
 

with CHU close by to NY.... we might find similar of use here

On 5/21/22 14:17, Rob Robinett wrote:
 In response to a user request, have tested and checked in enhancements to 3.0.2.4 which add support for the feature you requested which runs the quickest wsprd on those 'noise level only' bands like WWV_10.  You can see the noise level charts produced for those bands like WWV_10 at: http://wsprdaemon.org/graphs/NorthernUtahSDR/

In your conf file schedule you can explicitly define  mode 'W0"  (that is a zero) , e.g. "00:00 KIWI1,WWV_10,W0"
But W0 is now the default mode for those bands, so "00:00 KIWI1,WWV_10" defaults to W0.
Since this mode is a pure enhancement of  the functionality of 3.0.2.4 and (I think) the NortherUtahSDR (KA7OEI-1) site is the only user of those WWV_x bands, I haven't incremented the version number.

So if you run 'git pull' on a WD directory in which 'git checkout 3.0.2' has been run, you will see several files updated.  But if you don't have one of those WWV_x bands defined in your schedule, there should be no change in the operation of your site.
1 - 20 of 888