Ticket #3984: myth.log.crash

File myth.log.crash, 14.2 KB (added by johnfivealive@…, 13 years ago)

Log of Crashed mythbackend Debug Run

Line 
12007-09-18 19:25:17.765 Using runtime prefix = /usr/local
22007-09-18 19:25:18.106 New DB connection, total: 1
32007-09-18 19:25:18.147 Connected to database 'mythconverg' at host: localhost
42007-09-18 19:25:18.203 Current Schema Version: 1199
5Starting up as the master server.
62007-09-18 19:25:18.573 New DB connection, total: 2
72007-09-18 19:25:18.606 Connected to database 'mythconverg' at host: localhost
82007-09-18 19:25:18.642 TVRec(1): Start channel: 49.
92007-09-18 19:25:18.689 Channel(/dev/video0): Device name 'Kworld ATSC110' driver 'saa7134'.
102007-09-18 19:25:18.702 New DB connection, total: 3
112007-09-18 19:25:18.711 Connected to database 'mythconverg' at host: localhost
122007-09-18 19:25:18.734 ChannelBase(1): Input #1: 'Television' schan(49) sourceid(1) ccid(1)
132007-09-18 19:25:18.734 ChannelBase(1): Current Input #1: 'Television'
142007-09-18 19:25:18.736 Global TVFormat Setting 'NTSC'
152007-09-18 19:25:18.737 Channel(/dev/video0): Input #1: 'Television' schan(49) tun() v4l1(NTSC) v4l2(NTSC)
162007-09-18 19:25:18.737 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
172007-09-18 19:25:18.738 Channel(/dev/video0): SetInputAndFormat(1, NTSC) (v4l v2)
182007-09-18 19:25:18.809 Channel(/dev/video0): SetFormat(NTSC) fmt(NTSC) input(1)
192007-09-18 19:25:18.834 Channel(/dev/video0)::SwitchToInput(in 1, '')
202007-09-18 19:25:18.835 Channel(/dev/video0): SetInputAndFormat(1, NTSC) (v4l v2)
212007-09-18 19:25:18.905 Channel(/dev/video0): SetChannelByString(49)
222007-09-18 19:25:18.956 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
232007-09-18 19:25:18.956 Channel(/dev/video0)::TuneTo(49): curList[47].freq(373250)
242007-09-18 19:25:18.957 Channel(/dev/video0): Tune(373250000, , analog, analog)
252007-09-18 19:25:18.993 Channel(/dev/video0)::Tune(): Frequency is now 373250000
262007-09-18 19:25:19.006 Channel(/dev/video0): InitPictureAttribute(brightness):  128
27                        [    0,  255] dflt(  128, 0.50, 128)
282007-09-18 19:25:19.007 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
29                        [    0,  127] dflt(   68, 0.54, 2321)
302007-09-18 19:25:19.008 Channel(/dev/video0): InitPictureAttribute(    colour):  63
31                        [    0,  127] dflt(   64, 0.50, 257)
322007-09-18 19:25:19.009 Channel(/dev/video0): InitPictureAttribute(       hue):  0
33                        [ -128,  127] dflt(    0, 0.50, 128)
342007-09-18 19:25:19.041 TVRec(1): SetFlags(RunMainLoop,) -> RunMainLoop,
352007-09-18 19:25:19.050 TVRec(1): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop,
362007-09-18 19:25:19.052 New DB scheduler connection
372007-09-18 19:25:19.058 Connected to database 'mythconverg' at host: localhost
382007-09-18 19:25:20.777 Main::Registering HttpStatus Extension
392007-09-18 19:25:20.790 mythbackend version: 0.21.20070910-2 www.mythtv.org
402007-09-18 19:25:20.791 Enabled verbose msgs:  important general record channel siparser
412007-09-18 19:25:20.821 AutoExpire: Found max recording rate of 72 MB/min
422007-09-18 19:25:20.822 AutoExpire: CalcParams(): Required Free Space: 2.0 GB w/freq: 10 min
432007-09-18 19:25:22.441 Reschedule requested for id -1.
442007-09-18 19:25:24.048 Scheduled 29 items in 1.6 = 1.01 match + 0.59 place
452007-09-18 19:25:24.206 Seem to be woken up by USER
462007-09-18 19:25:29.513 JobQueue: Commercial Flagging Starting for Pardon the Interruption recorded from channel 1049 at Tue Sep 18 17:32:00 2007
472007-09-18 19:25:29.713 Using runtime prefix = /usr/local
482007-09-18 19:25:29.734 New DB connection, total: 1
492007-09-18 19:25:29.738 Connected to database 'mythconverg' at host: localhost
502007-09-18 19:25:29.760 New DB connection, total: 2
512007-09-18 19:25:29.769 Connected to database 'mythconverg' at host: localhost
522007-09-18 19:25:30.001 Connecting to backend server: 192.168.1.6:6543 (try 1 of 3)
532007-09-18 19:25:30.029 Using protocol version 36
542007-09-18 19:25:30.030 MainServer::HandleAnnounce Monitor
552007-09-18 19:25:30.037 adding: codebeast as a client (events: 0)
562007-09-18 19:25:30.038 MainServer::HandleAnnounce Monitor
572007-09-18 19:25:30.039 adding: codebeast as a client (events: 1)
582007-09-18 19:25:46.338 MainServer::HandleAnnounce Monitor
592007-09-18 19:25:46.357 adding: codebeast as a client (events: 0)
602007-09-18 19:25:46.401 MainServer::HandleAnnounce Monitor
612007-09-18 19:25:46.406 adding: codebeast as a client (events: 1)
622007-09-18 19:25:46.422 Getting next free recorder after : -1
632007-09-18 19:25:46.424 Card 1 is local.
642007-09-18 19:25:46.430 MainServer::HandleAnnounce Playback
652007-09-18 19:25:46.437 adding: codebeast as a client (events: 0)
662007-09-18 19:25:46.439 TVRec(1): Changing from None to WatchingLiveTV
672007-09-18 19:25:46.445 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
682007-09-18 19:25:46.446 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
692007-09-18 19:25:46.446 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,)
702007-09-18 19:25:46.447 TVRec(1): Start channel: 49.
712007-09-18 19:25:46.448 TVRec(1): HW Tuner: 1->1
722007-09-18 19:25:46.449 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
732007-09-18 19:25:46.473 Channel(/dev/video0): Device name 'Kworld ATSC110' driver 'saa7134'.
742007-09-18 19:25:46.547 ChannelBase(1): Input #1: 'Television' schan(49) sourceid(1) ccid(1)
752007-09-18 19:25:46.547 ChannelBase(1): Current Input #1: 'Television'
762007-09-18 19:25:46.548 Global TVFormat Setting 'NTSC'
772007-09-18 19:25:46.548 Channel(/dev/video0): Input #1: 'Television' schan(49) tun() v4l1(NTSC) v4l2(NTSC)
782007-09-18 19:25:46.549 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
792007-09-18 19:25:46.550 Channel(/dev/video0)::SwitchToInput(in 1, '')
802007-09-18 19:25:46.550 Channel(/dev/video0): SetInputAndFormat(1, NTSC) (v4l v2)
812007-09-18 19:25:46.601 Channel(/dev/video0): SetChannelByString(49)
822007-09-18 19:25:46.603 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
832007-09-18 19:25:46.603 Channel(/dev/video0)::TuneTo(49): curList[47].freq(373250)
842007-09-18 19:25:46.604 Channel(/dev/video0): Tune(373250000, , analog, analog)
852007-09-18 19:25:46.629 Channel(/dev/video0)::Tune(): Frequency is now 373250000
862007-09-18 19:25:46.638 Channel(/dev/video0): InitPictureAttribute(brightness):  128
87                        [    0,  255] dflt(  128, 0.50, 128)
882007-09-18 19:25:46.690 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
89                        [    0,  127] dflt(   68, 0.54, 2321)
902007-09-18 19:25:46.691 Channel(/dev/video0): InitPictureAttribute(    colour):  63
91                        [    0,  127] dflt(   64, 0.50, 257)
922007-09-18 19:25:46.693 Channel(/dev/video0): InitPictureAttribute(       hue):  0
93                        [ -128,  127] dflt(    0, 0.50, 128)
942007-09-18 19:25:46.695 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,
952007-09-18 19:25:46.696 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,
962007-09-18 19:25:46.696 TVRec(1): Starting Recorder
972007-09-18 19:25:46.712 Using profile 'Live TV' to record
982007-09-18 19:25:46.713 TVRec(1): CreateLiveTVRingBuffer()
992007-09-18 19:25:46.713 TVRec(1): GetProgramRingBufferForLiveTV()
1002007-09-18 19:25:46.896 TVRec(1): StartedRecording(0x87f470) fn(/var/lib/mythtv/recordings/1049_20070918192546.nuv)
1012007-09-18 19:25:47.075 Chain: Appended@0 '1049_20070918192546'
1022007-09-18 19:25:47.112 TVRec(1): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
1032007-09-18 19:25:47.595 RecBase(/dev/video0): SetRingBuffer(0x8a5b40) '/var/lib/mythtv/recordings/1049_20070918192546.nuv'
1042007-09-18 19:25:47.614 RecBase(/dev/video0): SetRecording(0x8a6290) title(SportsCenter)
1052007-09-18 19:25:47.616 Channel(/dev/video0): InitPictureAttribute(brightness):  128
106                        [    0,  255] dflt(  128, 0.50, 128)
1072007-09-18 19:25:47.617 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
108                        [    0,  127] dflt(   68, 0.54, 2321)
1092007-09-18 19:25:47.619 Channel(/dev/video0): InitPictureAttribute(    colour):  63
110                        [    0,  127] dflt(   64, 0.50, 257)
1112007-09-18 19:25:47.620 Channel(/dev/video0): InitPictureAttribute(       hue):  0
112                        [ -128,  127] dflt(    0, 0.50, 128)
1132007-09-18 19:25:47.655 TVRec(1): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
1142007-09-18 19:25:47.773 TVRec(1): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
1152007-09-18 19:25:47.784 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning,RingBufferReady,
116strange error flushing buffer ...
1172007-09-18 19:25:49.009 TVRec(1): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning,RingBufferReady,
1182007-09-18 19:26:04.601 StopLiveTV(void) curRec: 0x87f470 pseudoRec: 0
1192007-09-18 19:26:04.659 TVRec(1): Changing from WatchingLiveTV to None
1202007-09-18 19:26:04.726 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReady,
1212007-09-18 19:26:04.730 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReady,
1222007-09-18 19:26:04.731 TVRec(1): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
1232007-09-18 19:26:04.875 NVR(/dev/video0) Error: Only read 2048 bytes of 4096 bytes from '/dev/dsp1
124read audio: Success
1252007-09-18 19:26:05.423 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1262007-09-18 19:26:05.556 TVRec(1): FinishedRecording(SportsCenter) in recgroup: LiveTV
1272007-09-18 19:26:05.558 Chain: Updated endtime for '1049_20070918192546' to 20070918192605
1282007-09-18 19:26:05.565 Finished recording SportsCenter: channel 1049
1292007-09-18 19:26:05.568 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1302007-09-18 19:26:05.570 TVRec(1): Tearing down RingBuffer
1312007-09-18 19:26:05.633 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1322007-09-18 19:26:09.577 Getting next free recorder after : -1
1332007-09-18 19:26:09.590 Card 1 is local.
1342007-09-18 19:26:09.594 MainServer::HandleAnnounce Playback
1352007-09-18 19:26:09.595 adding: codebeast as a client (events: 0)
1362007-09-18 19:26:09.597 TVRec(1): Changing from None to WatchingLiveTV
1372007-09-18 19:26:09.601 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1382007-09-18 19:26:09.602 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1392007-09-18 19:26:09.603 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,)
1402007-09-18 19:26:09.604 TVRec(1): Start channel: 49.
1412007-09-18 19:26:09.604 TVRec(1): HW Tuner: 1->1
1422007-09-18 19:26:09.605 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1432007-09-18 19:26:09.645 Channel(/dev/video0): Device name 'Kworld ATSC110' driver 'saa7134'.
1442007-09-18 19:26:09.719 ChannelBase(1): Input #1: 'Television' schan(49) sourceid(1) ccid(1)
1452007-09-18 19:26:09.720 ChannelBase(1): Current Input #1: 'Television'
1462007-09-18 19:26:09.720 Global TVFormat Setting 'NTSC'
1472007-09-18 19:26:09.721 Channel(/dev/video0): Input #1: 'Television' schan(49) tun() v4l1(NTSC) v4l2(NTSC)
1482007-09-18 19:26:09.722 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
1492007-09-18 19:26:09.722 Channel(/dev/video0)::SwitchToInput(in 1, '')
1502007-09-18 19:26:09.723 Channel(/dev/video0): SetInputAndFormat(1, NTSC) (v4l v2)
1512007-09-18 19:26:09.773 Channel(/dev/video0): SetChannelByString(49)
1522007-09-18 19:26:09.782 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(1)
1532007-09-18 19:26:09.783 Channel(/dev/video0)::TuneTo(49): curList[47].freq(373250)
1542007-09-18 19:26:09.783 Channel(/dev/video0): Tune(373250000, , analog, analog)
1552007-09-18 19:26:09.809 Channel(/dev/video0)::Tune(): Frequency is now 373250000
1562007-09-18 19:26:09.810 Channel(/dev/video0): InitPictureAttribute(brightness):  128
157                        [    0,  255] dflt(  128, 0.50, 128)
1582007-09-18 19:26:09.812 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
159                        [    0,  127] dflt(   68, 0.54, 2321)
1602007-09-18 19:26:09.813 Channel(/dev/video0): InitPictureAttribute(    colour):  63
161                        [    0,  127] dflt(   64, 0.50, 257)
1622007-09-18 19:26:09.815 Channel(/dev/video0): InitPictureAttribute(       hue):  0
163                        [ -128,  127] dflt(    0, 0.50, 128)
1642007-09-18 19:26:09.816 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
1652007-09-18 19:26:09.816 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
1662007-09-18 19:26:09.817 TVRec(1): Starting Recorder
1672007-09-18 19:26:09.832 Using profile 'Live TV' to record
1682007-09-18 19:26:09.833 TVRec(1): CreateLiveTVRingBuffer()
1692007-09-18 19:26:09.833 TVRec(1): GetProgramRingBufferForLiveTV()
1702007-09-18 19:26:09.853 TVRec(1): StartedRecording(0x899240) fn(/var/lib/mythtv/recordings/1049_20070918192609.nuv)
1712007-09-18 19:26:09.943 Chain: Appended@0 '1049_20070918192609'
1722007-09-18 19:26:09.947 TVRec(1): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
1732007-09-18 19:26:09.995 RecBase(/dev/video0): SetRingBuffer(0x8c0f30) '/var/lib/mythtv/recordings/1049_20070918192609.nuv'
1742007-09-18 19:26:10.004 RecBase(/dev/video0): SetRecording(0x8c1fb0) title(SportsCenter)
1752007-09-18 19:26:10.006 Channel(/dev/video0): InitPictureAttribute(brightness):  128
176                        [    0,  255] dflt(  128, 0.50, 128)
1772007-09-18 19:26:10.008 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
178                        [    0,  127] dflt(   68, 0.54, 2321)
1792007-09-18 19:26:10.009 Channel(/dev/video0): InitPictureAttribute(    colour):  63
180                        [    0,  127] dflt(   64, 0.50, 257)
1812007-09-18 19:26:10.011 Channel(/dev/video0): InitPictureAttribute(       hue):  0
182                        [ -128,  127] dflt(    0, 0.50, 128)
1832007-09-18 19:26:10.055 TVRec(1): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
1842007-09-18 19:26:10.204 TVRec(1): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
1852007-09-18 19:26:10.281 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning,RingBufferReady,
186strange error flushing buffer ...
1872007-09-18 19:26:33.437 Event socket closed. No connection to the backend.
188Bus error (core dumped)