[linux-dvb] Re: Nova-s CAM/CI support

To: linux-dvb@linuxtv.org
Subject: [linux-dvb] Re: Nova-s CAM/CI support
From: Jesper Sörensen <jesper@datapartner.se>
Date: Wed, 12 May 2004 21:11:24 +0200
Content-type: text/plain; charset=ISO-8859-1; format=flowed
In-reply-to: <200405121519.45720.adq_dvb@lidskialf.net>
List-help: <mailto:ecartis@linuxtv.org?Subject=help>
List-id: linux-dvb <linux-dvb.mail>
List-software: Ecartis version 1.0.0
List-unsubscribe: <https://mail.convergence2.de/cgi-bin/listen.cgi>
References: <3FB4847C00723576@mail4.edisontel.com> (added by postmaster@ivs.edisontel.com) <200405121519.45720.adq_dvb@lidskialf.net>
Sender: linux-dvb-bounce@linuxtv.org
User-agent: Mozilla Thunderbird 0.6 (Windows/20040502)

I have tested the cam_* utils that were mentioned on the list recently, and it seems that my problems with the CAM getting reset is not caused by MythTV itself, but perhaps by either libdvbci (which I assume MythTV uses) or the budget-ci driver?

After running cam_test for a while I get "ERROR: CAM: Read failed: slot 0, tcid 1". The error seems to occur pretty randomly (after half a minute, a couple of minutes or even after an hour or so).

The actual error message is printed from line 407 in libdvbci/ci.cc:
$ nl libdvb-0.5.4/libdvbci/ci.cc | grep "Read failed"
407 esyslog("ERROR: CAM: Read failed: slot %d, tcid %d\n", slot, tcid);

I'd appreciate it if someone a bit more knowledgeable could take a look at the logs below and tell me what's going on. I don't know how this stuff works but to me it looks like there are two interrupts at the same time, and somehow the driver thread gets confused by this?

$ ./cam_set 2>&1 | awk '{print strftime("%H:%M:%S - ", systime()) $0}'
20:28:06 - Found 1CAM(s)
20:28:06 - Using /dev/dvb/adapter0/ca0
20:28:06 - Found 1 slots
20:28:09 - CAM: Conax 4.00e, 01, 0B00, 04B1
20:28:16 - New connection established.
20:28:16 - CI HANDLER: connection established
20:28:16 - CI HANDLER: 0x642 0x200 0x280 0x0 0xffff 0x6 | 0x9 0x4 0xb 0x0 0xe0 0x40 ok
20:28:16 - SysID b00
20:28:16 - Slot 0
20:28:16 - checking b00
20:28:16 - state: CAM
20:28:16 - CI HANDLER: client hung up
20:28:16 - state: NONE
20:37:14 - ERROR: CAM: Read failed: slot 0, tcid 1
20:37:14 -
20:37:20 - CAM: Conax 4.00e, 01, 0B00, 04B1

$ ./cam_test -q 11216000 -l V -r 24500000 -i 1602 2>&1 | awk '{print strftime("%H:%M:%S - ", systime()) $0}'
20:28:13 - Warning: TP already defined:
20:28:13 - ID: 1 SATID: 1
20:28:16 - Channel: TV4 apid: 0x280 vpid: 0x200 ttpid: 0x240
20:28:16 - CAM Test: 0x642 0x200 0x280 0x0 0xffff 0x6

Syslog:

