Entschlüsselung hängt nach 10 Sekunden - Standbild

[hotlein]

@Enigmafreak:

Die beiden Dorcel-Sender liegen auch auf einem anderen Transponder.

So, ich habe mal das log von VDR 2.2.0 zu Gemüte geführt.

log für Hustler (wenn entschlüsselt wird):

Spoiler: Hustler

Jan 27 11:42:16 (MLD) user.info vdr: [1061] switching to channel 145 (Hustler TV)
Jan 27 11:42:16 (MLD) user.debug vdr: [2897] device 2 receiver thread ended (pid=1061, tid=2897)
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] CAM 2: assigned to device 2
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 CA_PMT decoding len=12a lm=4 prg=4107 len=40
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(G)=01
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: pid=2,025f len=109 (0x6d)
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(S)=01
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: pid=4,0093 len=109 (0x6d)
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(S)=01
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 got CA pmt ciCmd=1 caLm=4
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 answer to query suppressed
Jan 27 11:42:16 (MLD) user.info vdr: [1061] DVBAPI: 1.0 set CAM decrypt (SID 4107 (0x100B), caLm 4, HasCaDescriptors 1)
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: send: channelSid=0x100b (4107)
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: Write, sock=19
Jan 27 11:42:16 (MLD) user.debug vdr: [1061] DVBAPI: socket_fd=19 len=308 wrote=308
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] device 2 receiver thread started (pid=1061, tid=2902, prio=high)
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=0, demux_idx=0, filter_num=0
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0000 start=1, demux=0, filter=0
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=0
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=1, demux_idx=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0001 start=1, demux=0, filter=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_STOP request, adapter_index=1, pid=1, demux_idx=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0001 start=0, demux=0, filter=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleting filter, demux=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleted the last filter for pid=0001, removing list
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=921, demux_idx=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0921 start=1, demux=0, filter=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: F0 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: saving first part of data
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=129
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: filter data assembled, sending len=312
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] DVBAPI: Write, sock=19
Jan 27 11:42:16 (MLD) user.debug vdr: [2902] DVBAPI: socket_fd=19 len=318 wrote=318
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=921, demux_idx=0, filter_num=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0921 start=1, demux=0, filter=1
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:16 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.-1: set pid 0x025f
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: set pid 0x025f
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.-1: set pid 0x0093
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: set pid 0x0093
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: even key set
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: odd key set
Jan 27 11:42:17 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: saving first part of data
Jan 27 11:42:17 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=129
Jan 27 11:42:17 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: filter data assembled, sending len=312
Jan 27 11:42:17 (MLD) user.debug vdr: [2902] DVBAPI: Write, sock=19
Jan 27 11:42:17 (MLD) user.debug vdr: [2902] DVBAPI: socket_fd=19 len=318 wrote=318
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=921, demux_idx=0, filter_num=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0921 start=1, demux=0, filter=1
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 81 00 00 00 00 00 05 0F 00 00 00 00 00 00 00 00
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 FF FF 00 00 00 00 00 00 00 00
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: odd key set
Jan 27 11:42:26 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=11, demux_idx=0, filter_num=2
Jan 27 11:42:26 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0011 start=1, demux=0, filter=2
Jan 27 11:42:26 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 42 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:26 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:42:26 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=2
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: saving first part of data
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=85
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: filter data assembled, sending len=1004
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Write, sock=19
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: socket_fd=19 len=1010 wrote=1010
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_STOP request, adapter_index=1, pid=11, demux_idx=0, filter_num=2
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0011 start=0, demux=0, filter=2
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleting filter, demux=0, filter_num=2
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleted the last filter for pid=0011, removing list
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: saving first part of data
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: PUSI=0, to_copy=129
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Analyze: filter data assembled, sending len=312
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: Write, sock=19
Jan 27 11:42:27 (MLD) user.debug vdr: [2902] DVBAPI: socket_fd=19 len=318 wrote=318
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=921, demux_idx=0, filter_num=1
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0921 start=1, demux=0, filter=1
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 80 00 00 00 00 00 05 0F 00 00 00 00 00 00 00 00
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 FF FF 00 00 00 00 00 00 00 00
Jan 27 11:42:27 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:42:28 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:42:28 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:42:28 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: even key set

log für Vivid (wenn nicht entschlüsselt wird) :

Spoiler: Vivid

