search

deeptho / neumodvb

neumoDVB DVB-S2/DVB-T/DVB-C settop box and DX program for Linux
Other
17 stars 8 forks source link

set TONE cmd missing #14

Closed psyborg55 closed 2 years ago

psyborg55 commented 2 years ago

there is this bug observed for a while now, with both HW and SW algo drivers at certain point switching between lower and upper band stops working, if i tune the freq that failed in neumo with tvheadend then i can tune it with neumo afterwards, but going back to freq at other band fails again requiring another tvheadend tune

i noticed there is no FE_SET_TONE in kernel debug output, whereas with tvheadend it was always present

[59575.353643] dvb_frontend: dvb_frontend_do_ioctl:2404: algo_ctrl requested
[59575.353650] dvb_frontend: dvb_frontend_handle_algo_ctrl_ioctl:2346: entering DTV_STOP: stop_task
[59575.390864] dvb_frontend: dvb_frontend_handle_algo_ctrl_ioctl:2350: DTV_STOP starts stop_task
[59575.390872] dvb_frontend: dvb_frontend_handle_algo_ctrl_ioctl:2355: DTV_STOP done stop_task
[59575.391048] dvb_frontend: dvb_frontend_handle_ioctl:3193: FE_SET_VOLTAGE 0
[59575.831018] dvb_frontend: dtv_property_process_set:2233: cmd=DTV_CLEAR
[59575.831032] dvb_frontend: dvbv5_set_delivery_system:1859: desired_system=6
[59575.831037] dvb_frontend: dvbv5_set_delivery_system:1868: desired_system=6
[59575.831040] dvb_frontend: dvbv5_set_delivery_system:1877: trying delsys [0]=5 <> 6
[59575.831044] dvb_frontend: dvbv5_set_delivery_system:1877: trying delsys [1]=6 <> 6
[59575.831047] dvb_frontend: dvbv5_set_delivery_system:1880: found delsys [1]=6 <> 6
[59575.831051] dvb_frontend: dtv_property_process_set:2304: cmd=17 data=6 ret=0
[59575.831055] dvb_frontend: dtv_property_process_set:2304: cmd=4 data=9 ret=0
[59575.831058] dvb_frontend: dtv_property_process_set:2304: cmd=3 data=1574400 ret=0
[59575.831061] dvb_frontend: dtv_property_process_set:2304: cmd=8 data=29701172 ret=0
[59575.831065] dvb_frontend: dtv_property_process_set:2304: cmd=9 data=2 ret=0
[59575.831068] dvb_frontend: dtv_property_process_set:2304: cmd=6 data=2 ret=0
[59575.831071] dvb_frontend: dtv_property_process_set:2304: cmd=13 data=0 ret=0
[59575.831074] dvb_frontend: dtv_property_process_set:2304: cmd=12 data=2 ret=0
[59575.831077] dvb_frontend: dtv_property_process_set:2304: cmd=42 data=-1 ret=0
[59575.831081] checking frequency
[59575.831094] dvb_frontend: dtv_property_process_set:2250: cmd=DTV_TUNE r=0
[59575.831097] dvb_frontend: dtv_property_process_set:2304: cmd=87 data=500 ret=0

also a fraction of log at the time the tune could not be completed

2022-04-28 15:24:34,319 DEBUG: [tuner TUN-CMD] ~active_stream_t
 iver/active_stream.h:366
2022-04-28 15:24:34,319 DEBUG: [tuner TUN-CMD] demux_fd was already closed ver/active_stream.cc:151
2022-04-28 16:12:35,218 DEBUG: [neumodvb ] UpdateRefMux: rec.k.sat_pos=700 self.sat.sat_pos=700 positioner_dialog.py:498
2022-04-28 16:12:35,219 DEBUG: [neumodvb ] saving ref_mux=7.0E 11324V positioner_dialog.py:510
2022-04-28 16:12:35,219 DEBUG: [neumodvb ] positioner: subscribing to lnb=D0A0Ku rotor 32767 mux=7.0E 11324V positioner_dialog.py:312
2022-04-28 16:12:35,250 DEBUG: [neumodvb ] SelectRecord 7.0E 11324V neumolist.py:1138
2022-04-28 16:12:35,252 DEBUG: [neumodvb ] Tuning - REGULAR scan: 7.0E 11324V pls_search_range=None positioner_dialog.py:294
2022-04-28 16:12:35,252 DEBUG: [receiver  RECEIVER-CMD SUB[-1] 7.0E 11324V] setting scan_done=false (init) /active_si_stream.cc:64
2022-04-28 16:12:35,253 DEBUG: [receiver  RECEIVER-CMD SUB[-1] 7.0E 11324V] starting frontend_monitor 0x7f3ae0002ec0: fefd=62
 ceiver/fe_monitor.cc:49
