View unanswered posts    View active topics

All times are UTC - 6 hours





Post new topic Reply to topic  [ 6 posts ] 
Print view Previous topic   Next topic  
Author Message
Search for:
PostPosted: Sun Dec 04, 2005 6:03 pm 
Offline
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
Since adding a second nova-t pci (909) card I am seeing more frontend crashes. Is there any technique to diagnose the cause ?

I've just started the frontend from an xterm - but it has not crashed yet (typical :) )

I had thought it was possible due to using the Retro theme - but Ive see it crash a few times since switching back to blue.

Im using a athlon 1.4 with 256mb ram and r5a16.
Crashes seem to occur when im doing something in the ui - like leaving watching a recording.


Top
 Profile  
 
 Post subject:
PostPosted: Sun Dec 04, 2005 8:06 pm 
Offline
Joined: Fri Sep 19, 2003 7:05 pm
Posts: 5088
Location: Fontana, Ca
In addition, take a look at the backend log.

_________________
cesman

When the source is open, the possibilities are endless!


Top
 Profile  
 
 Post subject:
PostPosted: Sun Dec 04, 2005 11:03 pm 
Offline
Joined: Thu Mar 25, 2004 11:00 am
Posts: 9551
Location: Arlington, MA
This weeks favorite pages! The first one is the top level page, the second one has more detail for looking at the logs.
http://www.knoppmythwiki.org/index.php?page=TroubleShooting
http://www.knoppmythwiki.org/index.php?page=CheckingLogFiles


Top
 Profile  
 
 Post subject:
PostPosted: Mon Dec 05, 2005 5:36 pm 
Offline
Joined: Wed Aug 24, 2005 3:44 am
Posts: 210
ok - it crashed again - at 22:59

looking in mythbackend.log i see

2005-12-05 22:59:27.429 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-05 22:59:35.117 Reschedule requested for id 0.
2005-12-05 22:59:35.713 Scheduled 59 items in 0.6 = 0.03 match + 0.56 place

tail .xsession-errors shows
2005-12-05 22:49:12.155 prebuffering pause
2005-12-05 22:49:12.171 prebuffering pause
2005-12-05 22:49:12.187 prebuffering pause
2005-12-05 22:49:12.203 prebuffering pause
2005-12-05 22:49:12.219 prebuffering pause
2005-12-05 22:49:12.235 prebuffering pause
2005-12-05 22:49:12.255 prebuffering pause
2005-12-05 22:59:15.882 Changing from WatchingPreRecorded to None
2005-12-05 22:59:15.937 Changing from None to None
2005-12-05 22:59:25.138 prebuffering pause

nothing much evident there either

tail /var/log/messages
Dec 5 20:08:01 decivo -- MARK --
Dec 5 20:28:02 decivo -- MARK --
Dec 5 20:48:02 decivo -- MARK --
Dec 5 21:08:02 decivo -- MARK --
Dec 5 21:28:03 decivo -- MARK --
Dec 5 21:48:03 decivo -- MARK --
Dec 5 22:08:03 decivo -- MARK --
Dec 5 22:28:04 decivo -- MARK --
Dec 5 22:48:04 decivo -- MARK --
Dec 5 23:08:05 decivo -- MARK --

nothing there either

tail /var/log/syslog

Dec 5 22:17:01 decivo /USR/SBIN/CRON[4202]: (root) CMD ( run-parts --report /etc/cron.hourly)
Dec 5 22:28:04 decivo -- MARK --
Dec 5 22:30:03 decivo kernel: cx88[0]/2: cx8802_restart_queue
Dec 5 22:30:03 decivo kernel: cx88[0]/2: cx8802_restart_queue: queue is empty
Dec 5 22:30:04 decivo kernel: cx88[0]/2: queue is empty - first active
Dec 5 22:30:04 decivo kernel: cx88[0]/2: cx8802_start_dma 752
Dec 5 22:30:04 decivo kernel: cx88[0]/2: setting the interrupt mask
Dec 5 22:30:04 decivo kernel: cx88[0]/2: [c6cfb360/0] cx8802_buf_queue - first active
Dec 5 22:48:04 decivo -- MARK --
Dec 5 23:08:05 decivo -- MARK --


tail /var/log/daemon.log