Jan 27 11:44:00 (MLD) user.info vdr: [1061] switching to channel 146 (Vivid)
Jan 27 11:44:00 (MLD) user.debug vdr: [2915] device 2 receiver thread ended (pid=1061, tid=2915)
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] CAM 2: assigned to device 2
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 CA_PMT decoding len=fc lm=4 prg=4064 len=34
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(G)=01
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: pid=2,0234 len=92 (0x5c)
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(S)=01
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: pid=4,005a len=92 (0x5c)
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: ci_cmd(S)=01
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 got CA pmt ciCmd=1 caLm=4
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: 1.0 answer to query suppressed
Jan 27 11:44:00 (MLD) user.info vdr: [1061] DVBAPI: 1.0 set CAM decrypt (SID 4064 (0x0FE0), caLm 4, HasCaDescriptors 1)
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: send: channelSid=0xfe0 (4064)
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: Write, sock=19
Jan 27 11:44:00 (MLD) user.debug vdr: [1061] DVBAPI: socket_fd=19 len=262 wrote=262
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] device 2 receiver thread started (pid=1061, tid=2922, prio=high)
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=0, demux_idx=0, filter_num=0
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0000 start=1, demux=0, filter=0
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=0
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=1, demux_idx=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0001 start=1, demux=0, filter=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_STOP request, adapter_index=1, pid=1, demux_idx=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0001 start=0, demux=0, filter=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleting filter, demux=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleted the last filter for pid=0001, removing list
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=D92, demux_idx=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0D92 start=1, demux=0, filter=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: F0 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: saving first part of data
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=129
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: filter data assembled, sending len=312
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] DVBAPI: Write, sock=19
Jan 27 11:44:00 (MLD) user.debug vdr: [2922] DVBAPI: socket_fd=19 len=318 wrote=318
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=D92, demux_idx=0, filter_num=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0D92 start=1, demux=0, filter=1
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:00 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.-1: set pid 0x0234
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: set pid 0x0234
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.-1: set pid 0x005a
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_PID request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: set pid 0x005a
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: even key set
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:44:01 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: odd key set
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: saving first part of data
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=129
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: filter data assembled, sending len=312
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] DVBAPI: Write, sock=19
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] DVBAPI: socket_fd=19 len=318 wrote=318
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=D92, demux_idx=0, filter_num=1
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0D92 start=1, demux=0, filter=1
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 81 00 00 00 00 00 05 0F 00 00 00 00 00 00 00 00
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 FF FF 00 00 00 00 00 00 00 00
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] detaching receiver - won't decrypt channel -0-0-0 with CAM 2
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: 0.0: odd key set
Jan 27 11:44:10 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_SET_FILTER request, adapter_index=1, pid=11, demux_idx=0, filter_num=2
Jan 27 11:44:10 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0011 start=1, demux=0, filter=2
Jan 27 11:44:10 (MLD) user.debug vdr: [1329] DVBAPI: --> FILTER: 42 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:10 (MLD) user.debug vdr: [1329] DVBAPI: --> MASK: FF 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Jan 27 11:44:10 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: inserting new filter, demux=0, filter_num=2
Jan 27 11:44:10 (MLD) user.info vdr: [1326] SATIP: Idle timeout - releasing [device 1]
Jan 27 11:44:10 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: saving first part of data
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: saving first part of data
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=184
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: PUSI=0, to_copy=85
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Analyze: filter data assembled, sending len=1004
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: Write, sock=19
Jan 27 11:44:12 (MLD) user.debug vdr: [2922] DVBAPI: socket_fd=19 len=1010 wrote=1010
Jan 27 11:44:12 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got DMX_STOP request, adapter_index=1, pid=11, demux_idx=0, filter_num=2
Jan 27 11:44:12 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: adapter=1 set FILTER pid=0011 start=0, demux=0, filter=2
Jan 27 11:44:12 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleting filter, demux=0, filter_num=2
Jan 27 11:44:12 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: deleted the last filter for pid=0011, removing list

Einen großen Unterschied sehe ich hier:

Spoiler

Hustler:
Jan 27 11:42:17 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:42:18 (MLD) user.debug vdr: [1329] DVBAPI: 0.0:  odd key set

Vivid:
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: SetFilter: filter update, demux=0, filter_num=1
Jan 27 11:44:05 (MLD) user.debug vdr: [2922] detaching receiver - won't decrypt channel -0-0-0 with CAM 2
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=1
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: SetDescr
Jan 27 11:44:05 (MLD) user.debug vdr: [1329] DVBAPI: 0.0:  odd key set

VDR ist hier der Meinung, daß er den Kanal nicht entschlüsseln kann. Ich habe mal die beiden cDevice::Action von VDR 2.2.0 und VDR 2.3.8 verglichen, die sind beide völlig unterschiedlich. Kann hier jemand weiterhelfen?

