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!
Pierre
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
-
Klaus Schmidinger -
Pierre-Yves Paranthoen (PERSO)