> On Wednesday 07 June 2006 09:03, Martin Dauskardt wrote: > > > From: Hans Verkuil <[EMAIL PROTECTED]> > > > > > > > But why is there such a long delay with the recommended ioctl? > > > > What makes the difference? How can I improve it? > > > > > > No idea. Try to set from debug messages in > > > ivtv_stop_v4l2_decode_stream() to see what part takes so much time. > > > > Hi Hans, > > could you describe this a little more? Which debug level do you > > recommend for this? > > No, I mean just add printk() messages at several places in the function. > You can see the timestamps of when the message was logged in > (usually) /var/log/messages. So if you see a sizeable gap in timestamps > between two printk's, then the code in between must be the culprit. > It's old-fashioned, but it works.
I am still not sure in which area I should set the printk`s. With debug level 21 set I now have the impression that it is not the stop decode area, but the start decode area. That`s strange, because starting the decoder works with the same ioctl commands very fast, if the decoder is _stopped_ before with a fwapi call. The log shows a lag of 5 seconds between IVTV_IOC_PLAY and "Starting v4l2_decode". Hans, do you have any idea what is happening here ? Jun 11 17:03:37 linvdr user.info vdr: [1432] switching to channel 44 Jun 11 17:03:37 linvdr user.debug vdr: [1445] transfer thread started (pid=1445, tid=1445) Jun 11 17:03:37 linvdr user.debug vdr: [1446] receiver on device 1 thread started (pid=1446, tid=1446) Jun 11 17:03:37 linvdr user.debug vdr: [1447] TS buffer on device 1 thread started (pid=1447, tid=1447) Jun 11 17:03:37 linvdr user.debug vdr: [1432] creating directory /vtx/T-8468-3841-129 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.debug vdr: [1436] video directory scanner thread ended (pid=1436, tid=1436) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.debug vdr: [1432] setting watchdog timer to 900 seconds Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: v4l2 ioctl 0x400c401e Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: IVTV_IOC_STOP_DECODE Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: v4l2 ioctl 0x4008402a Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: IVTV_IOC_S_START_DECODE Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: v4l2 ioctl 0x00004025 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 ioctl: IVTV_IOC_PLAY Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x00000001 (CX2341X_DEC_START_PLAYBACK) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000004, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:37 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:37 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b7 (CX2341X_ENC_SET_VBI_LINE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000c7 (CX2341X_ENC_SET_PGM_INDEX_INFO) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000c7 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ENC: PGM Index at 0x00180150 with 0x00000190 elements Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b9 (CX2341X_ENC_SET_STREAM_TYPE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000b9 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000bb (CX2341X_ENC_SET_OUTPUT_PORT) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000bb not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x0000008f (CX2341X_ENC_SET_FRAME_RATE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x0000008f not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000091 (CX2341X_ENC_SET_FRAME_SIZE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x00000091 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000099 (CX2341X_ENC_SET_ASPECT_RATIO) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x00000099 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000095 (CX2341X_ENC_SET_BIT_RATE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x00000095 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000097 (CX2341X_ENC_SET_GOP_PROPERTIES) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x00000097 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000b1 (CX2341X_ENC_SET_3_2_PULLDOWN) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000b1 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000c5 (CX2341X_ENC_SET_GOP_CLOSURE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000c5 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000bd (CX2341X_ENC_SET_AUDIO_PROPERTIES) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000bd not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x0000009b (CX2341X_ENC_SET_DNR_FILTER_MODE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x0000009b not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x0000009d (CX2341X_ENC_SET_DNR_FILTER_PROPS) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x0000009d not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x0000009f (CX2341X_ENC_SET_CORING_LEVELS) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x0000009f not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000a1 (CX2341X_ENC_SET_SPATIAL_FILTER_TYPE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000a1 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000d0 (CX2341X_ENC_SET_FRAME_DROP_RATE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x000000d0 not stored Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000dc (CX2341X_ENC_MISC) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000d5 (CX2341X_ENC_SET_EVENT_NOTIFICATION) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: Disabling digitizer Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000cd (CX2341X_ENC_INITIALIZE_INPUT) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: Enabling digitizer Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000081 (CX2341X_ENC_START_CAPTURE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: result not ready, waiting 10 ms (attempt 2) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: VBI insertion started Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv start v4l2 stream Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000d9 (CX2341X_ENC_MUTE_VIDEO) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000081 (CX2341X_ENC_START_CAPTURE) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x000000d3 (CX2341X_ENC_REFRESH_INPUT) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000007, after 0x00000000) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 128 free 0 dma 0 full 0 io Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:38 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x00000000 fill; 16 free 0 dma 0 full 0 io Jun 11 17:03:38 linvdr user.info kernel: ivtv0 ioctl: v4l2 ioctl 0xc04c40cc Jun 11 17:03:38 linvdr user.info kernel: ivtv0 ioctl: IVTV_IOC_FWAPI Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: API Call: 0x00000056 (CX2341X_OSD_SET_FRAMEBUFFER_WINDOW) Jun 11 17:03:38 linvdr user.info kernel: ivtv0 api: cmd: 0x00000056 arg 4 stored as 0x00000000 Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x00000000 fill; 16 free 0 dma 0 full 0 io Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_write Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: ivtv_fill_dec_buffers, 1000 bytes Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: DEC: write(0) 16 bufs, 0x00000000 fill; 15 free 0 dma 0 full 1 io Jun 11 17:03:38 linvdr user.info kernel: ivtv0 info: DEC: returning 1000 ... mainly repeating the last 4 lines for 4 seconds (complete log: http://home.arcor-online.de/martin.dauskardt/debug.tgz ) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: Starting v4l2_decode Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: Setting some initial decoder settings Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000016 (CX2341X_DEC_SET_AUDIO_MODE) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: cmd: 0x00000016 not stored Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000018 (CX2341X_DEC_SET_DISPLAY_BUFFERS) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: cmd: 0x00000018 arg 0 stored as 0x00000001 but changed to 0x00000000 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x0000001e (CX2341X_DEC_SET_PREBUFFERING) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: cmd: 0x0000001e not stored Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DMA/MPG type 0x00000000,size 0x00008800,offset 0x000fe6c0 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000019 (CX2341X_DEC_EXTRACT_VBI) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000004, after 0x00000000) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: Decoder VBI RE-Insert start 0x0019ac00 size 0x0000be00 type 1 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000017 (CX2341X_DEC_SET_EVENT_NOTIFICATION) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: cmd: 0x00000017 not stored Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1256 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DMA/MPG type 0x00000000,size 0x00008800,offset 0x00106ec0 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: read 34860, 96212 bytes left Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: v4l2 read Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 126 free 2 dma 0 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1256 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: read 34904, 96168 bytes left Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: v4l2 read Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 128 free 0 dma 0 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000004, after 0x00000000) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x0000001a (CX2341X_DEC_SET_DECODER_SOURCE) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DMA/MPG type 0x00000000,size 0x00008800,offset 0x0010f6c0 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000004, after 0x00000000) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000008 (CX2341X_DEC_SET_DMA_BLOCK_SIZE) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x00000001 (CX2341X_DEC_START_PLAYBACK) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: result not ready, waiting 10 ms (attempt 2) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1256 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: read 34948, 96124 bytes left Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DMA/MPG type 0x00000000,size 0x00008000,offset 0x00117ec0 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: v4l2 read Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 127 free 1 dma 0 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1256 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DMA/MPG type 0x00000000,size 0x00008000,offset 0x0011fec0 Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd ioctl: IVTVFB_IOCTL_PREP_FRAME Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: ivtvfb_prep_dec_dma_to_device, 1638400 bytes, 401 pages Jun 11 17:03:42 linvdr user.info kernel: ivtv0-osd info: Sched OSD dma: addr: 0x0cd80000, array_size 0x00190ff8, type 0x00000001 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: read 32944, 98128 bytes left Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: v4l2 read Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 127 free 1 dma 0 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1256 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: read 32856, 98216 bytes left Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: v4l2 read Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_read: stream 0.. Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ENC: 128 bufs, 0x00000000 fill; 128 free 0 dma 0 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: Releasing mailbox (before 0x00000004, after 0x00000000) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: Mailbox 10: 0x00000000 0x0040fb00 0x00100000 0x00000000 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_unmap_user_dma Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: encoder thread sleeping 1257 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 api: API Call: 0x0000000b (CX2341X_DEC_SCHED_DMA_FROM_HOST) Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: decoder thread sleeping 1261 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: dec_work_queue: Failed at 4294900213 (0) jiffies Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: decoder thread sleeping 1261 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: Mailbox 10: 0x00000000 0x0041fb00 0x00100000 0x00000000 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: 16 bufs, 0x000f0000 fill; 1 free 1 dma 14 full 0 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: write(0) 16 bufs, 0x000f0000 fill; 0 free 1 dma 14 full 1 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: returning 1000 Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_write Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: ivtv_fill_dec_buffers, 1000 bytes Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: write(0) 16 bufs, 0x000f0000 fill; 0 free 1 dma 14 full 1 io Jun 11 17:03:42 linvdr user.info kernel: ivtv0 info: DEC: returning 1000 _______________________________________________ ivtv-devel mailing list [email protected] http://ivtvdriver.org/mailman/listinfo/ivtv-devel