Gruß hotlein

 

[Enigmafreak]

Hallo,
schade, dass sich hier noch nichts getan hat. Problem besteht (zumindest bei mir) immer noch.

@hotlein
Hast du zwischenzeitlich eine Lösung?

 

[hotlein]

Nein, leider nicht. Ich komme auch erst am Wochenende dazu, mir den Quelltext mal näher anzuschauen, ich kann allerdings nicht versprechen, daß ich da durchsteige.

Gruß hotlein

Hab mal zwei Zeilen in device.c auskommentiert. Die Entschlüsselung läuft nun. Da es sich um den Test des TS_SCRAMBLING_TIMEOUT handelt, kann ich nicht sagen welche Nebeneffekte das hat. Es handelt sich um die Zeilen 1595 und 1596.

Gruß hotlein

@Link ist nicht mehr aktiv.:

Da Du ja MLD verwendest kannst Du "Timeout zur Entschlüsselung (s)" im OSD hochsetzen. Ich hatte mal ein paar Debugausgaben in den Quelltext eingebaut. Der größte Wert war 12s. Wenn Du als z.B. 15s nimmst, sollte Dein Problem behoben sein.

Gruß holten

 

[Enigmafreak]

@hotlein

Das wären ja tolle Nachrichten!
Nur, wo finde ich denn den Schalter im OSD/Menü von MLD um die Werte entsprechend einzutragen?

@Link ist nicht mehr aktiv.:

Da Du ja MLD verwendest kannst Du "Timeout zur Entschlüsselung (s)" im OSD hochsetzen. Ich hatte mal ein paar Debugausgaben in den Quelltext eingebaut. Der größte Wert war 12s. Wenn Du als z.B. 15s nimmst, sollte Dein Problem behoben sein.

Gruß holten

Das ist so nicht ganz richtig. MLD lief bei mir ursprünglich auf dem Raspi, dort traten dann auch erstmalig im September 17 die Probleme auf, weswegen ich damals den Thread startete.
Das Problem verschwand aber nach ein paar Tagen von selbst.

Auf meinem Desktop läuft yaVDR.
MLD 5.4 wurde dort nur installiert, um zu testen, ob das Porblem auch unter MLD auftritt. Was es aber nicht tat. Grundsätzlich möchte ich auf dem Desktop (zumindest erstmal) gerne wieder zurück zu yaVDR.
Vielleicht hättest du oder aber auch andere Mitleser einen Hinweis, ob und wo ich den entsprechenden o.g. Menüpunkt/Schalter in yaVDR finden kann. Sofern es den dort gibt. Das wäre toll.
Dank dir für deine Mühe!
Gruß
Enigmafreak


Update 6.2.:
Bin leider immer noch nicht weiter. Kein yaVDR-User hier, der mir sagen könnte, ob oder wo ich die Option

Timeout zur Entschlüsselung (s) = 15

bei yaVDR einbauen kann?

Den entsprechenden Menüpunkt bei MLD habe ich leider ebenfalls noch nicht gefunden.

 

[hotlein]

Moin,

wenn der Patch in yaVDR nicht drinnen ist, dann mußt Du Dir den VDR aus den Quellen selbst bauen. Anbei der patch:

Spoiler: vdr_scrambletime.patch

