2025/08/17 09:30:06 00000000 s >> OSCam << cardserver log switched, version 2.25.05-11884@76c92a2c (x86_64-linux-gnu-ssl-libdvbcsa-upx)
2025/08/17 09:30:06 00000000 s (main) System name = Linux
2025/08/17 09:30:06 00000000 s (main) Host name = BM2LTS-VT
2025/08/17 09:30:06 00000000 s (main) Release = 6.15.2-x64v3-xanmod1
2025/08/17 09:30:06 00000000 s (main) Version = #0~20250610.g2c02535 SMP PREEMPT_DYNAMIC Tue Jun 10 19:22:57 UTC
2025/08/17 09:30:06 00000000 s (main) Machine = x86_64
2025/08/17 09:30:06 00000000 s (main) creating pidfile /var/run/cardserver.pid with pid 6106
2025/08/17 09:30:06 00000000 s (config) userdb reloaded: 2 accounts loaded, 0 expired, 0 disabled
2025/08/17 09:30:06 00000000 s (main) signal handling initialized
2025/08/17 09:30:06 00000000 s (net) monitor: initialized (fd=5, port=17777)
2025/08/17 09:30:06 00000000 s (reader) orf_k4-p4_irdeto_650 [mouse] creating thread for device /dev/ttyUSB0
2025/08/17 09:30:06 00000000 s (main) waiting for local card init
2025/08/17 09:30:06 64D2F9DE h (webif) webif: decompressed 178034 bytes back into 477536 bytes
2025/08/17 09:30:06 64D2F9DE h (webif) HTTP Server running. ip=:: port=8888 (no SSL)
2025/08/17 09:30:07 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=600, cardmhz=600)
2025/08/17 09:30:07 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] card detected
2025/08/17 09:30:09 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] ATR: 3B 78 12 00 00 54 C4 03 00 8F F1 90 00
2025/08/17 09:30:09 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Setting baudrate to 32258 bps
2025/08/17 09:30:10 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Hist. Bytes: T�
2025/08/17 09:30:10 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] detect irdeto card
2025/08/17 09:30:10 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Warning: needed try nr 2, next ECM has some delay
2025/08/17 09:30:12 33FE14B9 r (-) -- Skipped 1 duplicated log lines --
2025/08/17 09:30:12 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] card detected
2025/08/17 09:30:12 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] type: CryptoWorks
2025/08/17 09:30:13 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Warning: needed try nr 2, next ECM has some delay
2025/08/17 09:30:13 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] card system not supported
2025/08/17 09:30:13 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Normal mode failed, reverting to Deprecated Mode
2025/08/17 09:30:15 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] ATR: 3B 78 12 00 00 54 C4 03 00 8F F1 90 00
2025/08/17 09:30:16 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Hist. Bytes: T�
2025/08/17 09:30:16 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] detect irdeto card
2025/08/17 09:30:16 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] Irdeto SC 60 version 1 revision 0, patch level 0
2025/08/17 09:30:16 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] caid: 0650, acs: 0.06, country code: AUT
2025/08/17 09:30:16 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] active providers: 4 #############################
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [mouse] found card system irdeto
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max allotted of 1
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] entitlements for provider: 1, id: ######
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 000D, date: 2020/07/30 - 2020/08/29
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 0001, date: 2025/08/16 - 2026/04/23
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 0002, date: 2025/08/16 - 2026/04/23
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 7FF7, date: 2025/08/16 - 2025/08/26
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: FFE0, date: 2025/08/06 - 2026/04/13
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 7FFB, date: 2025/08/16 - 2025/09/15
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] entitlements for provider: 2, id: ######
2025/08/17 09:30:17 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 001D, date: 2020/07/30 - 2020/08/29
2025/08/17 09:30:18 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] entitlements for provider: 4, id: ######
2025/08/17 09:30:18 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] chid: 0031, date: 2020/07/30 - 2020/08/29
2025/08/17 09:30:18 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] ready for requests
2025/08/17 09:30:19 00000000 s (main) init for all local cards done
2025/08/17 09:30:19 00000000 s (anticasc) anti cascading disabled
2025/08/17 09:30:19 17930610 c (client) plain dvbapi-client granted (dvbapi, au=auto (2 reader))
2025/08/17 09:30:19 17930610 c (dvbapi) dvbapi channelcache loaded from /etc/oscam/oscam.ccache
2025/08/17 09:30:19 17930610 c (dvbapi) Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11
2025/08/17 09:30:42 17930610 c (dvbapi) Client connected: 'vdr-plugin-dvbapi 2.2.8-BM2LTS / VDR 2.7.7' (protocol version = 2)
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0648 ECM_PID: 0078 PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0650 ECM_PID: 007A PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0D95 ECM_PID: 010E PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 0D98 ECM_PID: 0110 PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 06E2 ECM_PID: 0140 PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 5 CAID: 0500 ECM_PID: 01CD PROVID: 051900
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 6 CAID: 098D ECM_PID: 01D6 PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 7 CAID: 09C4 ECM_PID: 01E0 PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 ecmpid 8 CAID: 098C ECM_PID: 01EA PROVID: 000000
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 found 9 ECM pids and 3 STREAM pids in CA PMT
2025/08/17 09:30:42 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415842 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:42 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415842 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:42 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415842 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:42 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:43 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415843 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:43 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415843 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:43 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415843 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:43 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415843 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:43 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:44 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:44 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415844 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:44 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:44 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:44 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415844 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:44 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
...
2025/08/17 09:30:51 17930610 c (dvbapi) Warning reader orf_k4-p4_irdeto_650 received no emms for the last 1755415851 seconds -> skip, this reader needs emms first!
2025/08/17 09:30:51 17930610 c (dvbapi) Demuxer 0 impossible to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A PMTPID 0000 (NO MATCHING READER)
2025/08/17 09:30:51 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] dvbapi emmtype=global, len=36 (hex: 0x24), cnt=0: written (112 ms)
2025/08/17 09:30:51 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:51 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:51 33FE14B9 r (reader) orf_k4-p4_irdeto_650 [irdeto] dvbapi emmtype=global, len=36 (hex: 0x24), cnt=0: written (115 ms)
2025/08/17 09:30:51 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (155 ms) by orf_k4-p4_irdeto_650 (orf_k4-p4_irdeto_650 need global EMMs first) (lg)
2025/08/17 09:30:52 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:52 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:52 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (1 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:52 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:52 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:52 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:53 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:53 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:53 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:53 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:53 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:54 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:54 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:54 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:54 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:55 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:55 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:55 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:55 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:55 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:55 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:56 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:56 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:56 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:30:56 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:56 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:30:57 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:336FD54342E00E3C7DC85841ECCE7C1F): not found (157 ms) by orf_k4-p4_irdeto_650 (orf_k4-p4_irdeto_650 need global EMMs first) (lg)
2025/08/17 09:30:57 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:30:57 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
...
2025/08/17 09:32:10 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:32:10 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:32:10 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:91895C4574A0A77D781F44BE9B983EF7): not found (0 ms) by orf_k4-p4_irdeto_650
2025/08/17 09:32:10 17930610 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 8 disabled ecmpids!
2025/08/17 09:32:10 17930610 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0650 PROVID 000000 ECMPID 007A ANY CHID PMTPID 0000 VPID 0780
2025/08/17 09:32:11 17930610 c (ecm) dvbapi (0650@000000/0000/132F/4E:A59328433A87579335EA0FE6303EE18B): found (189 ms) by orf_k4-p4_irdeto_650 (lg