[vdr] Upgrading from 1.4.7 to 1.7.0 : enabling #define

Klaus Schmidinger Klaus.Schmidinger at cadsoft.de
Fri May 2 16:40:59 CEST 2008


On 04/25/08 18:34, Pierre-Yves Paranthoen (PERSO) wrote:
> I increased the values in ci.c. A bit better but, still no decryption 
> and channel not available :
>  
> #define MODULE_CHECK_INTERVAL 10000 // ms
> #define MODULE_RESET_TIMEOUT    5 // s
> gives under 1.7.0 :
>  
>  
> Apr 25 18:29:04 localhost vdr: [7317] CAM 2: module ready
> Apr 25 18:29:11 localhost vdr: [7317] CAM 2: doesn't reply to QUERY - 
> only a single channel can be decrypted
> Apr 25 18:29:11 localhost vdr: [7313] switching to channel 2
> Apr 25 18:29:11 localhost vdr: [7313] CAM 2: assigned to device 1
> Apr 25 18:29:11 localhost vdr: [7328] transfer thread started (pid=7313, 
> tid=7328)
> Apr 25 18:29:11 localhost vdr: [7329] receiver on device 1 thread 
> started (pid=7313, tid=7329)
> Apr 25 18:29:11 localhost vdr: [7330] TS buffer on device 1 thread 
> started (pid=7313, tid=7330)
> Apr 25 18:29:11 localhost vdr: [7313] setting watchdog timer to 20 seconds
> Apr 25 18:29:12 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 71 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:29:12 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 70 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:29:12 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 72 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:29:12 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 6F 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:29:12 localhost vdr: [7319] CAM: 88C0 212012  8801 0100 1 - 09 
> 89 01 00 F5 8C 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 88 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 8B 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 8A A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E5 EC 00 86 FF 00 00 00
> Apr 25 18:29:13 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DF 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:29:13 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DD 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:29:13 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 E0 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:29:13 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DE 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:29:13 localhost vdr: [7319] CAM: 88C0 212012  8802 0100 1 - 09 
> 89 01 00 F5 F9 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 F5 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 F4 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 F8 A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E6 59 00 86 FF 00 00 00
> Apr 25 18:29:14 localhost vdr: [7323] EPGSearch: timer conflict check 
> started
> Apr 25 18:29:14 localhost vdr: [7323] EPGSearch: timer conflict check 
> finished
> Apr 25 18:29:18 localhost vdr: [7313] max. latency time 1 seconds
> Apr 25 18:29:53 localhost vdr: [7322] connect from 192.168.3.245, port 
> 53838 - accepted
> Apr 25 18:29:59 localhost vdr: [7328] transfer thread ended (pid=7313, 
> tid=7328)
> Apr 25 18:30:00 localhost vdr: [7313] switching to channel 3
> Apr 25 18:30:00 localhost vdr: [7313] buffer stats: 5640 (0%) used
> Apr 25 18:30:00 localhost vdr: [7330] TS buffer on device 1 thread ended 
> (pid=7313, tid=7330)
> Apr 25 18:30:00 localhost vdr: [7329] buffer stats: 5264 (0%) used
> Apr 25 18:30:00 localhost vdr: [7334] transfer thread started (pid=7313, 
> tid=7334)
> Apr 25 18:30:00 localhost vdr: [7329] receiver on device 1 thread ended 
> (pid=7313, tid=7329)
> Apr 25 18:30:00 localhost vdr: [7335] receiver on device 1 thread 
> started (pid=7313, tid=7335)
> Apr 25 18:30:00 localhost vdr: [7336] TS buffer on device 1 thread 
> started (pid=7313, tid=7336)
> Apr 25 18:30:00 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 71 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:00 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 70 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:00 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 72 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:00 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 6F 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:00 localhost vdr: [7319] CAM: 88C0 212012  8801 0100 1 - 09 
> 89 01 00 F5 8C 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 88 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 8B 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 8A A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E5 EC 00 86 FF 00 00 00
> Apr 25 18:30:01 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DF 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:01 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DD 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:01 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 E0 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:01 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DE 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:01 localhost vdr: [7319] CAM: 88C0 212012  8802 0100 1 - 09 
> 89 01 00 F5 F9 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 F5 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 F4 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 F8 A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E6 59 00 86 FF 00 00 00
> Apr 25 18:30:04 localhost vdr: [7334] transfer thread ended (pid=7313, 
> tid=7334)
> Apr 25 18:30:04 localhost vdr: [7336] TS buffer on device 1 thread ended 
> (pid=7313, tid=7336)
> Apr 25 18:30:04 localhost vdr: [7335] buffer stats: 94188 (4%) used
> Apr 25 18:30:04 localhost vdr: [7335] receiver on device 1 thread ended 
> (pid=7313, tid=7335)
> Apr 25 18:30:04 localhost vdr: [7313] switching to channel 3
> Apr 25 18:30:04 localhost vdr: [7313] buffer stats: 47752 (2%) used
> Apr 25 18:30:04 localhost vdr: [7313] info: Channel not available!
> Apr 25 18:30:06 localhost vdr: [7313] max. latency time 2 seconds
> Apr 25 18:30:13 localhost vdr: [7313] switching to channel 1
> Apr 25 18:30:13 localhost vdr: [7338] transfer thread started (pid=7313, 
> tid=7338)
> Apr 25 18:30:13 localhost vdr: [7339] receiver on device 1 thread 
> started (pid=7313, tid=7339)
> Apr 25 18:30:14 localhost vdr: [7340] TS buffer on device 1 thread 
> started (pid=7313, tid=7340)
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8351 0500 0 - 09 
> 0F 05 00 F9 AC 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8351 0500 0 - 09 
> 0F 05 00 F9 AD 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8351 0500 0 - 09 
> 0F 05 00 F9 AE 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8351 0100 1 - 09 
> 5C 01 00 F5 C6 33 17 FF 40 00 00 00 00 00 00 04 24 99 F5 C3 33 11 FF 00 
> 02 0C 02 00 04 08 04 24 99 F5 C4 A8 21 FF 00 00 00 00 C0 00   00 00 24 
> 99 E6 25 00 85 FF 00 00 00 00 00 00 00 02 24 99 E6 24 00 84 FF 00 00 04
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8374 0500 0 - 09 
> 0F 05 00 FA 94 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:14 localhost vdr: [7319] CAM: 88C0 211895  8374 0100 1 - 09 
> 3E 01 00 E7 09 00 81 FF 00 00 04 00 00 00 08 02 24 5B E7 08 00 80 FF 40 
> 00 06 08 40 00 00 02 24 5B F6 A9 33 15 FF 00 00 0C 00 00 00   00 06 24 
> 5B F6 A8 33 11 FF 00 00 0E 02 00 00 00 02 24 5B
> Apr 25 18:30:15 localhost vdr: [7319] CAM: 88C0 211895  8372 0500 0 - 09 
> 0F 05 00 FA BC 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:15 localhost vdr: [7319] CAM: 88C0 211895  8372 0100 1 - 09 
> 3E 01 00 E7 31 00 81 FF 00 00 04 00 00 00 08 02 24 5B E7 30 00 80 FF 40 
> 00 06 02 40 00 00 02 24 5B F6 D1 33 15 FF 00 00 0C 00 00 00   00 06 24 
> 5B F6 D0 33 11 FF 00 00 0E 02 00 00 00 02 24 5B
> Apr 25 18:30:15 localhost vdr: [7319] CAM: 88C0 211895  8371 0500 0 - 09 
> 0F 05 00 FA 76 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:15 localhost vdr: [7319] CAM: 88C0 211895  8371 0100 1 - 09 
> 3E 01 00 E6 EB 00 81 FF 00 00 04 00 00 00 08 02 24 5B E6 EA 00 80 FF 40 
> 00 06 10 40 00 00 02 24 5B F6 8B 33 15 FF 00 00 0C 00 00 00   00 06 24 
> 5B F6 8A 33 11 FF 00 00 0E 02 00 00 00 02 24 5B
> Apr 25 18:30:17 localhost vdr: [7338] transfer thread ended (pid=7313, 
> tid=7338)
> Apr 25 18:30:17 localhost vdr: [7340] TS buffer on device 1 thread ended 
> (pid=7313, tid=7340)
> Apr 25 18:30:17 localhost vdr: [7339] buffer stats: 104528 (4%) used
> Apr 25 18:30:17 localhost vdr: [7339] receiver on device 1 thread ended 
> (pid=7313, tid=7339)
> Apr 25 18:30:18 localhost vdr: [7313] switching to channel 1
> Apr 25 18:30:18 localhost vdr: [7313] buffer stats: 51512 (2%) used
> Apr 25 18:30:18 localhost vdr: [7313] info: Channel not available!
> Apr 25 18:30:25 localhost vdr: [7313] switching to channel 2
> Apr 25 18:30:25 localhost vdr: [7342] transfer thread started (pid=7313, 
> tid=7342)
> Apr 25 18:30:25 localhost vdr: [7343] receiver on device 1 thread 
> started (pid=7313, tid=7343)
> Apr 25 18:30:25 localhost vdr: [7344] TS buffer on device 1 thread 
> started (pid=7313, tid=7344)
> Apr 25 18:30:26 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 71 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:26 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 70 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:26 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 72 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:26 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 6F 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:26 localhost vdr: [7319] CAM: 88C0 212012  8801 0100 1 - 09 
> 89 01 00 F5 8C 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 88 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 8B 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 8A A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E5 EC 00 86 FF 00 00 00
> Apr 25 18:30:27 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DF 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:27 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DD 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:27 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 E0 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:27 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DE 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:27 localhost vdr: [7319] CAM: 88C0 212012  8802 0100 1 - 09 
> 89 01 00 F5 F9 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 F5 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 F4 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 F8 A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E6 59 00 86 FF 00 00 00
> Apr 25 18:30:32 localhost vdr: [7313] switching to channel 3
> Apr 25 18:30:32 localhost vdr: [7342] transfer thread ended (pid=7313, 
> tid=7342)
> Apr 25 18:30:32 localhost vdr: [7313] buffer stats: 0 (0%) used
> Apr 25 18:30:32 localhost vdr: [7345] transfer thread started (pid=7313, 
> tid=7345)
> Apr 25 18:30:32 localhost vdr: [7344] TS buffer on device 1 thread ended 
> (pid=7313, tid=7344)
> Apr 25 18:30:32 localhost vdr: [7343] buffer stats: 24628 (1%) used
> Apr 25 18:30:32 localhost vdr: [7343] receiver on device 1 thread ended 
> (pid=7313, tid=7343)
> Apr 25 18:30:32 localhost vdr: [7346] receiver on device 1 thread 
> started (pid=7313, tid=7346)
> Apr 25 18:30:33 localhost vdr: [7347] TS buffer on device 1 thread 
> started (pid=7313, tid=7347)
> Apr 25 18:30:33 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 71 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:33 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 70 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:33 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 72 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:33 localhost vdr: [7319] CAM: 88C0 212012  8801 0500 0 - 09 
> 0F 05 00 F9 6F 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:33 localhost vdr: [7319] CAM: 88C0 212012  8801 0100 1 - 09 
> 89 01 00 F5 8C 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 88 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 8B 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 8A A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E5 EC 00 86 FF 00 00 00
> Apr 25 18:30:34 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DF 10 01 01 13 01 20 14 03 00 83 00
> Apr 25 18:30:34 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DD 10 01 01 13 01 20 14 03 03 0B 00
> Apr 25 18:30:34 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 E0 10 01 01 13 01 20 14 03 02 26 10
> Apr 25 18:30:34 localhost vdr: [7319] CAM: 88C0 212012  8802 0500 0 - 09 
> 0F 05 00 F9 DE 10 01 01 13 01 20 14 03 03 28 20
> Apr 25 18:30:34 localhost vdr: [7319] CAM: 88C0 212012  8802 0100 1 - 09 
> 89 01 00 F5 F9 33 17 FF 40 00 00 00 08 00 80 44 24 99 F5 F5 33 15 FF 00 
> 00 0C 00 00 00 00 06 24 99 F5 F4 33 11 FF 00 00 0E 02 00 00   00 02 24 
> 99 F5 F8 A8 21 FF 20 00 01 00 00 00 04 4E 24 99 E6 59 00 86 FF 00 00 00
> Apr 25 18:30:36 localhost vdr: [7345] transfer thread ended (pid=7313, 
> tid=7345)
> Apr 25 18:30:36 localhost vdr: [7347] TS buffer on device 1 thread ended 
> (pid=7313, tid=7347)
> Apr 25 18:30:36 localhost vdr: [7346] buffer stats: 100016 (4%) used
> Apr 25 18:30:36 localhost vdr: [7346] receiver on device 1 thread ended 
> (pid=7313, tid=7346)
> Apr 25 18:30:37 localhost vdr: [7313] switching to channel 3
> Apr 25 18:30:37 localhost vdr: [7313] buffer stats: 36284 (1%) used
> Apr 25 18:30:37 localhost vdr: [7313] info: Channel not available!
> Apr 25 18:30:48 localhost vdr: [7313] confirm: CAM is in use - really reset?
> Apr 25 18:30:48 localhost vdr: [7313] warning: CAM is in use - really reset?
> Apr 25 18:30:49 localhost vdr: [7313] confirmed
> Apr 25 18:30:53 localhost vdr: [7313] confirm: CAM is in use - really reset?
> Apr 25 18:30:53 localhost vdr: [7313] warning: CAM is in use - really reset?
> Apr 25 18:30:54 localhost vdr: [7313] confirmed
> Apr 25 18:30:58 localhost vdr: [7313] ERROR: Can't open CAM menu!

Looks like there are no CAM resets, so there must be a different reason
why VDR thinks the channel is not available.

Please add some debug output to cDevice::GetDevice(const cChannel *Channel, int Priority, bool LiveView)
to find out why this is happening.

Klaus



More information about the vdr mailing list