Dec 5 19:06:51 decivo init: Switching to runlevel: 6
Dec 5 19:06:55 decivo mysqld[2852]: 051205 19:06:55 /usr/sbin/mysqld: Normal shutdown
Dec 5 19:06:55 decivo mysqld[2852]:
Dec 5 19:06:55 decivo mysqld[2852]: 051205 19:06:55 /usr/sbin/mysqld: Shutdown Complete
Dec 5 19:06:55 decivo mysqld[2852]:
Dec 5 19:06:55 decivo mysqld_safe[10309]: ended
Dec 5 19:08:03 decivo mysqld_safe[2868]: started
Dec 5 19:08:04 decivo mysqld[2871]: /usr/sbin/mysqld: ready for connections.
Dec 5 19:08:04 decivo mysqld[2871]: Version: '4.0.22-log' socket: '/var/run/mysqld/mysqld.sock' port: 3306 Source distribution
Dec 5 19:08:04 decivo /etc/mysql/debian-start[2888]: Checking for crashed MySQL tables.


is it the 2005-12-05 22:59:27.429 IOBOUND - blocking in ThreadedFileWriter::Write()
in mythbackend thats causing the crash ?


I also spotted

2005-12-05 22:42:15.319 Realtime priority would require SUID as root.

in .xsession-errors - is this significant ?


is this possibly due to the addition of a second nova-t pci tuner card at the weekend ?


thanks in advance


Top
 Profile  
 
 Post subject:
PostPosted: Mon Dec 05, 2005 7:15 pm 
Offline
Joined: Thu Mar 25, 2004 11:00 am
Posts: 9551
Location: Arlington, MA
declanh wrote:
is it the 2005-12-05 22:59:27.429 IOBOUND - blocking in ThreadedFileWriter::Write()
in mythbackend thats causing the crash ?

That or it was caused by the crash.
declanh wrote:
2005-12-05 22:42:15.319 Realtime priority would require SUID as root.

in .xsession-errors - is this significant ?

No.


Top
 Profile  
 
 Post subject:
PostPosted: Mon Dec 12, 2005 3:16 pm 
Offline
Joined: Sun Sep 25, 2005 3:50 pm
Posts: 1013
Location: Los Angeles
After fixing my swap problem I am getting IOBOUND errors, too. I only get them when using my pcHDTV HD-3000 as the source tuner for OTA HDTV broadcasts. After a few seconds of live HDTV, I get a lot of stuttering, pixelation and finnaly a freeze. My PVR-150 with DISH Network has no problems. I found this thread on the MythTV mailing list archive. What I got out of it was (1) check to see if your DMA is enabled and (2) it's possible that the recording file writer buffer size may be too small. (See about 2/3 way down on the MythTV mailing list thread referenced above). I looked for the file Chris Pinkham referred to, but it does not seem to be in the same place nor the same file name on Knoppmyth. Does anyone know where the "RingBuffer.cpp" file is? I also found this thread from OpenSubscriber. I'm guessing this is not the same as cache which we can easily adjust in the Knoppmyth Setup GUI. For kicks, here's a sampling from my logs:

Code:
# pico /var/log/mythtv/backend.log
2005-12-11 18:46:18.167 DVB#0 Recorder: Card opened successfully (using PS mode).
2005-12-11 18:46:18.183 DVB#0 Data read from DMX - This is for debugging with transform.c
2005-12-11 18:46:46.714 DVB#0 DVB signal 93b5 | snr f655 | ber    0 | unc    0
2005-12-11 18:46:46.725 DVB#0 Status: LOCK.
2005-12-11 18:46:46.730 DVB#0 Multiplex Locked
2005-12-11 18:46:47.622 DVB#0 Successfully tuned to channel 51.
2005-12-11 18:46:47.649 DVB#0 Data read from DMX - This is for debugging with transform.c
2005-12-11 18:54:59.245 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:10.514 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:12.857 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:18.584 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:24.738 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:35.532 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:41.339 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:47.774 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:55:58.664 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:06.168 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:17.987 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:24.334 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:31.200 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:39.201 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:43.870 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:56:49.042 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:57:06.688 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:57:15.616 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:57:29.902 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:58:01.680 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:58:08.068 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:58:39.585 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 18:58:27.714 DVB#0 ERROR - Reading Section.
          (75) Value too large for defined data type
2005-12-11 18:59:28.016 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 19:00:34.160 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-12-11 19:00:10.243 DVB#0 ERROR - Reading Section.
          (75) Value too large for defined data type



Code:
# pico /var/log/syslog

Dec 11 18:57:45 mythbox kernel: spurious 8259A interrupt: IRQ7.
Dec 11 18:59:46 mythbox kernel: oom-killer: gfp_mask=0x201d2, order=0
Dec 11 18:59:50 mythbox kernel: Mem-info:
Dec 11 18:59:52 mythbox kernel: DMA per-cpu:
Dec 11 18:59:52 mythbox kernel: cpu 0 hot: low 2, high 6, batch 1 used:4
Dec 11 18:59:52 mythbox kernel: cpu 0 cold: low 0, high 2, batch 1 used:0
Dec 11 18:59:52 mythbox kernel: Normal per-cpu:
Dec 11 18:59:52 mythbox kernel: cpu 0 hot: low 62, high 186, batch 31 used:158
Dec 11 18:59:52 mythbox kernel: cpu 0 cold: low 0, high 62, batch 31 used:61
Dec 11 18:59:52 mythbox kernel: HighMem per-cpu: empty
Dec 11 18:59:52 mythbox kernel: Free pages:        4764kB (0kB HighMem)
Dec 11 18:59:52 mythbox kernel: Active:57741 inactive:57337 dirty:0 writeback:0 unstable:0 free:1191 slab:5894 mapped:115100 pagetables:506
Dec 11 18:59:52 mythbox kernel: DMA free:2068kB min:88kB low:108kB high:132kB active:4856kB inactive:4380kB present:16384kB pages_scanned:11377 all_unreclaimable? yes
Dec 11 18:59:52 mythbox kernel: lowmem_reserve[]: 0 495 495
Dec 11 18:59:52 mythbox kernel: Normal free:2696kB min:2800kB low:3500kB high:4200kB active:226108kB inactive:224968kB present:507072kB pages_scanned:562069 all_unreclaimable? yes
Dec 11 18:59:52 mythbox kernel: lowmem_reserve[]: 0 0 0
Dec 11 18:59:52 mythbox kernel: HighMem free:0kB min:128kB low:160kB high:192kB active:0kB inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
Dec 11 18:59:52 mythbox kernel: lowmem_reserve[]: 0 0 0
Dec 11 18:59:52 mythbox kernel: DMA: 1*4kB 0*8kB 1*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 1*2048kB 0*4096kB = 2068kB
Dec 11 18:59:52 mythbox kernel: Normal: 0*4kB 1*8kB 0*16kB 0*32kB 0*64kB 1*128kB 0*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 2696kB
Dec 11 18:59:52 mythbox kernel: HighMem: empty
Dec 11 18:59:52 mythbox kernel: Swap cache: add 191753, delete 191604, find 229/569, race 0+0
Dec 11 18:59:52 mythbox kernel: Free swap  = 0kB
Dec 11 18:59:52 mythbox kernel: Total swap = 755044kB
Dec 11 18:59:52 mythbox kernel: Free swap:            0kB
Dec 11 18:59:52 mythbox kernel: 130864 pages of RAM
Dec 11 18:59:52 mythbox kernel: 0 pages of HIGHMEM
Dec 11 18:59:52 mythbox kernel: 2696 reserved pages
Dec 11 18:59:52 mythbox kernel: 3063 pages shared
Dec 11 18:59:52 mythbox kernel: 149 pages swap cached
Dec 11 18:59:52 mythbox kernel: 0 pages dirty
Dec 11 18:59:52 mythbox kernel: 0 pages writeback
Dec 11 18:59:52 mythbox kernel: 115100 pages mapped
Dec 11 18:59:52 mythbox kernel: 5894 pages slab
Dec 11 18:59:52 mythbox kernel: 506 pages pagetables
Dec 11 18:59:52 mythbox kernel: Out of Memory: Killed process 4699 (ssh-agent).

_________________
Mike
My Hardware Profile


Top
 Profile  
 

Display posts from previous:  Sort by  
Post new topic Reply to topic  [ 6 posts ] 


All times are UTC - 6 hours




Who is online

Users browsing this forum: No registered users and 16 guests


You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot post attachments in this forum

Jump to:  
Powered by phpBB® Forum Software © phpBB Group

Theme Created By ceyhansuyu