2022-04-28 16:12:35,253 DEBUG: [receiver  RECEIVER-CMD SUB[-1] 7.0E 11324V] Subscribed to: 7.0E 11324V receiver/receiver.cc:589
2022-04-28 16:12:35,253 DEBUG: [tuner TUN-CMD] tune mux action src/receiver/tune.cc:151
2022-04-28 16:12:35,253 DEBUG: [fe 0.0 ] frontend_monitor run: 0x7f3ae0002ec0: fefd=62
 ceiver/fe_monitor.cc:160
2022-04-28 16:12:35,253 DEBUG: [tuner TUN-CMD] Tuning to DVBS mux 7.0E 11324V diseqc: lnb_id=D0A0Ku rotor 32767 UCX er/active_adapter.cc:176
2022-04-28 16:12:35,253 DEBUG: [tuner TUN-CMD] set_current_tp: sat_pos changed from -32767 to 700 ver/active_adapter.h:268
2022-04-28 16:12:35,290 DEBUG: [tuner TUN-CMD] tune: change_delivery_system done er/active_adapter.cc:189
2022-04-28 16:12:35,290 DEBUG: [fe 0.0 ] SIGNAL: signal=0 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:35,290 DEBUG: [tuner TUN-CMD] SENDING diseqc: retune_count=0 mode=2 er/active_adapter.cc:701
2022-04-28 16:12:35,730 DEBUG: [tuner TUN-CMD] tune: do_lnb_and_diseqc done er/active_adapter.cc:197
2022-04-28 16:12:35,730 DEBUG: [tuner TUN-CMD] /home/tom/neumodvb/src/receiver/active_adapter.cc_203 TIME: 439 vb/src/util/logger.h:168
2022-04-28 16:12:35,730 DEBUG: [tuner TUN-CMD] Using adapter  0 er/active_adapter.cc:415
2022-04-28 16:12:35,731 DEBUG: [tuner TUN-CMD] tune_it returning ret=0 receiver/frontend.cc:1120
2022-04-28 16:12:35,731 DEBUG: [tuner TUN-CMD] ret=0 er/active_adapter.cc:444
2022-04-28 16:12:35,731 DEBUG: [tuner TUN-CMD] Now ret=0 er/active_adapter.cc:472
2022-04-28 16:12:35,731 DEBUG: [tuner TUN-CMD] tune: tune_it done ret=0
 er/active_adapter.cc:205
2022-04-28 16:12:35,733 DEBUG: [fe 0.0 ] SIGNAL: signal=0 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:35,853 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:35,854 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:35,865 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:36,503 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:36,509 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:37,144 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:37,150 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:37,783 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:37,789 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:38,430 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:38,436 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:39,063 DEBUG: [fe 0.0 ] SIGNAL: signal=1 carrier=0 viterbi=0 sync=0 lock=0 timedout=0
 ceiver/fe_monitor.cc:120
2022-04-28 16:12:39,069 DEBUG: [neumodvb ] SignalPanel: NO LONGER LOCKED positioner_dialog.py:615
2022-04-28 16:12:39,387 DEBUG: [neumodvb ] positioner: unsubscribing positioner_dialog.py:344
2022-04-28 16:12:39,390 DEBUG: [receiver  RECEIVER-CMD] Release fe =0x7f3ae0002ec0 src/receiver/tune.cc:435
2022-04-28 16:12:39,390 DEBUG: [receiver  RECEIVER-CMD] releasing frontend_monitor 0x7f3ae0002ec0: fefd=62
 ceiver/devmanager.cc:861
2022-04-28 16:12:39,390 DEBUG: [fe 0.0 ] frontend_monitor end: 0x7f3ae0002ec0: fefd=62
 ceiver/fe_monitor.cc:185
2022-04-28 16:12:39,390 DEBUG: [fe 0.0 ] closing fefd=62 receiver/frontend.cc:142
2022-04-28 16:12:39,394 DEBUG: [tuner TUN-CMD] Adapter 0 frontend 0 destroyed
 er/active_adapter.cc:735
2022-04-28 16:12:39,394 DEBUG: [tuner TUN-CMD] ~active_stream_t
 iver/active_stream.h:366
2022-04-28 16:12:39,394 DEBUG: [tuner TUN-CMD] demux_fd was already closed ver/active_stream.cc:151
deeptho commented 2 years ago

Should be fixed now