search

catalinii / minisatip

minisatip is an SATIP server for linux using local DVB-S2, DVB-C, DVB-T or ATSC cards
https://minisatip.org
324 stars 78 forks source link

PID Continuity error #1135

Open minrim opened 6 months ago

minrim commented 6 months ago

Hi, I have multicam server 4x dual cams tbs 6950. Mostly on HD channel is see errors in log PID Continuity error. At this time channel freeze (graphs also confirm some problem). SD channels from same tp working good (a lot of better, we see less PID Continuity errors). Maybe its possible to modify somehow to make hd channels works better? Maybe its some decryption bug with HD channel?

Commands: root 1865 4.0 0.0 243056 4328 ? Ssl 07:00 3:59 /usr/bin/minisatip -E -G -B 700 -f -y 551 -l http,dvb -e 1 -x 8081 root 1872 5.1 0.0 243056 4368 ? Ssl 07:00 5:02 /usr/bin/minisatip -E -G -B 700 -f -y 553 -l http,dvb -e 3 -x 8083 root 1876 4.0 0.0 243056 4280 ? Ssl 07:00 3:58 /usr/bin/minisatip -E -G -B 700 -f -y 552 -l http,dvb -e 2 -x 8082 root 1883 5.7 0.0 243056 4536 ? Ssl 07:00 5:40 /usr/bin/minisatip -E -G -B 700 -f -y 554 -l http,dvb -e 4 -x 8084 root 1885 4.2 0.0 243024 4140 ? Ssl 07:00 4:13 /usr/bin/minisatip -E -G -B 700 -f -y 555 -l http,dvb -e 5 -x 8085 root 1887 0.0 0.0 169168 3492 ? Ssl 07:00 0:04 /usr/bin/minisatip -E -G -B 700 -f -y 557 -l http,dvb -e 7 -x 8087 root 1892 0.0 0.0 242900 4072 ? Ssl 07:00 0:04 /usr/bin/minisatip -E -G -B 700 -f -y 556 -l http,dvb -e 6 -x 8086 root 1895 3.8 0.0 243056 4280 ? Ssl 07:00 3:50 /usr/bin/minisatip -E -G -B 700 -f -y 550 -l http,dvb -e 0 -x 8080

