Waiting for waterfall after new install

Hello,
After a re install of my SatNogs system (same Raspi, but new install), I have an issue with the station:
It stays on ‘…waiting for waterfall’, “waiting for audio” and “waiting for data”… With the previous install I never had this issue.

When logging with journalctl , I see this error when an observation starts:

Aug 04 22:00:14 raspberrypi satnogs-client[17127]: [INFO] Using format CF32.
Aug 04 22:00:14 raspberrypi satnogs-client[17127]: Could not find port: freq in:
Aug 04 22:00:14 raspberrypi satnogs-client[17127]: freq
Aug 04 22:00:14 raspberrypi satnogs-client[17127]: system
Aug 04 22:00:14 raspberrypi satnogs-client[17127]: 2
Aug 04 22:00:14 raspberrypi satnogs-client[17127]: Traceback (most recent call last):

See my logging file of an observation of NOAA19:

*Aug 04 21:15:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:16:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:16:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Post data started
Aug 04 21:17:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:18:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:19:05 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Spawning observer worker.
Aug 04 21:19:05 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Start rotctrl thread.
Aug 04 21:19:05 raspberrypi satnogs-client[12477]: satnogsclient.observer.worker - INFO - Tracking initiated
Aug 04 21:19:05 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Start rigctrl thread.
Aug 04 21:19:05 raspberrypi satnogs-client[12477]: satnogsclient.observer.worker - INFO - Tracking initiated
Aug 04 21:19:06 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Start gnuradio thread.
Aug 04 21:19:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:19:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Post data started
Aug 04 21:19:17 raspberrypi satnogs-client[12477]: Found Rafael Micro R820T tuner
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: Found Rafael Micro R820T tuner
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: [R82XX] PLL not locked!
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: [INFO] Using format CF32.
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: Could not find port: freq in:
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: system
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: freq
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: 4
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: Traceback (most recent call last):
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/bin/satnogs_cw_decoder.py”, line 459, in
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: main()
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/bin/satnogs_cw_decoder.py”, line 444, in main
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: tb = top_block_cls(antenna=options.antenna, bb_freq=options.bb_freq, bfo_freq=options.bfo_freq, bw=options.bw, dc_removal=options.dc_removal, decoded_data_file_path=options.decoded_data_file_path, dev_args=options.dev_args, doppler_correction_per_sec=options.doppler_correction_per_sec, enable_iq_dump=options.enable_iq_dump, file_path=options.file_path, gain=options.gain, gain_mode=options.gain_mode, iq_file_path=options.iq_file_path, lo_offset=options.lo_offset, other_settings=options.other_settings, ppm=options.ppm, rigctl_port=options.rigctl_port, rx_freq=options.rx_freq, samp_rate_rx=options.samp_rate_rx, soapy_rx_device=options.soapy_rx_device, stream_args=options.stream_args, tune_args=options.tune_args, udp_IP=options.udp_IP, udp_port=options.udp_port, waterfall_file_path=options.waterfall_file_path, wpm=options.wpm)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/bin/satnogs_cw_decoder.py”, line 129, in init
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: self.satnogs_doppler_compensation_0 = satnogs.doppler_compensation(samp_rate_rx, rx_freq, lo_offset, audio_samp_rate, 1, 0)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/lib/python3/dist-packages/satnogs/doppler_compensation.py”, line 147, in init
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: self.doppler, “freq”)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/lib/python3/dist-packages/gnuradio/gr/hier_block2.py”, line 60, in wrapped
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: func(self, src.to_basic_block(), srcport, dst.to_basic_block(), dstport)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/lib/python3/dist-packages/gnuradio/gr/hier_block2.py”, line 132, in msg_connect
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: self.primitive_msg_connect(*args)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: File “/usr/lib/python3/dist-packages/gnuradio/gr/runtime_swig.py”, line 3665, in primitive_msg_connect
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: return _runtime_swig.hier_block2_sptr_primitive_msg_connect(self, *args)
Aug 04 21:19:18 raspberrypi satnogs-client[12477]: RuntimeError: invalid msg port in connect() or disconnect()
Aug 04 21:19:21 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Tracking stopped.
Aug 04 21:19:21 raspberrypi satnogs-client[12477]: satnogsclient.observer.worker - INFO - Tracking stopped.
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.worker - INFO - Tracking stopped.
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Observation Finished
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Executing post-observation script.
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Rename encoded file for uploading finished
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.observer - INFO - Creating waterfall plot.
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: satnogsclient.observer.waterfall - INFO - Read waterfall file
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: apscheduler.executors.default - ERROR - Job “spawn_observer (trigger: date[2020-08-04 20:19:05 UTC], next run at: 2020-08-04 20:19:05 UTC)” raised an exception
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: Traceback (most recent call last):
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/usr/lib/python3/dist-packages/apscheduler/executors/base.py”, line 125, in run_job
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: retval = job.func(*job.args, **job.kwargs)
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/var/lib/satnogs/lib/python3.7/site-packages/satnogsclient/scheduler/tasks.py”, line 55, in spawn_observer
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: observer.observe()
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/var/lib/satnogs/lib/python3.7/site-packages/satnogsclient/observer/observer.py”, line 165, in observe
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: self.plot_waterfall()
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/var/lib/satnogs/lib/python3.7/site-packages/satnogsclient/observer/observer.py”, line 267, in plot_waterfall
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: waterfall_png=self.observation_waterfall_png)
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/var/lib/satnogs/lib/python3.7/site-packages/satnogsclient/observer/waterfall.py”, line 39, in plot_waterfall
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: waterfall = read_waterfall(waterfall_file)
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: File “/var/lib/satnogs/lib/python3.7/site-packages/satnogsclient/observer/waterfall.py”, line 22, in read_waterfall
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: ‘timestamp’: np.fromfile(wf_file, dtype=’|S32’, count=1)[0],
Aug 04 21:19:23 raspberrypi satnogs-client[12477]: IndexError: index 0 is out of bounds for axis 0 with size 0
Aug 04 21:20:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:21:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:22:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:22:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Post data started
Aug 04 21:22:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to PUT observation data for id: 2649365
Aug 04 21:22:11 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Upload successful.
Aug 04 21:23:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
Aug 04 21:24:10 raspberrypi satnogs-client[12477]: satnogsclient.scheduler.tasks - INFO - Trying to GET observation jobs from the network
*