diff -Nur vdr-2.2.0/config.c vdr-2.2.0-Scramble/config.c
--- vdr-2.2.0/config.c 2016-09-13 22:41:36.000000000 +0200
+++ vdr-2.2.0-Scramble/config.c 2016-09-13 23:00:35.425006487 +0200
@@ -399,6 +399,8 @@
PowerdownEnabled = 0;
PowerdownTimeoutM = 15;
PowerdownWakeupH = 4;
+ ScrambleTimeout = 3;
+ ScrambleLock = 10;
SetSystemTime = 0;
TimeSource = 0;
ChannelBlocker = 0;
@@ -634,6 +636,8 @@
else if (!strcasecmp(Name, "PowerdownEnabled")) PowerdownEnabled = atoi(Value);
else if (!strcasecmp(Name, "PowerdownTimeoutM")) PowerdownTimeoutM = atoi(Value);
else if (!strcasecmp(Name, "PowerdownWakeupH")) PowerdownWakeupH = atoi(Value);
+ else if (!strcasecmp(Name, "ScrambleTimeout")) ScrambleTimeout = atoi(Value);
+ else if (!strcasecmp(Name, "ScrambleLock")) ScrambleLock = atoi(Value);
else if (!strcasecmp(Name, "SetSystemTime")) SetSystemTime = atoi(Value);
else if (!strcasecmp(Name, "TimeSource")) TimeSource = cSource::FromString(Value);
else if (!strcasecmp(Name, "TimeTransponder")) TimeTransponder = atoi(Value);
@@ -773,6 +777,8 @@
Store("PowerdownEnabled", PowerdownEnabled);
Store("PowerdownTimeoutM", PowerdownTimeoutM);
Store("PowerdownWakeupH", PowerdownWakeupH);
+ Store("ScrambleTimeout", ScrambleTimeout);
+ Store("ScrambleLock", ScrambleLock);
Store("SetSystemTime", SetSystemTime);
Store("TimeSource", cSource::ToString(TimeSource));
Store("TimeTransponder", TimeTransponder);
diff -Nur vdr-2.2.0/config.h vdr-2.2.0-Scramble/config.h
--- vdr-2.2.0/config.h 2016-09-13 22:41:36.000000000 +0200
+++ vdr-2.2.0-Scramble/config.h 2016-09-13 23:01:45.961006795 +0200
@@ -283,6 +283,8 @@
int PowerdownEnabled;
int PowerdownTimeoutM;
int PowerdownWakeupH;
+ int ScrambleTimeout;
+ int ScrambleLock;
int SetSystemTime;
int TimeSource;
int TimeTransponder;
diff -Nur vdr-2.2.0/device.c vdr-2.2.0-Scramble/device.c
--- vdr-2.2.0/device.c 2016-09-13 22:41:36.000000000 +0200
+++ vdr-2.2.0-Scramble/device.c 2016-09-13 23:12:35.597009629 +0200
@@ -1625,8 +1625,8 @@
return false;
}

-#define TS_SCRAMBLING_TIMEOUT 3 // seconds to wait until a TS becomes unscrambled
-#define TS_SCRAMBLING_TIME_OK 10 // seconds before a Channel/CAM combination is marked as known to decrypt
+//#define TS_SCRAMBLING_TIMEOUT 3 // seconds to wait until a TS becomes unscrambled
+//#define TS_SCRAMBLING_TIME_OK 10 // seconds before a Channel/CAM combination is marked as known to decrypt

void cDevice::Action(void)
{
@@ -1648,10 +1648,10 @@
if (CamSlotNumber) {
int t = time(NULL) - startScrambleDetection;
if (TsIsScrambled(b)) {
- if (t > TS_SCRAMBLING_TIMEOUT)
+ if (t > Setup.ScrambleTimeout)
DetachReceivers = true;
}
- else if (t > TS_SCRAMBLING_TIME_OK) {
+ else if (t > Setup.ScrambleLock) {
DescramblingOk = true;
startScrambleDetection = 0;
}
diff -Nur vdr-2.2.0/menu.c vdr-2.2.0-Scramble/menu.c
--- vdr-2.2.0/menu.c 2016-09-13 22:41:36.000000000 +0200
+++ vdr-2.2.0-Scramble/menu.c 2016-09-13 22:55:22.017005120 +0200
@@ -3431,5 +3431,7 @@
}
Add(new cMenuEditBoolItem(tr("Setup.DVB$Enable teletext support"), &data.SupportTeletext));
+ Add(new cMenuEditIntItem(tr("Setup.DVB$Scramble Timeout"), &data.ScrambleTimeout));
+ Add(new cMenuEditIntItem(tr("Setup.DVB$Scramble Lock"), &data.ScrambleLock));

SetCurrent(Get(current));
Display();
diff -Nur vdr-2.2.0/po/de_DE.po vdr-2.2.0-Scramble/po/de_DE.po
--- vdr-2.2.0/po/de_DE.po 2016-09-13 22:41:47.000000000 +0200
+++ vdr-2.2.0-Scramble/po/de_DE.po 2016-09-13 23:10:18.637009032 +0200
@@ -1075,6 +1075,12 @@
msgid "Setup.DVB$Channel Blocker"
msgstr "Tuner des primären DVB blocken"

+msgid "Setup.DVB$Scramble Timeout"
+msgstr "Timeout zur Entschlüsselung (s)"
+
+msgid "Setup.DVB$Scramble Lock"
+msgstr "Zeit bis zur bestätigten Entschlüsselung (s)"
+
msgid "LNB"
msgstr "LNB"

Gruß hotlein

 

[Enigmafreak]

Das übersteigt dann meine "Künste" um ein Vielfaches...
Trotzdem vielen Dank für deine Mühe.
Vielleicht liest das ja noch der ein oder andere yaVDR-User und gibt mir weitere Hilfestellung.
Gruß
Enigmafreak