LOG at freeze time:

Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.119 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.102 AD3]: PID Continuity error (adapter 3, pos 150): pid: 018, Expected CC: 4, Actual CC: 5, CC Before 3
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.102 AD3]: PID Continuity error (adapter 3, pos 109): pid: 4421, Expected CC: 1, Actual CC: 5, CC Before 0 encrypted
Dec 07 07:26:56 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:55 moipro minisatip[1872]: [07/12 07:26:55.205 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:55 moipro minisatip[1872]: [07/12 07:26:55.100 main]: BW 1228 KB/s, DMX 1267 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 619, r: 25, w: 25 fw: 0, tt: 15 ms
Dec 07 07:26:55 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:54 moipro minisatip[1872]: [07/12 07:26:54.289 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:54 moipro minisatip[1872]: [07/12 07:26:54.085 main]: BW 1090 KB/s, DMX 1126 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 568, r: 23, w: 23 fw: 0, tt: 13 ms
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.985 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.962 AD3]: Expiring CW 0 for pmt 8: id 0, parity 1, pmt 8, time 229201 ms ago, expiry in 10000 ms, CW: 09 81 F0 8A 44 CD 4E 87, IV: 5C 8B D1 81 04 B1 D0 CD
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.962 AD3]: found CW: 2 [validated] for PMT 8, old cw 1, packets 249, parity 1, pid 4420: id 2, parity 1, pmt 8, time 9329 ms ago, expiry in 3710671 ms, CW: 5E CF 2D FB C3 58 E5 DD,
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.962 AD3]: Parity change for PMT 8, new active parity 1 pid 4421 [47 11 45 DE 04 25 11]
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.896 AD3]: ca_write_apdu: CA 3, session 4, name CIPLUS_APP_CC_RESOURCEID_TWO, write tag 9F9010, data length 40
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.896 AD3]: ______________________ci_ccmgr_cc_sac_send______________________
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.896 AD3]: SEND ------------ CC_SAC_SYNC_CNF-----------
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.896 AD3]: RECV ciplus cc msg CAM3, session_num 4, tag 9f9009 len 24 dt_id 0
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.896 AD3]: ca_read_apdu: CA 3, session 4, name CIPLUS_APP_CC_RESOURCEID_TWO, read tag 9F9009, data length 24
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.280 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.076 main]: BW 841 KB/s, DMX 879 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 475, r: 24, w: 24 fw: 0, tt: 11 ms
Dec 07 07:26:53 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:52 moipro minisatip[1872]: [07/12 07:26:52.366 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:58 moipro minisatip[1872]: [07/12 07:26:58.252 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:58 moipro minisatip[1872]: [07/12 07:26:58.148 main]: BW 826 KB/s, DMX 864 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 465, r: 24, w: 24 fw: 0, tt: 11 ms
Dec 07 07:26:58 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:57 moipro minisatip[1872]: [07/12 07:26:57.338 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:57 moipro minisatip[1872]: [07/12 07:26:57.134 main]: BW 911 KB/s, DMX 949 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 540, r: 24, w: 24 fw: 0, tt: 12 ms
Dec 07 07:26:57 moipro minisatip[1872]: [07/12 07:26:57.034 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:26:57 moipro minisatip[1872]: Message repeated 1 times
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.423 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.119 main]: BW 1007 KB/s, DMX 1045 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 569, r: 24, w: 24 fw: 0, tt: 13 ms
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.119 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.102 AD3]: PID Continuity error (adapter 3, pos 150): pid: 018, Expected CC: 4, Actual CC: 5, CC Before 3
Dec 07 07:26:56 moipro minisatip[1872]: [07/12 07:26:56.102 AD3]: PID Continuity error (adapter 3, pos 109): pid: 4421, Expected CC: 1, Actual CC: 5, CC Before 0 encrypted
Dec 07 07:26:56 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:55 moipro minisatip[1872]: [07/12 07:26:55.205 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:55 moipro minisatip[1872]: [07/12 07:26:55.100 main]: BW 1228 KB/s, DMX 1267 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 619, r: 25, w: 25 fw: 0, tt: 15 ms
Dec 07 07:26:55 moipro minisatip[1872]: Message repeated 2 times
Dec 07 07:26:54 moipro minisatip[1872]: [07/12 07:26:54.289 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:26:54 moipro minisatip[1872]: [07/12 07:26:54.085 main]: BW 1090 KB/s, DMX 1126 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 568, r: 23, w: 23 fw: 0, tt: 13 ms
Dec 07 07:26:53 moipro minisatip[1872]: [07/12 07:26:53.985 main]: get_signal_new adapter 3: status 31, strength -29900 dBm -> 45940, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
-----------------------

Dec 07 07:15:45 moipro minisatip[1883]: [07/12 07:15:45.955 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:45 moipro minisatip[1883]: [07/12 07:15:45.750 signal]: BW 1145 KB/s, DMX 1183 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 609, r: 24, w: 24 fw: 0, tt: 14 ms
Dec 07 07:15:45 moipro minisatip[1883]: Message repeated 2 times
Dec 07 07:15:45 moipro minisatip[1883]: [07/12 07:15:45.041 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.803 AD4]: found CW: 1 [validated] for PMT 15, old cw 2, packets 177, parity 0, pid 5560: id 1, parity 0, pmt 15, time 110725 ms ago, expiry in 3609275 ms, CW: 8D BD 04 E6 F9 EC 6E
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.803 AD4]: Parity change for PMT 15, new active parity 0 pid 5561 [47 15 B9 9E D5 7A 67]
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.803 AD4]: found CW: 2 [not validated] for PMT 15, old cw 1, packets 4, parity 1, pid 5560: id 2, parity 1, pmt 15, time 797 ms ago, expiry in 3719203 ms, CW: 75 61 AB 04 5F 10 B6 F
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.803 AD4]: Parity change for PMT 15, new active parity 1 pid 5561 [47 95 B9 D9 90 5F 14]
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.802 AD4]: PID Continuity error (adapter 4, pos 83): pid: 5561, Expected CC: 9, Actual CC: E, CC Before 8 encrypted
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.737 signal]: BW 1179 KB/s, DMX 1217 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 591, r: 24, w: 24 fw: 0, tt: 14 ms
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.737 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.433 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.128 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: ca_write_apdu: CA 4, session 4, name CIPLUS_APP_CC_RESOURCEID_TWO, write tag 9F9008, data length 56
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: ______________________ci_ccmgr_cc_sac_send______________________
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: CW 2 for PMT 15 (), master 15, pid 5560, for next parity, id 2, parity 1, pmt 15, time 0 ms ago, expiry in 3720000 ms, CW: 75 61 AB 04 5F 10 B6 FB, IV: 87 2B 34 FA B9 E3 A
Dec 07 07:15:44 moipro minisatip[1883]: IV: 87 2B 34 FA B9 E3 A8 56 61 B2 88 9F D1 67 35 C3
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: received from CI+ CAM 4: KEY: 75 61 AB 04 5F 10 B6 FB 07 87 BC 51 51 5C 10 4C
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: auth ok!
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: RECV ciplus cc msg CAM4, session_num 4, tag 9f9007 len 88 dt_id 0
Dec 07 07:15:44 moipro minisatip[1883]: [07/12 07:15:44.006 AD4]: ca_read_apdu: CA 4, session 4, name CIPLUS_APP_CC_RESOURCEID_TWO, read tag 9F9007, data length 88
Dec 07 07:15:43 moipro minisatip[1883]: [07/12 07:15:43.824 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:43 moipro minisatip[1883]: [07/12 07:15:43.720 signal]: BW 1275 KB/s, DMX 1313 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 684, r: 24, w: 24 fw: 0, tt: 16 ms
Dec 07 07:15:43 moipro minisatip[1883]: Message repeated 1 times
Dec 07 07:15:43 moipro minisatip[1883]: [07/12 07:15:43.215 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:42 moipro minisatip[1883]: [07/12 07:15:42.910 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:42 moipro minisatip[1883]: [07/12 07:15:42.704 signal]: BW 1385 KB/s, DMX 1423 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 746, r: 24, w: 24 fw: 0, tt: 17 ms
Dec 07 07:15:42 moipro minisatip[1883]: Message repeated 1 times
Dec 07 07:15:42 moipro minisatip[1883]: [07/12 07:15:42.300 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:41 moipro minisatip[1883]: [07/12 07:15:41.995 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:41 moipro minisatip[1883]: [07/12 07:15:41.691 signal]: BW 1382 KB/s, DMX 1420 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 735, r: 24, w: 24 fw: 0, tt: 17 ms
Dec 07 07:15:41 moipro minisatip[1883]: [07/12 07:15:41.691 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:41 moipro minisatip[1883]: Message repeated 2 times
Dec 07 07:15:40 moipro minisatip[1883]: [07/12 07:15:40.776 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:40 moipro minisatip[1883]: [07/12 07:15:40.672 signal]: BW 1341 KB/s, DMX 1378 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 729, r: 24, w: 24 fw: 0, tt: 17 ms
Dec 07 07:15:40 moipro minisatip[1883]: [07/12 07:15:40.471 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:40 moipro minisatip[1883]: Message repeated 1 times
Dec 07 07:15:39 moipro minisatip[1883]: [07/12 07:15:39.862 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15500 dB -> 12697, BER: 0, dB: 155, err 0
Dec 07 07:15:39 moipro minisatip[1883]: [07/12 07:15:39.658 signal]: BW 1270 KB/s, DMX 1309 KB/s, Buffered 0.0 MB, Dropped: 0.0 MB, ns/read 705, r: 25, w: 25 fw: 0, tt: 17 ms
Dec 07 07:15:39 moipro minisatip[1883]: [07/12 07:15:39.558 signal]: get_signal_new adapter 4: status 31, strength -26300 dBm -> 48299, snr 15250 dB -> 12492, BER: 0, dB: 152, err 0
Dec 07 07:15:39 moipro minisatip[1883]: Message repeated 1 times

hd_channel hd_channel1 sd_channel

lars18th commented 6 months ago

Hi @minrim ,

Just out of curiosity, with what tool did you generate those diagrams?

minrim commented 6 months ago

Hi @minrim ,

Just out of curiosity, with what tool did you generate those diagrams?

Hi, Graphs is generated with tool Grafana

lars18th commented 6 months ago

Hi @minrim , Just out of curiosity, with what tool did you generate those diagrams?

Hi, Graphs is generated with tool Grafana

And you can share the configuration? I want to add my minisatip server to it.

Thank you.

minrim commented 6 months ago

Its not so simple to paste. First you need setup database influxdb -> using paid cesbo astra add stream to astra -> setup astra to export data to influxdb -> last step configure grafana to use influxdb with data from astra. Regards,

lars18th commented 6 months ago

Hi @minrim ,

Now I see it... you use Cesbo's Astra to collect the data.

Please, can you share an example of the data exported to influxdb? Perhaps we can try to do similar with minisatip.

Jalle19 commented 1 week ago

Does the channel freeze indefinitely, or does playback resume after the glitch?