Support log:

Generating support report. Please wait…
------------[ copy here ]------------
{
“versions”: {
“satnogs-client”: “1.3.4”,
“satnogs-client-ansible”: “202007160921”,
“satnogs-flowgraphs”: “1.2.2-1”,
“gr-satnogs”: “2.1.2.1-1”,
“gr-soapy”: “2.1.3-1”,
“gnuradio”: “3.8.0.0-6”,
“satnogs-config”: “0.10.2”
},
“state”: {
“is-applied”: true,
“pending-tags”: null
},
“system”: {
“date”: “2020-08-04T20:39:19.178894+00:00”,
“distribution”: {
“DESCRIPTION”: “Raspbian GNU/Linux 10 (buster)”,
“RELEASE”: “10”,
“CODENAME”: “buster”,
“ID”: “Raspbian”
},
“pending-updates”: true,
“platform”: {
“system”: “Linux”,
“node”: “raspberrypi”,
“release”: “4.19.97-v7+”,
“version”: “#1294 SMP Thu Jan 30 13:15:58 GMT 2020”,
“machine”: “armv7l”,
“processor”: “”
},
“memory”: {
“total”: 971059200,
“available”: 777916416,
“percent”: 19.9,
“used”: 116137984,
“free”: 413261824,
“active”: 295108608,
“inactive”: 179388416,
“buffers”: 65302528,
“cached”: 376356864,
“shared”: 12521472,
“slab”: 65208320
},
“disk”: {
“total”: 7568015360,
“used”: 3310313472,
“free”: 3902746624,
“percent”: 45.9
}
},
“configuration”: {
“satnogs_antenna”: “RX”,
“satnogs_api_token”: “[redacted]”,
“satnogs_log_level”: “INFO”,
“satnogs_rf_gain”: “32.8”,
“satnogs_rx_samp_rate”: “2.048e6”,
“satnogs_soapy_rx_device”: “driver=rtlsdr”,
“satnogs_station_elev”: “20”,
“satnogs_station_id”: “479”,
“satnogs_station_lat”: “50.931117”,
“satnogs_station_lon”: “3.0923”
}
}
------------[ copy end ]-------------

Somebody who has an idea what is going wrong here?

Best 73’s, ON4API

It looks like you still have pending updates to be applied. That gnuradio version doesn’t look right.

Try running Update, then Apply again in satnogs-setup.

1 Like

Hello Mark,

An update resolved the issue. Thank you very much for the help.
I updated using sudo satnogs-upgrade , reboot Still had an error:

/var/lib/satnogs/.gnuradio/prefs/vmcircbuf_default_factory: No such file or directory
vmcircbuf_createfilemapping: createfilemapping is not available*
gr::vmcircbuf_sysv_shm: shmat (2): Invalid argument

But after I started and applied the settings from Satnogs-setup , no errors anymore.
Now still some observations to do as test, but I already had some data from NOAA19 at a few ° elevation.

73s, Krist ON4API

1 Like