May 12 20:37:14 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:14 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:14 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:14 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:14 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:14 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:14 htpc kernel: dvb_ca_en50221_slot_shutdown
May 12 20:37:14 htpc kernel: Slot 0 shutdown
May 12 20:37:14 htpc kernel: CAMCHANGE IRQ slot:0 change_type:1
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:14 htpc last message repeated 243 times
May 12 20:37:14 htpc kernel: CAMREADY IRQ slot:0
May 12 20:37:14 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:14 htpc kernel: TUPLE type:0x1d length:4
May 12 20:37:14 htpc kernel: 0x00: 0x00 .
May 12 20:37:14 htpc kernel: 0x01: 0xdb .
May 12 20:37:14 htpc kernel: 0x02: 0x08 .
May 12 20:37:14 htpc kernel: 0x03: 0xff .
May 12 20:37:14 htpc kernel: TUPLE type:0x1c length:3
May 12 20:37:14 htpc kernel: 0x00: 0x00 .
May 12 20:37:14 htpc kernel: 0x01: 0x08 .
May 12 20:37:14 htpc kernel: 0x02: 0xff .
May 12 20:37:14 htpc kernel: TUPLE type:0x15 length:21
May 12 20:37:14 htpc kernel: 0x00: 0x05 .
May 12 20:37:14 htpc kernel: 0x01: 0x00 .
May 12 20:37:14 htpc kernel: 0x02: 0x53 S
May 12 20:37:14 htpc kernel: 0x03: 0x43 C
May 12 20:37:14 htpc kernel: 0x04: 0x4d M
May 12 20:37:14 htpc kernel: 0x05: 0x00 .
May 12 20:37:14 htpc kernel: 0x06: 0x44 D
May 12 20:37:14 htpc kernel: 0x07: 0x56 V
May 12 20:37:14 htpc kernel: 0x08: 0x42 B
May 12 20:37:14 htpc kernel: 0x09: 0x20 May 12 20:37:14 htpc kernel: 0x0a: 0x43 C
May 12 20:37:14 htpc kernel: 0x0b: 0x41 A
May 12 20:37:14 htpc kernel: 0x0c: 0x20 May 12 20:37:14 htpc kernel: 0x0d: 0x4d M
May 12 20:37:14 htpc kernel: 0x0e: 0x6f o
May 12 20:37:14 htpc kernel: 0x0f: 0x64 d
May 12 20:37:14 htpc kernel: 0x10: 0x75 u
May 12 20:37:14 htpc kernel: 0x11: 0x6c l
May 12 20:37:14 htpc kernel: 0x12: 0x65 e
May 12 20:37:14 htpc kernel: 0x13: 0x00 .
May 12 20:37:14 htpc kernel: 0x14: 0xff .
May 12 20:37:14 htpc kernel: TUPLE type:0x20 length:4
May 12 20:37:14 htpc kernel: 0x00: 0xff .
May 12 20:37:14 htpc kernel: 0x01: 0xff .
May 12 20:37:14 htpc kernel: 0x02: 0x01 .
May 12 20:37:14 htpc kernel: 0x03: 0x00 .
May 12 20:37:14 htpc kernel: TUPLE type:0x1a length:21
May 12 20:37:14 htpc kernel: 0x00: 0x01 .
May 12 20:37:14 htpc kernel: 0x01: 0x0f .
May 12 20:37:14 htpc kernel: 0x02: 0xfe .
May 12 20:37:14 htpc kernel: 0x03: 0x01 .
May 12 20:37:14 htpc kernel: 0x04: 0x01 .
May 12 20:37:14 htpc kernel: 0x05: 0xc0 .
May 12 20:37:14 htpc kernel: 0x06: 0x0e .
May 12 20:37:14 htpc kernel: 0x07: 0x41 A
May 12 20:37:14 htpc kernel: 0x08: 0x02 .
May 12 20:37:14 htpc kernel: 0x09: 0x44 D
May 12 20:37:14 htpc kernel: 0x0a: 0x56 V
May 12 20:37:14 htpc kernel: 0x0b: 0x42 B
May 12 20:37:14 htpc kernel: 0x0c: 0x5f _
May 12 20:37:14 htpc kernel: 0x0d: 0x43 C
May 12 20:37:14 htpc kernel: 0x0e: 0x49 I
May 12 20:37:14 htpc kernel: 0x0f: 0x5f _
May 12 20:37:14 htpc kernel: 0x10: 0x56 V
May 12 20:37:14 htpc kernel: 0x11: 0x31 1
May 12 20:37:14 htpc kernel: 0x12: 0x2e .
May 12 20:37:14 htpc kernel: 0x13: 0x30 0
May 12 20:37:14 htpc kernel: 0x14: 0x30 0
May 12 20:37:14 htpc kernel: TUPLE type:0x1b length:17
May 12 20:37:14 htpc kernel: 0x00: 0xc9 .
May 12 20:37:14 htpc kernel: 0x01: 0x41 A
May 12 20:37:14 htpc kernel: 0x02: 0x19 .
May 12 20:37:14 htpc kernel: 0x03: 0x37 7
May 12 20:37:14 htpc kernel: 0x04: 0x55 U
May 12 20:37:14 htpc kernel: 0x05: 0x4e N
May 12 20:37:14 htpc kernel: 0x06: 0x5e ^
May 12 20:37:14 htpc kernel: 0x07: 0x1d .
May 12 20:37:14 htpc kernel: 0x08: 0x56 V
May 12 20:37:14 htpc kernel: 0x09: 0xaa .
May 12 20:37:14 htpc kernel: 0x0a: 0x60 `
May 12 20:37:14 htpc kernel: 0x0b: 0x20 May 12 20:37:14 htpc kernel: 0x0c: 0x03 .
May 12 20:37:14 htpc kernel: 0x0d: 0x03 .
May 12 20:37:14 htpc kernel: 0x0e: 0x50 P
May 12 20:37:14 htpc kernel: 0x0f: 0xff .
May 12 20:37:14 htpc kernel: 0x10: 0xff .
May 12 20:37:14 htpc kernel: TUPLE type:0x1b length:37
May 12 20:37:14 htpc kernel: 0x00: 0xcf .
May 12 20:37:14 htpc kernel: 0x01: 0x04 .
May 12 20:37:14 htpc kernel: 0x02: 0x09 .
May 12 20:37:14 htpc kernel: 0x03: 0x37 7
May 12 20:37:14 htpc kernel: 0x04: 0x55 U
May 12 20:37:14 htpc kernel: 0x05: 0x4d M
May 12 20:37:14 htpc kernel: 0x06: 0x5d ]
May 12 20:37:14 htpc kernel: 0x07: 0x1d .
May 12 20:37:14 htpc kernel: 0x08: 0x56 V
May 12 20:37:14 htpc kernel: 0x09: 0x22 "
May 12 20:37:14 htpc kernel: 0x0a: 0xc0 .
May 12 20:37:14 htpc kernel: 0x0b: 0x09 .
May 12 20:37:14 htpc kernel: 0x0c: 0x44 D
May 12 20:37:14 htpc kernel: 0x0d: 0x56 V
May 12 20:37:14 htpc kernel: 0x0e: 0x42 B
May 12 20:37:14 htpc kernel: 0x0f: 0x5f _
May 12 20:37:14 htpc kernel: 0x10: 0x48 H
May 12 20:37:14 htpc kernel: 0x11: 0x4f O
May 12 20:37:14 htpc kernel: 0x12: 0x53 S
May 12 20:37:14 htpc kernel: 0x13: 0x54 T
May 12 20:37:14 htpc kernel: 0x14: 0x00 .
May 12 20:37:14 htpc kernel: 0x15: 0xc1 .
May 12 20:37:14 htpc kernel: 0x16: 0x0e .
May 12 20:37:14 htpc kernel: 0x17: 0x44 D
May 12 20:37:14 htpc kernel: 0x18: 0x56 V
May 12 20:37:14 htpc kernel: 0x19: 0x42 B
May 12 20:37:14 htpc kernel: 0x1a: 0x5f _
May 12 20:37:14 htpc kernel: 0x1b: 0x43 C
May 12 20:37:14 htpc kernel: 0x1c: 0x49 I
May 12 20:37:14 htpc kernel: 0x1d: 0x5f _
May 12 20:37:14 htpc kernel: 0x1e: 0x4d M
May 12 20:37:14 htpc kernel: 0x1f: 0x4f O
May 12 20:37:14 htpc kernel: 0x20: 0x44 D
May 12 20:37:14 htpc kernel: 0x21: 0x55 U
May 12 20:37:14 htpc kernel: 0x22: 0x4c L
May 12 20:37:14 htpc kernel: 0x23: 0x45 E
May 12 20:37:14 htpc kernel: 0x24: 0x00 .
May 12 20:37:14 htpc kernel: TUPLE type:0x14 length:0
May 12 20:37:14 htpc kernel: TUPLE type:0xff length:0
May 12 20:37:14 htpc kernel: Valid DVB CAM detected MANID:ffff DEVID:1 CONFIGBASE:0x1fe CONFIGOPTION:0xf
May 12 20:37:14 htpc kernel: dvb_ca_en50221_set_configoption
May 12 20:37:14 htpc kernel: Set configoption 0xf, read configoption 0xf
May 12 20:37:14 htpc kernel: DVB CAM validated successfully
May 12 20:37:14 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:16 htpc last message repeated 1798 times
May 12 20:37:16 htpc kernel: dvb_ca_en50221_link_init
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status succeeded timeout:1
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: CAM supports DA IRQ
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status succeeded timeout:1
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: Chosen link buffer size of 128
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status
May 12 20:37:16 htpc kernel: dvb_ca_en50221_wait_if_status succeeded timeout:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:16 htpc kernel: dvb_ca: DVB CAM detected and initialised successfully
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_do_ioctl
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0
May 12 20:37:16 htpc kernel: dvb_ca_en50221_thread_wakeup
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_read_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_read
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_write
May 12 20:37:16 htpc kernel: dvb_ca_en50221_write_data
May 12 20:37:16 htpc kernel: dvb_ca_en50221_io_poll
May 12 20:37:16 htpc kernel: FR/DA IRQ slot:0

--
Info:
To unsubscribe send a mail to ecartis@linuxtv.org with "unsubscribe linux-dvb" as subject.

Follow-Ups:
- [linux-dvb] Re: Nova-s CAM/CI support
  - From: Andrew de Quincey <adq_dvb@lidskialf.net>
- [linux-dvb] Re: Nova-s CAM/CI support
  - From: Andrew de Quincey <adq_dvb@lidskialf.net>

References:
- [linux-dvb] Nova-s CAM/CI support
  - From: "Paolo Scaffardi" <scaffardi@airventsam.it>
- [linux-dvb] Re: Nova-s CAM/CI support
  - From: Andrew de Quincey <adq_dvb@lidskialf.net>

Prev by Date: [linux-dvb] FE_CAN_MUTE_TS and delays in FE_SET_FRONTEND
Next by Date: [linux-dvb] Re: Nova-s CAM/CI support
Previous by thread: [linux-dvb] Re: Nova-s CAM/CI support
Next by thread: [linux-dvb] Re: Nova-s CAM/CI support
Index(es):
- Date
- Thread

Home | Main Index | Thread Index