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: