nuggelbeb
Freak
- Registriert
- 26. Mai 2013
- Beiträge
- 216
- Reaktionspunkte
- 40
- Punkte
- 88
Hallo, nach dem ich mein Problem im Pogo Forum nicht lösen konnte, hat man mir geraten ich sollte mich an die Jungs vom Oscam Forum im Digital Eliteboard wenden. Ich hoffe ich bin hier richtig und ich drücke mich richtig aus. Nun das Problem ist das hell werden der ORF-Sender. Die Konfiguration ist ein Pogo Server mit Debian 6.0.7 und CS-Server IPC. Als oscam ist die 1.20-unstable_svn build #8725 eingerichtet die Verbindung des Clients ist auch da und auch der camd3 Proxy Reader wird CONNECTED aber im Client wird nichts hell. Ich weiß nicht warum? Ich finde einfach den Fehler nicht.
hier ein Logauszug:
Kann mir jemand einen Hinweis oder Hilfe geben?
hier ein Logauszug:
-------------------------------------------------------------------------------
>> OSCam << cardserver started at Wed Jun 26 11:45:10 2013
-------------------------------------------------------------------------------
2013/06/26 11:45:10 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r8725 (arm-linux-gnueabi)
2013/06/26 11:45:10 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 19393
2013/06/26 11:45:10 0 s services reloaded: 0 services freed, 3 services loaded, rejected 0
2013/06/26 11:45:10 0 s userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2013/06/26 11:45:10 0 s signal handling initialized
2013/06/26 11:45:10 0 s 241 service-id's loaded in 2ms
2013/06/26 11:45:10 0 s 245 tier-id's loaded
2013/06/26 11:45:10 0 s 30 provid's loaded
2013/06/26 11:45:10 0 s LED support is not active. Can't detect machine type.
2013/06/26 11:45:10 0 s camd35: initialized (fd=5, port=20248)
2013/06/26 11:45:10 0 s newcamd: initialized (fd=6, port=22000)
2013/06/26 11:45:10 0 s -> CAID: 1830 PROVID: 003411
2013/06/26 11:45:10 0 s cccam: initialized (fd=7, port=13030)
2013/06/26 11:45:10 0 s ORF [camd35] creating thread for device 192.168.178.4
2013/06/26 11:45:10 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2013/06/26 11:45:10 0 s waiting for local card init
2013/06/26 11:45:10 1041B0 p camd35 proxy 192.168.178.4:24110
2013/06/26 11:45:10 1041B0 p ORF [camd35] proxy initialized, server 192.168.178.4:24110
2013/06/26 11:45:10 11A468 h webif: decompressed 50761 bytes back into 150976 bytes
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/HEADER.tpl is in the old template format without revision info. Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;1820323145;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/USERCONFIGLIST.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7361). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;2489487885;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/USERCONFIGLISTBIT.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7202). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;85624906;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/READERS.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7904). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;3321163592;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h HTTP Server running. ip=:: port=16002
2013/06/26 11:45:10 0 s init for all local cards done
2013/06/26 11:45:10 0 s anti cascading disabled
2013/06/26 11:45:36 1200B8 c encrypted cccam-client 192.168.178.163 granted (Z1, au=on (3 reader))
2013/06/26 11:45:37 1041B0 p 192.168.178.4: resolved ip=192.168.178.4
2013/06/26 11:45:37 1041B0 p ORF [camd35] connecting to 192.168.178.4:24110
2013/06/26 11:45:39 11A468 h all debug_level=65535
2013/06/26 11:45:39 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:39 0 share-updater mode=initfast t=1s i=28
2013/06/26 11:45:40 0 share-updater mode=initfast t=1s i=27
2013/06/26 11:45:41 0 share-updater mode=initfast t=1s i=26
2013/06/26 11:45:42 0 timeout for Z1 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D
2013/06/26 11:45:42 0 add client job action 24 queue length 1 Z1
2013/06/26 11:45:42 0 starting thread housekeeping lb stats
2013/06/26 11:45:42 0 housekeeping lb stats thread started
2013/06/26 11:45:42 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D time 5001ms fail 1
2013/06/26 11:45:42 1200B8 c Client Z1 csphash 27711240 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D
2013/06/26 11:45:42 1200B8 c Z1 (0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D): timeout (5001 ms) by ORF - ORF 2 HD
2013/06/26 11:45:42 1200B8 c cw:
2013/06/26 11:45:42 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:45:42 0 loadbalancer cleanup: removed 0 entries
2013/06/26 11:45:42 0 share-updater mode=initfast t=1s i=25
2013/06/26 11:45:43 0 share-updater mode=initfast t=1s i=24
2013/06/26 11:45:44 0 share-updater mode=initfast t=1s i=23
2013/06/26 11:45:45 0 share-updater mode=initfast t=1s i=22
2013/06/26 11:45:46 0 share-updater mode=initfast t=1s i=21
2013/06/26 11:45:47 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10263 ms inactivity
2013/06/26 11:45:47 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:45:47 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:45:47 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:45:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163: n=1 valid readers: ORF
2013/06/26 11:45:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:45:47 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:45:47 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:45:47 1200B8 c loadbalancer: reader ORF blocked for 30 seconds (fail_factor 1), retryng in 25 seconds
2013/06/26 11:45:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:45:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163: n=0 selected readers:
2013/06/26 11:45:47 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:45:47 1200B8 c Client Z1 csphash 402FD58C cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163
2013/06/26 11:45:47 1200B8 c Z1 (0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163): rejected group (0 ms) - ORF 2 HD (no matching reader)
2013/06/26 11:45:47 1200B8 c cw:
2013/06/26 11:45:47 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:45:47 0 share-updater mode=initfast t=1s i=20
2013/06/26 11:45:48 0 share-updater mode=initfast t=1s i=19
2013/06/26 11:45:49 0 share-updater mode=initfast t=1s i=18
2013/06/26 11:45:50 0 share-updater mode=initfast t=1s i=17
2013/06/26 11:45:51 0 share-updater mode=initfast t=1s i=16
2013/06/26 11:45:52 0 share-updater mode=initfast t=1s i=15
2013/06/26 11:45:53 0 share-updater mode=initfast t=1s i=14
2013/06/26 11:45:54 0 share-updater mode=initfast t=1s i=13
2013/06/26 11:45:54 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:55 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=307820cb30e1bf65f7748b171b17b8b3, expectednonce=b6c8e84d0ac196738da7e61c38e5c5d0, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:45:55 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:55 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:45:55 0 share-updater mode=initfast t=1s i=12
2013/06/26 11:45:56 0 share-updater mode=initfast t=1s i=11
2013/06/26 11:45:57 0 share-updater mode=initfast t=1s i=10
2013/06/26 11:45:58 0 share-updater mode=initfast t=1s i=9
2013/06/26 11:45:59 0 share-updater mode=initfast t=1s i=8
2013/06/26 11:46:00 0 share-updater mode=initfast t=1s i=7
2013/06/26 11:46:01 0 share-updater mode=initfast t=1s i=6
2013/06/26 11:46:02 0 share-updater mode=initfast t=1s i=5
2013/06/26 11:46:03 0 share-updater mode=initfast t=1s i=4
2013/06/26 11:46:04 0 share-updater mode=initfast t=1s i=3
2013/06/26 11:46:05 0 share-updater mode=initfast t=1s i=2
2013/06/26 11:46:06 0 share-updater mode=initfast t=1s i=1
2013/06/26 11:46:07 0 share-updater mode=interval t=240s
2013/06/26 11:46:10 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:46:25 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:46:25 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=b6c8e84d0ac196738da7e61c38e5c5d0, expectednonce=8af9db5f498f145393f18d3a22d44939, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:46:25 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:46:43 0 --- Skipped 5 duplicated log lines ---
2013/06/26 11:46:43 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 55872 ms inactivity
2013/06/26 11:46:43 1200B8 c cccam(s) Z1: parse_msg=6
2013/06/26 11:46:43 1200B8 c cccam: keepalive
2013/06/26 11:46:45 11A468 h WebIf: No data received from client 192.168.178.101. Closing connection.
2013/06/26 11:46:55 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=8af9db5f498f145393f18d3a22d44939, expectednonce=f898fe6dd3e452118ada2869cad3060c, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:46:55 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:01 0 --- Skipped 4 duplicated log lines ---
2013/06/26 11:47:01 11A468 h WebIf: No data received from client 192.168.178.101. Closing connection.
2013/06/26 11:47:07 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:07 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 23872 ms inactivity
2013/06/26 11:47:07 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:07 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:47:07 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:07 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9: n=1 valid readers: ORF
2013/06/26 11:47:07 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:07 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:07 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:07 1200B8 c loadbalancer: reader ORF reaches 30 seconds for reopening (fail_factor 1) --> ACTIVE
2013/06/26 11:47:07 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:07 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9: n=1 selected readers: ORF
2013/06/26 11:47:07 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:07 1200B8 c request_cw stage=3 to reader ORF ecm hash=B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:07 1200B8 c add reader job action 5 queue length 1 ORF
2013/06/26 11:47:07 1200B8 c Client Z1 ECM dump 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:07 1200B8 80 70 99 81 FF 00 00 94 80 60 08 D1 67 44 DE 1A
2013/06/26 11:47:07 1200B8 08 72 32 01 8F 16 4C 55 45 71 98 BD 39 1F EB C4
2013/06/26 11:47:07 1200B8 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D 4B F7 D9 7E
2013/06/26 11:47:07 1200B8 D6 97 DB 2C 4E E9 05 49 06 5A 0C 80 FF A5 9B 90
2013/06/26 11:47:07 1200B8 63 EC E6 D2 1B 29 52 92 A5 42 22 D2 A6 53 00 EB
2013/06/26 11:47:07 1200B8 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C 05 7C 34 3F
2013/06/26 11:47:07 1200B8 B4 CE 7E 53 9D C4 26 1E E2 14 83 01 04 84 02 04
2013/06/26 11:47:07 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:07 1200B8 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F 8E 15 D0 55
2013/06/26 11:47:07 1200B8 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:07 1041B0 p ---- ecm_task 0, idx 2, sflag=1
2013/06/26 11:47:07 1041B0 p casc ecm (ORF):
2013/06/26 11:47:07 1041B0 80 70 99 81 FF 00 00 94 80 60 08 D1 67 44 DE 1A
2013/06/26 11:47:07 1041B0 08 72 32 01 8F 16 4C 55 45 71 98 BD 39 1F EB C4
2013/06/26 11:47:07 1041B0 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D 4B F7 D9 7E
2013/06/26 11:47:07 1041B0 D6 97 DB 2C 4E E9 05 49 06 5A 0C 80 FF A5 9B 90
2013/06/26 11:47:07 1041B0 63 EC E6 D2 1B 29 52 92 A5 42 22 D2 A6 53 00 EB
2013/06/26 11:47:07 1041B0 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C 05 7C 34 3F
2013/06/26 11:47:07 1041B0 B4 CE 7E 53 9D C4 26 1E E2 14 83 01 04 84 02 04
2013/06/26 11:47:07 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:07 1041B0 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F 8E 15 D0 55
2013/06/26 11:47:07 1041B0 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:07 1041B0 p send 176 bytes to ORF
2013/06/26 11:47:07 1041B0 00 9C 00 00 54 21 21 80 13 30 0D 05 00 00 00 04
2013/06/26 11:47:07 1041B0 00 02 FF FF 80 70 99 81 FF 00 00 94 80 60 08 D1
2013/06/26 11:47:07 1041B0 67 44 DE 1A 08 72 32 01 8F 16 4C 55 45 71 98 BD
2013/06/26 11:47:07 1041B0 39 1F EB C4 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D
2013/06/26 11:47:07 1041B0 4B F7 D9 7E D6 97 DB 2C 4E E9 05 49 06 5A 0C 80
2013/06/26 11:47:07 1041B0 FF A5 9B 90 63 EC E6 D2 1B 29 52 92 A5 42 22 D2
2013/06/26 11:47:07 1041B0 A6 53 00 EB 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C
2013/06/26 11:47:07 1041B0 05 7C 34 3F B4 CE 7E 53 9D C4 26 1E E2 14 83 01
2013/06/26 11:47:07 1041B0 04 84 02 04 01 8C 03 08 00 01 8E 02 2E DA 8F 01
2013/06/26 11:47:07 1041B0 01 91 01 01 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F
2013/06/26 11:47:07 1041B0 8E 15 D0 55 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:09 0 fallback for Z1 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:11 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=f898fe6dd3e452118ada2869cad3060c, expectednonce=96dbe44194b6059e36123bd448e247c1, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:11 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:12 0 --- Skipped 2 duplicated log lines ---
2013/06/26 11:47:12 0 timeout for Z1 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:12 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:12 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9 time 5000ms fail 2
2013/06/26 11:47:12 1200B8 c Client Z1 csphash DD173C16 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:12 1200B8 c Z1 (0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9): timeout (5001 ms) by ORF - ORF 2 HD
2013/06/26 11:47:12 1200B8 c cw:
2013/06/26 11:47:12 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:17 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10032 ms inactivity
2013/06/26 11:47:17 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:17 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:47:17 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:17 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF: n=1 valid readers: ORF
2013/06/26 11:47:17 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:17 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:17 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:17 1200B8 c loadbalancer: reader ORF blocked for 60 seconds (fail_factor 2), retryng in 55 seconds
2013/06/26 11:47:17 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:17 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF: n=0 selected readers:
2013/06/26 11:47:17 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:17 1200B8 c Client Z1 csphash 2D652FD7 cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF
2013/06/26 11:47:17 1200B8 c Z1 (0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF): rejected group (1 ms) - ORF 2 HD (no matching reader)
2013/06/26 11:47:17 1200B8 c cw:
2013/06/26 11:47:17 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:26 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:41 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:41 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=96dbe44194b6059e36123bd448e247c1, expectednonce=67ca72c6d6d9ac973566afd4c7861222, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:41 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:46 0 --- Skipped 2 duplicated log lines ---
2013/06/26 11:47:46 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 28802 ms inactivity
2013/06/26 11:47:46 1200B8 c cccam(s) Z1: parse_msg=6
2013/06/26 11:47:46 1200B8 c cccam: keepalive
2013/06/26 11:47:47 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 1746 ms inactivity
2013/06/26 11:47:47 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:47 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:47 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A: n=1 valid readers: ORF
2013/06/26 11:47:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:47 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:47 1200B8 c loadbalancer: reader ORF need starting statistics --> ACTIVE
2013/06/26 11:47:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A: n=1 selected readers: ORF
2013/06/26 11:47:47 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:47 1200B8 c request_cw stage=3 to reader ORF ecm hash=AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:47 1200B8 c add reader job action 5 queue length 1 ORF
2013/06/26 11:47:47 1200B8 c Client Z1 ECM dump 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:47 1200B8 80 70 99 81 FF 00 00 94 80 60 E2 8F 76 34 9F 8F
2013/06/26 11:47:47 1200B8 F6 1B 65 8F 7D 41 BD F1 4B 35 26 3A 6C 1D 16 48
2013/06/26 11:47:47 1200B8 1F F1 77 B9 E3 B7 2E 02 10 D3 D0 74 F7 FA 5B 44
2013/06/26 11:47:47 1200B8 F5 F7 1C 01 26 3E 99 2F 4A 61 A7 E6 4C 2D 15 82
2013/06/26 11:47:47 1200B8 11 85 66 EA B7 A1 D3 8D 26 1B 55 A7 F5 B0 61 C3
2013/06/26 11:47:47 1200B8 2F 76 57 28 F6 DE D7 B9 9F 31 0B F3 0A C5 37 57
2013/06/26 11:47:47 1200B8 68 AF B9 9A 7B CB 89 65 98 69 83 01 04 84 02 04
2013/06/26 11:47:47 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:47 1200B8 DB 10 87 37 BC 41 79 7F 13 75 C7 0C 7D 89 01 ED
2013/06/26 11:47:47 1200B8 40 21 DF 08 64 71 65 23 74 04 0B 51
2013/06/26 11:47:47 1041B0 p ---- ecm_task 0, idx 3, sflag=1
2013/06/26 11:47:47 1041B0 p casc ecm (ORF):
2013/06/26 11:47:47 1041B0 80 70 99 81 FF 00 00 94 80 60 E2 8F 76 34 9F 8F
2013/06/26 11:47:47 1041B0 F6 1B 65 8F 7D 41 BD F1 4B 35 26 3A 6C 1D 16 48
2013/06/26 11:47:47 1041B0 1F F1 77 B9 E3 B7 2E 02 10 D3 D0 74 F7 FA 5B 44
2013/06/26 11:47:47 1041B0 F5 F7 1C 01 26 3E 99 2F 4A 61 A7 E6 4C 2D 15 82
2013/06/26 11:47:47 1041B0 11 85 66 EA B7 A1 D3 8D 26 1B 55 A7 F5 B0 61 C3
2013/06/26 11:47:47 1041B0 2F 76 57 28 F6 DE D7 B9 9F 31 0B F3 0A C5 37 57
2013/06/26 11:47:47 1041B0 68 AF B9 9A 7B CB 89 65 98 69 83 01 04 84 02 04
2013/06/26 11:47:47 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:47 1041B0 DB 10 87 37 BC 41 79 7F 13 75 C7 0C 7D 89 01 ED
2013/06/26 11:47:47 1041B0 40 21 DF 08 64 71 65 23 74 04 0B 51
2013/06/26 11:47:47 1041B0 p ORF [camd35] disconnected: reason rto
2013/06/26 11:47:48 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 1085 ms inactivity
2013/06/26 11:47:48 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:48 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:48 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:48 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0: n=1 valid readers: ORF
2013/06/26 11:47:48 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:48 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:48 1200B8 c loadbalancer: reader ORF need starting statistics --> ACTIVE
2013/06/26 11:47:48 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:48 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0: n=1 selected readers: ORF
2013/06/26 11:47:48 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:48 1200B8 c request_cw stage=3 to reader ORF ecm hash=0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:48 1200B8 c start reader thread action 5
2013/06/26 11:47:48 1200B8 c Client Z1 ECM dump 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:48 1200B8 81 70 99 81 FF 00 00 94 80 60 4F 0E 21 BA 84 64
2013/06/26 11:47:48 1200B8 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3 11 4A 75 C5
2013/06/26 11:47:48 1200B8 30 E2 7F 81 92 3C 23 08 AC 16 3F B7 F7 D5 10 7B
2013/06/26 11:47:48 1200B8 2D FD 68 52 0C BD C6 A0 C8 46 DE 31 3D 96 54 40
2013/06/26 11:47:48 1200B8 FF BD 80 31 62 4A AA DE 7F 31 4B E4 D0 1A 2A 16
2013/06/26 11:47:48 1200B8 89 59 D8 12 0B D7 97 7A 02 B7 9D CF F5 4E 13 59
2013/06/26 11:47:48 1200B8 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01 04 84 02 04
2013/06/26 11:47:48 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:48 1200B8 DB 10 87 37 BC 41 79 7F 13 75 03 D8 14 03 88 15
2013/06/26 11:47:48 1200B8 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:48 1041B0 p data from add_job action=5 client p ORF
2013/06/26 11:47:48 1041B0 p ---- ecm_task 0, idx 4, sflag=1
2013/06/26 11:47:48 1041B0 p casc ecm (ORF):
2013/06/26 11:47:48 1041B0 81 70 99 81 FF 00 00 94 80 60 4F 0E 21 BA 84 64
2013/06/26 11:47:48 1041B0 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3 11 4A 75 C5
2013/06/26 11:47:48 1041B0 30 E2 7F 81 92 3C 23 08 AC 16 3F B7 F7 D5 10 7B
2013/06/26 11:47:48 1041B0 2D FD 68 52 0C BD C6 A0 C8 46 DE 31 3D 96 54 40
2013/06/26 11:47:48 1041B0 FF BD 80 31 62 4A AA DE 7F 31 4B E4 D0 1A 2A 16
2013/06/26 11:47:48 1041B0 89 59 D8 12 0B D7 97 7A 02 B7 9D CF F5 4E 13 59
2013/06/26 11:47:48 1041B0 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01 04 84 02 04
2013/06/26 11:47:48 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:48 1041B0 DB 10 87 37 BC 41 79 7F 13 75 03 D8 14 03 88 15
2013/06/26 11:47:48 1041B0 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:48 1041B0 p ORF [camd35] connecting to 192.168.178.4:24110
2013/06/26 11:47:48 1041B0 p ORF [camd35] TRACE: socket open for camd35 fd=12
2013/06/26 11:47:48 1041B0 p send 176 bytes to ORF
2013/06/26 11:47:48 1041B0 00 9C 00 00 08 FD C8 71 32 C9 0D 05 00 00 00 04
2013/06/26 11:47:48 1041B0 00 04 FF FF 81 70 99 81 FF 00 00 94 80 60 4F 0E
2013/06/26 11:47:48 1041B0 21 BA 84 64 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3
2013/06/26 11:47:48 1041B0 11 4A 75 C5 30 E2 7F 81 92 3C 23 08 AC 16 3F B7
2013/06/26 11:47:48 1041B0 F7 D5 10 7B 2D FD 68 52 0C BD C6 A0 C8 46 DE 31
2013/06/26 11:47:48 1041B0 3D 96 54 40 FF BD 80 31 62 4A AA DE 7F 31 4B E4
2013/06/26 11:47:48 1041B0 D0 1A 2A 16 89 59 D8 12 0B D7 97 7A 02 B7 9D CF
2013/06/26 11:47:48 1041B0 F5 4E 13 59 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01
2013/06/26 11:47:48 1041B0 04 84 02 04 01 8C 03 08 00 01 8E 02 2E DA 8F 01
2013/06/26 11:47:48 1041B0 01 91 01 01 DB 10 87 37 BC 41 79 7F 13 75 03 D8
2013/06/26 11:47:48 1041B0 14 03 88 15 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:50 0 fallback for Z1 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 0 timeout for Z1 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:52 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A time 5000ms fail 1
2013/06/26 11:47:52 1200B8 c Client Z1 csphash 8ACB6EAE cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 1200B8 c Z1 (0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A): timeout (5000 ms) by ORF - ORF 1
2013/06/26 11:47:52 1200B8 c cw:
2013/06/26 11:47:52 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:53 0 timeout for Z1 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:53 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:53 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0 time 5000ms fail 2
2013/06/26 11:47:53 1200B8 c Client Z1 csphash 5CB65620 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:53 1200B8 c Z1 (0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0): timeout (5001 ms) by ORF - ORF 1
2013/06/26 11:47:53 1200B8 c cw:
2013/06/26 11:47:53 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:56 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:57 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=67ca72c6d6d9ac973566afd4c7861222, expectednonce=7801bb65d45af3756d46606571ae75bf, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:57 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:59 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:59 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10363 ms inactivity
2013/06/26 11:47:59 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:59 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:59 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:59 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97: n=1 valid readers: ORF
2013/06/26 11:47:59 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:59 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:59 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:59 1200B8 c loadbalancer: reader ORF blocked for 60 seconds (fail_factor 2), retryng in 54 seconds
2013/06/26 11:47:59 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:59 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97: n=0 selected readers:
2013/06/26 11:47:59 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:59 1200B8 c Client Z1 csphash 1E7879BB cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97
2013/06/26 11:47:59 1200B8 c Z1 (0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97): rejected group (1 ms) - ORF 1 (no matching reader)
2013/06/26 11:47:59 1200B8 c cw:
2013/06/26 11:47:59 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:48:12 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:48:15 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:48:15 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=7801bb65d45af3756d46606571ae75bf, expectednonce=14e35efd94a92714f3f80afaff9c4e1b, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:48:15 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
>> OSCam << cardserver started at Wed Jun 26 11:45:10 2013
-------------------------------------------------------------------------------
2013/06/26 11:45:10 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r8725 (arm-linux-gnueabi)
2013/06/26 11:45:10 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 19393
2013/06/26 11:45:10 0 s services reloaded: 0 services freed, 3 services loaded, rejected 0
2013/06/26 11:45:10 0 s userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2013/06/26 11:45:10 0 s signal handling initialized
2013/06/26 11:45:10 0 s 241 service-id's loaded in 2ms
2013/06/26 11:45:10 0 s 245 tier-id's loaded
2013/06/26 11:45:10 0 s 30 provid's loaded
2013/06/26 11:45:10 0 s LED support is not active. Can't detect machine type.
2013/06/26 11:45:10 0 s camd35: initialized (fd=5, port=20248)
2013/06/26 11:45:10 0 s newcamd: initialized (fd=6, port=22000)
2013/06/26 11:45:10 0 s -> CAID: 1830 PROVID: 003411
2013/06/26 11:45:10 0 s cccam: initialized (fd=7, port=13030)
2013/06/26 11:45:10 0 s ORF [camd35] creating thread for device 192.168.178.4
2013/06/26 11:45:10 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2013/06/26 11:45:10 0 s waiting for local card init
2013/06/26 11:45:10 1041B0 p camd35 proxy 192.168.178.4:24110
2013/06/26 11:45:10 1041B0 p ORF [camd35] proxy initialized, server 192.168.178.4:24110
2013/06/26 11:45:10 11A468 h webif: decompressed 50761 bytes back into 150976 bytes
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/HEADER.tpl is in the old template format without revision info. Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;1820323145;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/USERCONFIGLIST.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7361). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;2489487885;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/USERCONFIGLISTBIT.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7202). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;85624906;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h WARNING: Your http disk template /var/picons/READERS.tpl was created for an older revision of OSCam and was changed in original OSCam (1.20-unstable_svn,r7904). Please consider upgrading it!
2013/06/26 11:45:10 11A468 h If you are sure that it is current, add the following line at the beginning of the template to suppress this warning: <!--OSCam;3321163592;1.20-unstable_svn;8725;-->
2013/06/26 11:45:10 11A468 h HTTP Server running. ip=:: port=16002
2013/06/26 11:45:10 0 s init for all local cards done
2013/06/26 11:45:10 0 s anti cascading disabled
2013/06/26 11:45:36 1200B8 c encrypted cccam-client 192.168.178.163 granted (Z1, au=on (3 reader))
2013/06/26 11:45:37 1041B0 p 192.168.178.4: resolved ip=192.168.178.4
2013/06/26 11:45:37 1041B0 p ORF [camd35] connecting to 192.168.178.4:24110
2013/06/26 11:45:39 11A468 h all debug_level=65535
2013/06/26 11:45:39 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:39 0 share-updater mode=initfast t=1s i=28
2013/06/26 11:45:40 0 share-updater mode=initfast t=1s i=27
2013/06/26 11:45:41 0 share-updater mode=initfast t=1s i=26
2013/06/26 11:45:42 0 timeout for Z1 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D
2013/06/26 11:45:42 0 add client job action 24 queue length 1 Z1
2013/06/26 11:45:42 0 starting thread housekeeping lb stats
2013/06/26 11:45:42 0 housekeeping lb stats thread started
2013/06/26 11:45:42 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D time 5001ms fail 1
2013/06/26 11:45:42 1200B8 c Client Z1 csphash 27711240 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D
2013/06/26 11:45:42 1200B8 c Z1 (0D05&000004/0000/1330/9C:A266EB6E090EE9BA830E3AED2F76329D): timeout (5001 ms) by ORF - ORF 2 HD
2013/06/26 11:45:42 1200B8 c cw:
2013/06/26 11:45:42 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:45:42 0 loadbalancer cleanup: removed 0 entries
2013/06/26 11:45:42 0 share-updater mode=initfast t=1s i=25
2013/06/26 11:45:43 0 share-updater mode=initfast t=1s i=24
2013/06/26 11:45:44 0 share-updater mode=initfast t=1s i=23
2013/06/26 11:45:45 0 share-updater mode=initfast t=1s i=22
2013/06/26 11:45:46 0 share-updater mode=initfast t=1s i=21
2013/06/26 11:45:47 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10263 ms inactivity
2013/06/26 11:45:47 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:45:47 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:45:47 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:45:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163: n=1 valid readers: ORF
2013/06/26 11:45:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:45:47 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:45:47 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:45:47 1200B8 c loadbalancer: reader ORF blocked for 30 seconds (fail_factor 1), retryng in 25 seconds
2013/06/26 11:45:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:45:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163: n=0 selected readers:
2013/06/26 11:45:47 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:45:47 1200B8 c Client Z1 csphash 402FD58C cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163
2013/06/26 11:45:47 1200B8 c Z1 (0D05&000004/0000/1330/9C:A43C30A4FAA42F3F00B8C791184DD163): rejected group (0 ms) - ORF 2 HD (no matching reader)
2013/06/26 11:45:47 1200B8 c cw:
2013/06/26 11:45:47 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:45:47 0 share-updater mode=initfast t=1s i=20
2013/06/26 11:45:48 0 share-updater mode=initfast t=1s i=19
2013/06/26 11:45:49 0 share-updater mode=initfast t=1s i=18
2013/06/26 11:45:50 0 share-updater mode=initfast t=1s i=17
2013/06/26 11:45:51 0 share-updater mode=initfast t=1s i=16
2013/06/26 11:45:52 0 share-updater mode=initfast t=1s i=15
2013/06/26 11:45:53 0 share-updater mode=initfast t=1s i=14
2013/06/26 11:45:54 0 share-updater mode=initfast t=1s i=13
2013/06/26 11:45:54 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:55 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=307820cb30e1bf65f7748b171b17b8b3, expectednonce=b6c8e84d0ac196738da7e61c38e5c5d0, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:45:55 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:45:55 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:45:55 0 share-updater mode=initfast t=1s i=12
2013/06/26 11:45:56 0 share-updater mode=initfast t=1s i=11
2013/06/26 11:45:57 0 share-updater mode=initfast t=1s i=10
2013/06/26 11:45:58 0 share-updater mode=initfast t=1s i=9
2013/06/26 11:45:59 0 share-updater mode=initfast t=1s i=8
2013/06/26 11:46:00 0 share-updater mode=initfast t=1s i=7
2013/06/26 11:46:01 0 share-updater mode=initfast t=1s i=6
2013/06/26 11:46:02 0 share-updater mode=initfast t=1s i=5
2013/06/26 11:46:03 0 share-updater mode=initfast t=1s i=4
2013/06/26 11:46:04 0 share-updater mode=initfast t=1s i=3
2013/06/26 11:46:05 0 share-updater mode=initfast t=1s i=2
2013/06/26 11:46:06 0 share-updater mode=initfast t=1s i=1
2013/06/26 11:46:07 0 share-updater mode=interval t=240s
2013/06/26 11:46:10 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:46:25 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:46:25 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=b6c8e84d0ac196738da7e61c38e5c5d0, expectednonce=8af9db5f498f145393f18d3a22d44939, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:46:25 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:46:43 0 --- Skipped 5 duplicated log lines ---
2013/06/26 11:46:43 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 55872 ms inactivity
2013/06/26 11:46:43 1200B8 c cccam(s) Z1: parse_msg=6
2013/06/26 11:46:43 1200B8 c cccam: keepalive
2013/06/26 11:46:45 11A468 h WebIf: No data received from client 192.168.178.101. Closing connection.
2013/06/26 11:46:55 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=8af9db5f498f145393f18d3a22d44939, expectednonce=f898fe6dd3e452118ada2869cad3060c, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:46:55 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:01 0 --- Skipped 4 duplicated log lines ---
2013/06/26 11:47:01 11A468 h WebIf: No data received from client 192.168.178.101. Closing connection.
2013/06/26 11:47:07 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:07 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 23872 ms inactivity
2013/06/26 11:47:07 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:07 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:47:07 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:07 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9: n=1 valid readers: ORF
2013/06/26 11:47:07 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:07 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:07 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:07 1200B8 c loadbalancer: reader ORF reaches 30 seconds for reopening (fail_factor 1) --> ACTIVE
2013/06/26 11:47:07 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:07 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9: n=1 selected readers: ORF
2013/06/26 11:47:07 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:07 1200B8 c request_cw stage=3 to reader ORF ecm hash=B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:07 1200B8 c add reader job action 5 queue length 1 ORF
2013/06/26 11:47:07 1200B8 c Client Z1 ECM dump 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:07 1200B8 80 70 99 81 FF 00 00 94 80 60 08 D1 67 44 DE 1A
2013/06/26 11:47:07 1200B8 08 72 32 01 8F 16 4C 55 45 71 98 BD 39 1F EB C4
2013/06/26 11:47:07 1200B8 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D 4B F7 D9 7E
2013/06/26 11:47:07 1200B8 D6 97 DB 2C 4E E9 05 49 06 5A 0C 80 FF A5 9B 90
2013/06/26 11:47:07 1200B8 63 EC E6 D2 1B 29 52 92 A5 42 22 D2 A6 53 00 EB
2013/06/26 11:47:07 1200B8 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C 05 7C 34 3F
2013/06/26 11:47:07 1200B8 B4 CE 7E 53 9D C4 26 1E E2 14 83 01 04 84 02 04
2013/06/26 11:47:07 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:07 1200B8 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F 8E 15 D0 55
2013/06/26 11:47:07 1200B8 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:07 1041B0 p ---- ecm_task 0, idx 2, sflag=1
2013/06/26 11:47:07 1041B0 p casc ecm (ORF):
2013/06/26 11:47:07 1041B0 80 70 99 81 FF 00 00 94 80 60 08 D1 67 44 DE 1A
2013/06/26 11:47:07 1041B0 08 72 32 01 8F 16 4C 55 45 71 98 BD 39 1F EB C4
2013/06/26 11:47:07 1041B0 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D 4B F7 D9 7E
2013/06/26 11:47:07 1041B0 D6 97 DB 2C 4E E9 05 49 06 5A 0C 80 FF A5 9B 90
2013/06/26 11:47:07 1041B0 63 EC E6 D2 1B 29 52 92 A5 42 22 D2 A6 53 00 EB
2013/06/26 11:47:07 1041B0 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C 05 7C 34 3F
2013/06/26 11:47:07 1041B0 B4 CE 7E 53 9D C4 26 1E E2 14 83 01 04 84 02 04
2013/06/26 11:47:07 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:07 1041B0 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F 8E 15 D0 55
2013/06/26 11:47:07 1041B0 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:07 1041B0 p send 176 bytes to ORF
2013/06/26 11:47:07 1041B0 00 9C 00 00 54 21 21 80 13 30 0D 05 00 00 00 04
2013/06/26 11:47:07 1041B0 00 02 FF FF 80 70 99 81 FF 00 00 94 80 60 08 D1
2013/06/26 11:47:07 1041B0 67 44 DE 1A 08 72 32 01 8F 16 4C 55 45 71 98 BD
2013/06/26 11:47:07 1041B0 39 1F EB C4 64 E1 B6 7E B6 9B 8C BD 25 4F B1 0D
2013/06/26 11:47:07 1041B0 4B F7 D9 7E D6 97 DB 2C 4E E9 05 49 06 5A 0C 80
2013/06/26 11:47:07 1041B0 FF A5 9B 90 63 EC E6 D2 1B 29 52 92 A5 42 22 D2
2013/06/26 11:47:07 1041B0 A6 53 00 EB 39 A0 D8 0B 66 6C 7D 82 AB 9E 2A 7C
2013/06/26 11:47:07 1041B0 05 7C 34 3F B4 CE 7E 53 9D C4 26 1E E2 14 83 01
2013/06/26 11:47:07 1041B0 04 84 02 04 01 8C 03 08 00 01 8E 02 2E DA 8F 01
2013/06/26 11:47:07 1041B0 01 91 01 01 DB 10 5B 2B 25 60 04 F3 A8 FF FF 4F
2013/06/26 11:47:07 1041B0 8E 15 D0 55 B5 53 DF 08 B0 3E 2E FD 17 35 C3 FE
2013/06/26 11:47:09 0 fallback for Z1 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:11 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=f898fe6dd3e452118ada2869cad3060c, expectednonce=96dbe44194b6059e36123bd448e247c1, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:11 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:12 0 --- Skipped 2 duplicated log lines ---
2013/06/26 11:47:12 0 timeout for Z1 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:12 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:12 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9 time 5000ms fail 2
2013/06/26 11:47:12 1200B8 c Client Z1 csphash DD173C16 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9
2013/06/26 11:47:12 1200B8 c Z1 (0D05&000004/0000/1330/9C:B8E1D58E16F2A2BAC170B5F34AC05DF9): timeout (5001 ms) by ORF - ORF 2 HD
2013/06/26 11:47:12 1200B8 c cw:
2013/06/26 11:47:12 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:17 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10032 ms inactivity
2013/06/26 11:47:17 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:17 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 1330(156) prid 000004
2013/06/26 11:47:17 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:17 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF: n=1 valid readers: ORF
2013/06/26 11:47:17 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:17 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:17 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:17 1200B8 c loadbalancer: reader ORF blocked for 60 seconds (fail_factor 2), retryng in 55 seconds
2013/06/26 11:47:17 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:17 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF: n=0 selected readers:
2013/06/26 11:47:17 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 1330 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:17 1200B8 c Client Z1 csphash 2D652FD7 cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF
2013/06/26 11:47:17 1200B8 c Z1 (0D05&000004/0000/1330/9C:EDB819D8531271531130570AA96BBEAF): rejected group (1 ms) - ORF 2 HD (no matching reader)
2013/06/26 11:47:17 1200B8 c cw:
2013/06/26 11:47:17 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:26 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:41 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:41 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=96dbe44194b6059e36123bd448e247c1, expectednonce=67ca72c6d6d9ac973566afd4c7861222, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:41 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:46 0 --- Skipped 2 duplicated log lines ---
2013/06/26 11:47:46 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 28802 ms inactivity
2013/06/26 11:47:46 1200B8 c cccam(s) Z1: parse_msg=6
2013/06/26 11:47:46 1200B8 c cccam: keepalive
2013/06/26 11:47:47 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 1746 ms inactivity
2013/06/26 11:47:47 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:47 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:47 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A: n=1 valid readers: ORF
2013/06/26 11:47:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:47 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:47 1200B8 c loadbalancer: reader ORF need starting statistics --> ACTIVE
2013/06/26 11:47:47 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:47 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A: n=1 selected readers: ORF
2013/06/26 11:47:47 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:47 1200B8 c request_cw stage=3 to reader ORF ecm hash=AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:47 1200B8 c add reader job action 5 queue length 1 ORF
2013/06/26 11:47:47 1200B8 c Client Z1 ECM dump 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:47 1200B8 80 70 99 81 FF 00 00 94 80 60 E2 8F 76 34 9F 8F
2013/06/26 11:47:47 1200B8 F6 1B 65 8F 7D 41 BD F1 4B 35 26 3A 6C 1D 16 48
2013/06/26 11:47:47 1200B8 1F F1 77 B9 E3 B7 2E 02 10 D3 D0 74 F7 FA 5B 44
2013/06/26 11:47:47 1200B8 F5 F7 1C 01 26 3E 99 2F 4A 61 A7 E6 4C 2D 15 82
2013/06/26 11:47:47 1200B8 11 85 66 EA B7 A1 D3 8D 26 1B 55 A7 F5 B0 61 C3
2013/06/26 11:47:47 1200B8 2F 76 57 28 F6 DE D7 B9 9F 31 0B F3 0A C5 37 57
2013/06/26 11:47:47 1200B8 68 AF B9 9A 7B CB 89 65 98 69 83 01 04 84 02 04
2013/06/26 11:47:47 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:47 1200B8 DB 10 87 37 BC 41 79 7F 13 75 C7 0C 7D 89 01 ED
2013/06/26 11:47:47 1200B8 40 21 DF 08 64 71 65 23 74 04 0B 51
2013/06/26 11:47:47 1041B0 p ---- ecm_task 0, idx 3, sflag=1
2013/06/26 11:47:47 1041B0 p casc ecm (ORF):
2013/06/26 11:47:47 1041B0 80 70 99 81 FF 00 00 94 80 60 E2 8F 76 34 9F 8F
2013/06/26 11:47:47 1041B0 F6 1B 65 8F 7D 41 BD F1 4B 35 26 3A 6C 1D 16 48
2013/06/26 11:47:47 1041B0 1F F1 77 B9 E3 B7 2E 02 10 D3 D0 74 F7 FA 5B 44
2013/06/26 11:47:47 1041B0 F5 F7 1C 01 26 3E 99 2F 4A 61 A7 E6 4C 2D 15 82
2013/06/26 11:47:47 1041B0 11 85 66 EA B7 A1 D3 8D 26 1B 55 A7 F5 B0 61 C3
2013/06/26 11:47:47 1041B0 2F 76 57 28 F6 DE D7 B9 9F 31 0B F3 0A C5 37 57
2013/06/26 11:47:47 1041B0 68 AF B9 9A 7B CB 89 65 98 69 83 01 04 84 02 04
2013/06/26 11:47:47 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:47 1041B0 DB 10 87 37 BC 41 79 7F 13 75 C7 0C 7D 89 01 ED
2013/06/26 11:47:47 1041B0 40 21 DF 08 64 71 65 23 74 04 0B 51
2013/06/26 11:47:47 1041B0 p ORF [camd35] disconnected: reason rto
2013/06/26 11:47:48 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 1085 ms inactivity
2013/06/26 11:47:48 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:48 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:48 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:48 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0: n=1 valid readers: ORF
2013/06/26 11:47:48 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:48 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:48 1200B8 c loadbalancer: reader ORF need starting statistics --> ACTIVE
2013/06/26 11:47:48 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:48 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0: n=1 selected readers: ORF
2013/06/26 11:47:48 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 100 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:48 1200B8 c request_cw stage=3 to reader ORF ecm hash=0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:48 1200B8 c start reader thread action 5
2013/06/26 11:47:48 1200B8 c Client Z1 ECM dump 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:48 1200B8 81 70 99 81 FF 00 00 94 80 60 4F 0E 21 BA 84 64
2013/06/26 11:47:48 1200B8 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3 11 4A 75 C5
2013/06/26 11:47:48 1200B8 30 E2 7F 81 92 3C 23 08 AC 16 3F B7 F7 D5 10 7B
2013/06/26 11:47:48 1200B8 2D FD 68 52 0C BD C6 A0 C8 46 DE 31 3D 96 54 40
2013/06/26 11:47:48 1200B8 FF BD 80 31 62 4A AA DE 7F 31 4B E4 D0 1A 2A 16
2013/06/26 11:47:48 1200B8 89 59 D8 12 0B D7 97 7A 02 B7 9D CF F5 4E 13 59
2013/06/26 11:47:48 1200B8 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01 04 84 02 04
2013/06/26 11:47:48 1200B8 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:48 1200B8 DB 10 87 37 BC 41 79 7F 13 75 03 D8 14 03 88 15
2013/06/26 11:47:48 1200B8 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:48 1041B0 p data from add_job action=5 client p ORF
2013/06/26 11:47:48 1041B0 p ---- ecm_task 0, idx 4, sflag=1
2013/06/26 11:47:48 1041B0 p casc ecm (ORF):
2013/06/26 11:47:48 1041B0 81 70 99 81 FF 00 00 94 80 60 4F 0E 21 BA 84 64
2013/06/26 11:47:48 1041B0 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3 11 4A 75 C5
2013/06/26 11:47:48 1041B0 30 E2 7F 81 92 3C 23 08 AC 16 3F B7 F7 D5 10 7B
2013/06/26 11:47:48 1041B0 2D FD 68 52 0C BD C6 A0 C8 46 DE 31 3D 96 54 40
2013/06/26 11:47:48 1041B0 FF BD 80 31 62 4A AA DE 7F 31 4B E4 D0 1A 2A 16
2013/06/26 11:47:48 1041B0 89 59 D8 12 0B D7 97 7A 02 B7 9D CF F5 4E 13 59
2013/06/26 11:47:48 1041B0 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01 04 84 02 04
2013/06/26 11:47:48 1041B0 01 8C 03 08 00 01 8E 02 2E DA 8F 01 01 91 01 01
2013/06/26 11:47:48 1041B0 DB 10 87 37 BC 41 79 7F 13 75 03 D8 14 03 88 15
2013/06/26 11:47:48 1041B0 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:48 1041B0 p ORF [camd35] connecting to 192.168.178.4:24110
2013/06/26 11:47:48 1041B0 p ORF [camd35] TRACE: socket open for camd35 fd=12
2013/06/26 11:47:48 1041B0 p send 176 bytes to ORF
2013/06/26 11:47:48 1041B0 00 9C 00 00 08 FD C8 71 32 C9 0D 05 00 00 00 04
2013/06/26 11:47:48 1041B0 00 04 FF FF 81 70 99 81 FF 00 00 94 80 60 4F 0E
2013/06/26 11:47:48 1041B0 21 BA 84 64 1C 6C E7 FF 8B 99 DC 30 34 A6 33 D3
2013/06/26 11:47:48 1041B0 11 4A 75 C5 30 E2 7F 81 92 3C 23 08 AC 16 3F B7
2013/06/26 11:47:48 1041B0 F7 D5 10 7B 2D FD 68 52 0C BD C6 A0 C8 46 DE 31
2013/06/26 11:47:48 1041B0 3D 96 54 40 FF BD 80 31 62 4A AA DE 7F 31 4B E4
2013/06/26 11:47:48 1041B0 D0 1A 2A 16 89 59 D8 12 0B D7 97 7A 02 B7 9D CF
2013/06/26 11:47:48 1041B0 F5 4E 13 59 A8 E5 E8 00 EC 70 5B D7 9C 50 83 01
2013/06/26 11:47:48 1041B0 04 84 02 04 01 8C 03 08 00 01 8E 02 2E DA 8F 01
2013/06/26 11:47:48 1041B0 01 91 01 01 DB 10 87 37 BC 41 79 7F 13 75 03 D8
2013/06/26 11:47:48 1041B0 14 03 88 15 87 AC DF 08 D8 38 E5 03 F2 5E A6 C4
2013/06/26 11:47:50 0 fallback for Z1 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 0 timeout for Z1 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:52 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A time 5000ms fail 1
2013/06/26 11:47:52 1200B8 c Client Z1 csphash 8ACB6EAE cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A
2013/06/26 11:47:52 1200B8 c Z1 (0D05&000004/0000/32C9/9C:AB9092C9093B9CEB02503C58B6031E9A): timeout (5000 ms) by ORF - ORF 1
2013/06/26 11:47:52 1200B8 c cw:
2013/06/26 11:47:52 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:53 0 timeout for Z1 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:53 0 add client job action 24 queue length 1 Z1
2013/06/26 11:47:53 0 loadbalancer: adding stat for reader ORF: rc 5 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0 time 5000ms fail 2
2013/06/26 11:47:53 1200B8 c Client Z1 csphash 5CB65620 cw 00000000000000000000000000000000 rc 5 0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0
2013/06/26 11:47:53 1200B8 c Z1 (0D05&000004/0000/32C9/9C:0EBFE00D98D5EE1084AE45B85DC47EB0): timeout (5001 ms) by ORF - ORF 1
2013/06/26 11:47:53 1200B8 c cw:
2013/06/26 11:47:53 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:47:56 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:57 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=67ca72c6d6d9ac973566afd4c7861222, expectednonce=7801bb65d45af3756d46606571ae75bf, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:47:57 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:47:59 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:47:59 1200B8 c [OSCAM-WORK] new event 1 occurred on fd 13 after 10363 ms inactivity
2013/06/26 11:47:59 1200B8 c cccam(s) Z1: parse_msg=1
2013/06/26 11:47:59 1200B8 c cccam(s) Z1: ECM request from client: caid 0d05 srvid 32c9(156) prid 000004
2013/06/26 11:47:59 1200B8 c matching_reader became slot attribute of 1
2013/06/26 11:47:59 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97: n=1 valid readers: ORF
2013/06/26 11:47:59 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:59 1200B8 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2013/06/26 11:47:59 1200B8 c loadbalancer: NO VALID MATCHING READER FOUND, force reopening (knock) all valid blocked readers!
2013/06/26 11:47:59 1200B8 c loadbalancer: reader ORF blocked for 60 seconds (fail_factor 2), retryng in 54 seconds
2013/06/26 11:47:59 1200B8 c loadbalancer: --------------------------------------------
2013/06/26 11:47:59 1200B8 c loadbalancer: client Z1 for 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97: n=0 selected readers:
2013/06/26 11:47:59 1200B8 c [GET_CW] wait_time 0 caid 0D05 prov 000004 srvid 32C9 rc 4 cacheex cl mode 0 ex1rdr 0
2013/06/26 11:47:59 1200B8 c Client Z1 csphash 1E7879BB cw 00000000000000000000000000000000 rc 4 0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97
2013/06/26 11:47:59 1200B8 c Z1 (0D05&000004/0000/32C9/9C:49797649BA28740EEF9F43B4B0D79C97): rejected group (1 ms) - ORF 1 (no matching reader)
2013/06/26 11:47:59 1200B8 c cw:
2013/06/26 11:47:59 1200B8 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2013/06/26 11:48:12 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
2013/06/26 11:48:15 0 --- Skipped 1 duplicated log lines ---
2013/06/26 11:48:15 11A468 h WebIf: Received stale header from 192.168.178.101 (nonce=7801bb65d45af3756d46606571ae75bf, expectednonce=14e35efd94a92714f3f80afaff9c4e1b, opaque=a1f70fae3d2767cd1f70dbccb8f93a40).
2013/06/26 11:48:15 11A468 h WebIf: Origin checked. Result: access from 192.168.178.101 => allowed
Kann mir jemand einen Hinweis oder Hilfe geben?