[mythtv-users] Back to back recording issues, and musical sound cards.

Jim Beckett beckett.jim at gmail.com
Fri Jan 15 10:16:16 UTC 2010


Hello Everyone!

I am experiencing some weird issues with my current MythTV system, and 
would love some ideas from those of you who know more than I do...

I expect that probably includes everyone on the list ;) .

I recently did a fresh install of Mythbuntu 9.10, and am overall pretty 
impressed by it, but the Family Appreciation Factor is suffering at the 
moment, and I could really use some insight to solving the issues I am 
having here.

I've tried to gather the log information and have put it at the end of 
the message. Sorry in advance, if the length of this message irritates 
anyone.

My setup is as follows:

Backend (recording issues) / Frontend (sound issues)
Remote Frontend (no issues)

Frontend/Backend system
Mythbuntu 9.10 - 64-Bit
mythbackend version: branches/release-0-22-fixes [22594] www.mythtv.org
AMD 4000+ CPU 64-bit, 2 GB RAM
Two Avermedia A180 HD Cards - Each card is set to only record 1 program 
at a time. I would like to change this to 2 at a time, but I haven't 
figured out if the cards support it, or not.
One Hauppauge PVR-150 (using it for remote control functions only)
3 500GB Hardisks (2 sata, 1 USB) All formatted Ext3 - I don't notice any 
issues with this. I have slow-delete turned on.
On Comcast Portland, catching the clear QAM channels directly over the 
cable.
I use Schedules Direct, have manually mapped out the channels, and the 
HD capture cards are set to open on demand, and are set to not scan for 
program info.


Issue One: Start time conflict? (for back-to-back programs on the same 
channel).

I was recording these shows tonight:

Community  NBC  8:00-8:30
(Recorded Fine)

Parks and Recreation NBC 8:30-9:00
(FAILED to Record - Start time showed 8:29 in the Previously Recorded 
screen with a red conflict indicator. It should have been an 8:30 Start 
time.)

The Mentalist CBS  8:00-9:00
(Recorded Fine)

I noticed an NTP program update in the system updates a few days ago, so 
I think it probably corrected the system time in the process of the 
update, but would that explain the incorrect start time for Parks and 
recreation?

 From the backend log, I don't even see an attempt to record the Parks 
and Recreation program, even though a tuner was free at the time (8:30). 
See log below.


Issue Two: Partial Recording - tuning issue?

I had two recordings scheduled for 30 Rock tonight. They were 
back-to-back, on the same channel.

30 Rock "Klaus and Greta" (9:00-9:30) Recorded fine.
30 Rock "Black Light Attack!" (9:30-10:00) Only recorded the last 12 
minutes of the show.

I think that the second show actually began recording when I logged into 
a remote* frontend to figure out why we could not see the second 
recording on the main front-end when we were ready to begin watching it.

(* I was on the remote frontend because it is NOT cool with the women 
folk, for me to mess around with the main system during tv watching hours.)

In the backend log I see some strange activity, but frankly, can't tell 
what is really going on. I know that I did NOT schedule American Masters 
"Hollywood Chinese" which was showing on the PBS channel. And, I cannot 
think of a reason either of the tuners should be on that channel as they 
had only been tuned to CBS and NBC for the recordings tonight. (No live 
TV took place until the sound issue (below) came up, so that shouldn't 
be why it is in the logs.) See log below.


Issue Three: Musical Chairs for sound card drivers?

(I suspect that this really belongs on the Ubuntu forum, but it seems to 
me that the MythTV users probably have more experience with this.)

Often after a reboot, I will attempt to watch live 
tv/recordings/videos/*whatever* and I will have no sound.

I find that I can temporarily fix this by going into the frontend and 
switching the audio device from ALSA:default to /dev/dsp2, and then 
sound works.

After random reboots, I will not have sound until I go back into the 
General settings in the front-end, and switch it back to ALSA:default.

I suspect that this has to do with the order the sound modules load. It 
looks like the alsa modules for the A180 capture cards are loading 
before the on board sound... I have attached a filtered dmesg below



So, my question about this is how do I tell this Ubuntu 9.10 
installation to load the snd_via82xx module first? /*no kidding kernel, 
just do it*/

Any help with any of these issues would be greatly appreciated.

Thanks in Advance!

Jim


Log Entries for Issue One:

2010-01-14 20:27:24.495 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 8 min
2010-01-14 20:29:23.935 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 20:29:23.967 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 20:29:23.968 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 20:29:23.970 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 20:30:00.423 TVRec(6): Changing from Watching RecordingOnly 
to None
2010-01-14 20:30:00.438 Reschedule requested for id 0.
2010-01-14 20:30:00.446 Finished recording Community "Investigative 
Journalism": channel 1081
2010-01-14 20:30:00.544 Recording designated 1080i/p because width was 1920
2010-01-14 20:30:00.642 Scheduled 123 items in 0.2 = 0.01 match + 0.19 place
2010-01-14 20:30:01.600 Finished recording Community "Investigative 
Journalism": channel 1081
2010-01-14 20:30:02.565 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 20:30:02.573 Using runtime prefix = /usr
2010-01-14 20:30:02.574 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 20:30:02.575 Empty LocalHostName.
2010-01-14 20:30:02.576 Using localhost value of tv
2010-01-14 20:30:02.577 Testing network connectivity to '192.168.0.30'
2010-01-14 20:30:02.712 New DB connection, total: 1
2010-01-14 20:30:02.724 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 20:30:02.725 Closing DB connection named 'DBManager0'
2010-01-14 20:30:02.726 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 20:30:02.730 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 20:30:02.732 New DB connection, total: 2
2010-01-14 20:30:02.734 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 20:30:05.253 AFD: Opened codec 0x139def0, id(MPEG2VIDEO) 
type(Video)
2010-01-14 20:30:05.254 AFD: codec AC3 has 6 channels
2010-01-14 20:30:05.255 AFD: Opened codec 0x139ce60, id(AC3) type(Audio)
2010-01-14 20:30:06.018 Preview: Grabbed preview 
'/recordings2/files/1081_20100114200000.mpg' 1920x1088 at 64s
2010-01-14 20:34:23.976 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:



Log Entries for Issue Two:

2010-01-14 21:00:00.358 TVRec(5): Changing from Watching RecordingOnly 
to None
2010-01-14 21:00:00.363 Finished recording The Mentalist "Red Scare": 
channel 1061
2010-01-14 21:00:00.364 Reschedule requested for id 0.
2010-01-14 21:00:00.365 Recording designated 1080i/p because width was 1920
2010-01-14 21:00:00.536 Scheduled 120 items in 0.2 = 0.00 match + 0.16 place
2010-01-14 21:00:01.404 Finished recording The Mentalist "Red Scare": 
channel 1061
2010-01-14 21:00:02.335 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 21:00:02.345 Using runtime prefix = /usr
2010-01-14 21:00:02.346 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:00:02.347 Empty LocalHostName.
2010-01-14 21:00:02.348 Using localhost value of tv
2010-01-14 21:00:02.349 Testing network connectivity to '192.168.0.30'
2010-01-14 21:00:02.403 New DB connection, total: 1
2010-01-14 21:00:02.409 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:02.409 Closing DB connection named 'DBManager0'
2010-01-14 21:00:02.425 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:02.432 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 21:00:02.439 New DB connection, total: 2
2010-01-14 21:00:02.447 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:05.098 AFD: Opened codec 0x1a9fd90, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:00:05.099 AFD: codec AC3 has 6 channels
2010-01-14 21:00:05.100 AFD: Opened codec 0x1a9ed40, id(AC3) type(Audio)
2010-01-14 21:00:05.101 AFD: codec AC3 has 1 channels
2010-01-14 21:00:05.102 AFD: Opened codec 0x1a9f380, id(AC3) type(Audio)
2010-01-14 21:00:06.035 Preview: Grabbed preview 
'/recordings2/files/1061_20100114200000.mpg' 1920x1088 at 64s
2010-01-14 21:00:10.388 JobQueue: Commercial Flagging Starting for 30 
Rock "Klaus and Greta" recorded from channel 1081 at Thu Jan 14 21:00:00 
2010
2010-01-14 21:00:10.613 Using runtime prefix = /usr
2010-01-14 21:00:10.616 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:00:10.618 Empty LocalHostName.
2010-01-14 21:00:10.619 Using localhost value of tv
2010-01-14 21:00:10.620 Testing network connectivity to '192.168.0.30'
2010-01-14 21:00:10.648 New DB connection, total: 1
2010-01-14 21:00:10.667 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:10.668 Closing DB connection named 'DBManager0'
2010-01-14 21:00:10.670 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:10.674 New DB connection, total: 2
2010-01-14 21:00:10.675 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:00:10.712 MythContext: Connecting to backend server: 
192.168.0.30:6543 (try 1 of 1)
2010-01-14 21:00:10.714 Using protocol version 50
2010-01-14 21:00:10.715 MainServer::ANN Monitor
2010-01-14 21:00:10.717 adding: tv as a client (events: 0)
2010-01-14 21:00:10.718 MainServer::ANN Monitor
2010-01-14 21:00:10.720 adding: tv as a client (events: 1)
2010-01-14 21:00:22.820 MainServer::ANN Monitor
2010-01-14 21:00:22.821 adding: tv as a client (events: 1)
2010-01-14 21:00:30.928 AFD: Opened codec 0x20dd720, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:00:30.929 AFD: codec AC3 has 6 channels
2010-01-14 21:00:30.930 AFD: Opened codec 0x20ddd60, id(AC3) type(Audio)
2010-01-14 21:00:30.933 MythContext: Connecting to backend server: 
192.168.0.30:6543 (try 1 of 1)
2010-01-14 21:00:30.935 Using protocol version 50
2010-01-14 21:00:30.936 MainServer::ANN Playback
2010-01-14 21:00:30.937 adding: tv as a client (events: 0)
2010-01-14 21:00:30.954 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(1041,9223372036854775807,#2) out of 41
2010-01-14 21:04:50.239 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:04:50.309 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:04:50.310 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:04:50.323 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:05:24.752 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:08:38.110 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(1099,9223372036854775807,#566) out of 607
2010-01-14 21:09:54.405 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:09:54.490 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:09:54.491 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:09:54.611 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:14:54.639 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:14:54.753 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:14:54.779 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:14:54.834 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:17:03.868 MainServer::ANN Monitor
2010-01-14 21:17:03.879 adding: tv as a client (events: 0)
2010-01-14 21:19:59.879 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:19:59.989 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:19:59.990 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:20:00.000 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:20:25.598 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:23:25.303 MainServer::ANN Playback
2010-01-14 21:23:25.305 adding: tv as a client (events: 0)
2010-01-14 21:23:25.613 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(42204,9223372036854775807,#4) out of 1599
2010-01-14 21:23:28.424 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(42321,9223372036854775807,#3) out of 1602
2010-01-14 21:23:35.075 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(42411,9223372036854775807,#7) out of 1609
2010-01-14 21:23:51.725 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(42606,9223372036854775807,#18) out of 1627
2010-01-14 21:24:08.442 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(43106,9223372036854775807,#19) out of 1646
2010-01-14 21:25:06.060 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:25:06.135 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:25:06.140 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:25:06.200 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:29:08.855 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(43594,9223372036854775807,#351) out of 1997
2010-01-14 21:29:25.421 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(52593,9223372036854775807,#18) out of 2015
2010-01-14 21:29:42.192 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(53082,9223372036854775807,#21) out of 2036
2010-01-14 21:29:46.764 TVRec(6): Changing from Watching RecordingOnly 
to None
2010-01-14 21:29:46.912 Finished recording 30 Rock "Klaus and Greta": 
channel 1081
2010-01-14 21:29:46.995 Reschedule requested for id 0.
2010-01-14 21:29:47.111 Recording designated 1080i/p because width was 1920
2010-01-14 21:29:48.012 Scheduled 119 items in 1.0 = 0.00 match + 1.01 place
2010-01-14 21:29:48.401 Finished recording 30 Rock "Klaus and Greta": 
channel 1081
2010-01-14 21:29:54.923 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 21:29:54.954 Using runtime prefix = /usr
2010-01-14 21:29:54.967 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:29:55.067 Empty LocalHostName.
2010-01-14 21:29:55.076 Using localhost value of tv
2010-01-14 21:29:55.092 Testing network connectivity to '192.168.0.30'
2010-01-14 21:29:55.318 New DB connection, total: 1
2010-01-14 21:29:55.412 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:29:55.438 Closing DB connection named 'DBManager0'
2010-01-14 21:29:55.476 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:29:55.488 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 21:29:55.502 New DB connection, total: 2
2010-01-14 21:29:55.503 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:29:58.775 AFD: Opened codec 0x1ab8f10, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:29:58.776 AFD: codec AC3 has 6 channels
2010-01-14 21:29:58.777 AFD: Opened codec 0x1ab9dc0, id(AC3) type(Audio)
2010-01-14 21:30:00.783 Preview: Grabbed preview 
'/recordings2/files/1081_20100114210000.mpg' 1920x1088 at 64s
2010-01-14 21:30:05.168 [mpeg2video @ 0x7f93cd5e8820]ac-tex damaged at 11 27
2010-01-14 21:30:05.200 [mpeg2video @ 0x7f93cd5e8820]Warning MVs not 
available
2010-01-14 21:30:06.766 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 21:30:06.768 Using runtime prefix = /usr
2010-01-14 21:30:06.773 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:30:06.774 Empty LocalHostName.
2010-01-14 21:30:06.775 Using localhost value of tv
2010-01-14 21:30:06.776 Testing network connectivity to '192.168.0.30'
2010-01-14 21:30:06.789 New DB connection, total: 1
2010-01-14 21:30:06.795 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:30:06.796 Closing DB connection named 'DBManager0'
2010-01-14 21:30:06.804 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:30:06.808 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 21:30:06.811 New DB connection, total: 2
2010-01-14 21:30:06.812 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:30:09.239 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:30:09.284 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:30:09.285 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:30:09.293 AFD: Opened codec 0xb4cbc0, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:30:09.294 AFD: codec AC3 has 6 channels
2010-01-14 21:30:09.295 AFD: Opened codec 0xb4bb50, id(AC3) type(Audio)
2010-01-14 21:30:09.304 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:30:09.861 Preview: Grabbed preview 
'/recordings2/files/1081_20100114210000.mpg' 1920x1088 at 64s
2010-01-14 21:31:09.623 MainServer::ANN Monitor
2010-01-14 21:31:09.626 adding: tv as a client (events: 1)
2010-01-14 21:31:20.784 MainServer::ANN Monitor
2010-01-14 21:31:20.785 adding: tv as a client (events: 1)
2010-01-14 21:31:33.058 MainServer::ANN Monitor
2010-01-14 21:31:33.059 adding: tv as a client (events: 1)
2010-01-14 21:35:11.337 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:35:11.379 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:35:11.380 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:35:11.381 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:35:26.225 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15 min
2010-01-14 21:40:15.388 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:40:15.440 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:40:15.441 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:40:15.443 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:45:22.449 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:45:22.482 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:45:22.483 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:45:22.485 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:46:11.775 MainServer::ANN Playback
2010-01-14 21:46:11.785 adding: tv as a client (events: 0)
2010-01-14 21:46:11.809 TVRec(6): Changing from None to Watching 
WatchingLiveTV
2010-01-14 21:46:11.857 TVRec(6): HW Tuner: 6->6
2010-01-14 21:46:14.846 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:46:16.802 Finished recording 30 Rock "Black Light 
Attack!": channel 1081
2010-01-14 21:46:16.840 Finished recording 30 Rock "Black Light 
Attack!": channel 1081
2010-01-14 21:46:16.909 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:46:19.075 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(23,9223372036854775807,#1) out of 2
2010-01-14 21:46:19.100 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(23,9223372036854775807,#1) out of 2
2010-01-14 21:46:28.471 TVRec(6): HW Tuner: 6->6
2010-01-14 21:46:31.701 Finished recording 30 Rock "Black Light 
Attack!": channel 1081
2010-01-14 21:46:32.255 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:46:32.496 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 21:46:32.503 Using runtime prefix = /usr
2010-01-14 21:46:32.504 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:46:32.505 Empty LocalHostName.
2010-01-14 21:46:32.505 Using localhost value of tv
2010-01-14 21:46:32.506 Testing network connectivity to '192.168.0.30'
2010-01-14 21:46:32.564 New DB connection, total: 1
2010-01-14 21:46:32.568 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:46:32.569 Closing DB connection named 'DBManager0'
2010-01-14 21:46:32.570 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:46:32.574 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 21:46:32.576 New DB connection, total: 2
2010-01-14 21:46:32.577 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:46:33.084 DTVSM(/dev/dvb/adapter1/frontend0) Error: Wrong 
PMT; pmt->pn(14) desired(13)
2010-01-14 21:46:33.135 DTVSM(/dev/dvb/adapter1/frontend0) Error: Wrong 
PMT; pmt->pn(1) desired(13)
2010-01-14 21:46:34.187 Finished recording American Masters "Hollywood 
Chinese": channel 1101
2010-01-14 21:46:34.213 Finished recording American Masters "Hollywood 
Chinese": channel 1101
2010-01-14 21:46:34.257 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:46:35.129 AFD: Opened codec 0x1ac0210, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:46:35.143 AFD: codec AC3 has 6 channels
2010-01-14 21:46:35.144 AFD: Opened codec 0x1abf1c0, id(AC3) type(Audio)
2010-01-14 21:46:35.539 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(28,9223372036854775807,#0) out of 1
2010-01-14 21:46:35.604 RecBase(6:/dev/dvb/adapter1/frontend0): 
GetKeyframePositions(28,9223372036854775807,#0) out of 1
2010-01-14 21:46:35.624 Preview: Grabbed preview 
'/livetv/files/1081_20100114214616.mpg' 1920x1088 at 64s
2010-01-14 21:47:04.776 TVRec(6): Changing from Watching WatchingLiveTV 
to None
2010-01-14 21:47:04.778 Unknown type, recording width was 0
2010-01-14 21:47:05.811 Finished recording American Masters "Hollywood 
Chinese": channel 1101
2010-01-14 21:47:43.416 Reschedule requested for id -1.
2010-01-14 21:47:43.639 Scheduled 120 items in 0.2 = 0.04 match + 0.18 place
2010-01-14 21:47:43.651 TVRec(5): ASK_RECORDING 5 0 0 0
2010-01-14 21:47:43.685 TVRec(5): Changing from None to Watching 
RecordingOnly
2010-01-14 21:47:43.688 TVRec(5): HW Tuner: 5->5
2010-01-14 21:47:46.352 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:47:46.357 Started recording: 30 Rock "Black Light 
Attack!": channel 1081 on cardid 5, sourceid 1
2010-01-14 21:48:15.632 JobQueue: Commercial Flagging Starting for 30 
Rock "Black Light Attack!" recorded from channel 1081 at Thu Jan 14 
21:48:00 2010
2010-01-14 21:48:15.730 Using runtime prefix = /usr
2010-01-14 21:48:15.736 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:48:15.737 Empty LocalHostName.
2010-01-14 21:48:15.737 Using localhost value of tv
2010-01-14 21:48:15.739 Testing network connectivity to '192.168.0.30'
2010-01-14 21:48:15.759 New DB connection, total: 1
2010-01-14 21:48:15.766 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:48:15.768 Closing DB connection named 'DBManager0'
2010-01-14 21:48:15.769 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:48:15.773 New DB connection, total: 2
2010-01-14 21:48:15.774 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:48:15.799 MythContext: Connecting to backend server: 
192.168.0.30:6543 (try 1 of 1)
2010-01-14 21:48:15.801 Using protocol version 50
2010-01-14 21:48:15.803 MainServer::ANN Monitor
2010-01-14 21:48:15.805 adding: tv as a client (events: 0)
2010-01-14 21:48:15.806 MainServer::ANN Monitor
2010-01-14 21:48:15.808 adding: tv as a client (events: 1)
2010-01-14 21:48:26.328 Expiring 0 MBytes for 1081 @ Thu Jan 14 21:30:00 
2010 => 30 Rock "Black Light Attack!"
2010-01-14 21:48:26.328 Expiring 19 MBytes for 1081 @ Thu Jan 14 
21:30:00 2010 => 30 Rock "Black Light Attack!"
2010-01-14 21:48:26.334 Expiring 0 MBytes for 1101 @ Thu Jan 14 21:30:00 
2010 => American Masters "Hollywood Chinese"
2010-01-14 21:48:26.338 Expiring 32 MBytes for 1101 @ Thu Jan 14 
21:30:00 2010 => American Masters "Hollywood Chinese"
2010-01-14 21:48:31.987 AFD: Opened codec 0x12d2da0, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:48:31.988 AFD: codec AC3 has 6 channels
2010-01-14 21:48:31.989 AFD: Opened codec 0x12ca7e0, id(AC3) type(Audio)
2010-01-14 21:48:31.992 MythContext: Connecting to backend server: 
192.168.0.30:6543 (try 1 of 1)
2010-01-14 21:48:31.993 Using protocol version 50
2010-01-14 21:48:31.994 MainServer::ANN Playback
2010-01-14 21:48:31.995 adding: tv as a client (events: 0)
2010-01-14 21:48:31.995 RecBase(5:/dev/dvb/adapter0/frontend0): 
GetKeyframePositions(1105,9223372036854775807,#7) out of 47
2010-01-14 21:50:26.345 AutoExpire: CalcParams(): Max required Free 
Space: 3.0 GB w/freq: 15 min
2010-01-14 21:50:28.491 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:50:28.528 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:50:28.528 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:50:28.531 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:51:17.700 MainServer::ANN Monitor
2010-01-14 21:51:17.701 adding: lenny.thenet. as a client (events: 0)
2010-01-14 21:51:17.702 MainServer::ANN Monitor
2010-01-14 21:51:17.703 adding: lenny.thenet. as a client (events: 1)
2010-01-14 21:51:20.582 MainServer::ANN Monitor
2010-01-14 21:51:20.589 adding: lenny.thenet. as a client (events: 0)
2010-01-14 21:51:20.780 mythbackend version: branches/release-0-22-fixes 
[22594] www.mythtv.org
2010-01-14 21:51:20.783 Using runtime prefix = /usr
2010-01-14 21:51:20.784 Using configuration directory = /home/mythtv/.mythtv
2010-01-14 21:51:20.784 Empty LocalHostName.
2010-01-14 21:51:20.785 Using localhost value of tv
2010-01-14 21:51:20.787 Testing network connectivity to '192.168.0.30'
2010-01-14 21:51:20.808 New DB connection, total: 1
2010-01-14 21:51:20.820 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:51:20.821 Closing DB connection named 'DBManager0'
2010-01-14 21:51:20.823 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:51:20.829 Current MythTV Schema Version (DBSchemaVer): 1244
2010-01-14 21:51:20.831 New DB connection, total: 2
2010-01-14 21:51:20.833 Connected to database 'mythconverg' at host: 
192.168.0.30
2010-01-14 21:51:21.050 AFD: Opened codec 0x22abec0, id(MPEG2VIDEO) 
type(Video)
2010-01-14 21:51:21.052 AFD: codec AC3 has 6 channels
2010-01-14 21:51:21.053 AFD: Opened codec 0x22aae30, id(AC3) type(Audio)
2010-01-14 21:51:21.542 Preview: Grabbed preview 
'/recordings2/files/1081_20100114214800.mpg' 1920x1088 at 64s
2010-01-14 21:51:21.626 MainServer::ANN Playback
2010-01-14 21:51:21.628 adding: lenny.thenet. as a client (events: 0)
2010-01-14 21:51:21.629 MainServer::HandleAnnounce FileTransfer
2010-01-14 21:51:21.630 adding: lenny.thenet. as a remote file transfer
2010-01-14 21:55:32.536 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/videos/files:
2010-01-14 21:55:32.565 UPnpMedia: BuildMediaMap Done. Found 91 objects
2010-01-14 21:55:32.566 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/recordings2/videos:
2010-01-14 21:55:32.568 UPnpMedia: BuildMediaMap Done. Found 1 objects
2010-01-14 21:56:34.817 RecBase(5:/dev/dvb/adapter0/frontend0): 
GetKeyframePositions(1297,9223372036854775807,#536) out of 583
2010-01-14 21:59:00.749 Reschedule requested for id 0.
2010-01-14 21:59:00.960 Scheduled 120 items in 0.2 = 0.00 match + 0.20 place
2010-01-14 21:59:30.139 TVRec(5): ASK_RECORDING 5 29 0 0



dmesg output (filtered) and /proc/asound/modules output for Issue Three:

[    8.409556] saa7130/34: v4l2 driver version 0.2.15 loaded
[    8.809269] saa7134 0000:00:08.0: PCI INT A -> GSI 16 (level, low) -> 
IRQ 16
[    8.809277] saa7133[0]: found at 0000:00:08.0, rev: 209, irq: 16, 
latency: 32, mmio: 0xef001000
[    8.809284] saa7133[0]: subsystem: 1461:1044, board: AVerMedia 
AVerTVHD MCE A180 [card=75,insmod option]
[    8.809299] saa7133[0]: board init: gpio is 210474
[    8.809309] IRQ 16/saa7133[0]: IRQF_DISABLED is not guaranteed on 
shared IRQs
[    9.000011] saa7133[0]: i2c eeprom 00: 61 14 44 10 54 20 1c 00 43 43 
a9 1c 55 d2 b2 92
[    9.000021] saa7133[0]: i2c eeprom 10: 00 ff 86 0f ff 20 00 00 00 00 
00 00 00 00 00 00
[    9.000029] saa7133[0]: i2c eeprom 20: 01 40 01 02 02 ff 01 03 06 ff 
01 11 00 00 00 00
[    9.000036] saa7133[0]: i2c eeprom 30: 00 00 00 00 00 00 00 00 00 00 
00 00 00 00 00 00
[    9.000044] saa7133[0]: i2c eeprom 40: ff 64 00 c2 14 16 ff ff 00 00 
00 00 00 00 00 00
[    9.000051] saa7133[0]: i2c eeprom 50: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000059] saa7133[0]: i2c eeprom 60: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000066] saa7133[0]: i2c eeprom 70: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000074] saa7133[0]: i2c eeprom 80: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000082] saa7133[0]: i2c eeprom 90: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000089] saa7133[0]: i2c eeprom a0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000097] saa7133[0]: i2c eeprom b0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000104] saa7133[0]: i2c eeprom c0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000112] saa7133[0]: i2c eeprom d0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000119] saa7133[0]: i2c eeprom e0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.000127] saa7133[0]: i2c eeprom f0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.001108] saa7133[0]: registered device video1 [v4l2]
[    9.001137] saa7133[0]: registered device vbi1
[    9.001310] saa7134 0000:00:09.0: PCI INT A -> GSI 17 (level, low) -> 
IRQ 17
[    9.001319] saa7133[1]: found at 0000:00:09.0, rev: 209, irq: 17, 
latency: 32, mmio: 0xef000000
[    9.001325] saa7133[1]: subsystem: 1461:1044, board: AVerMedia 
AVerTVHD MCE A180 [card=75,insmod option]
[    9.001343] saa7133[1]: board init: gpio is 2104cf
[    9.001352] IRQ 17/saa7133[1]: IRQF_DISABLED is not guaranteed on 
shared IRQs
[    9.190013] saa7133[1]: i2c eeprom 00: 61 14 44 10 54 20 1c 00 43 43 
a9 1c 55 d2 b2 92
[    9.190023] saa7133[1]: i2c eeprom 10: 00 ff 86 0f ff 20 00 00 00 00 
00 00 00 00 00 00
[    9.190031] saa7133[1]: i2c eeprom 20: 01 40 01 02 02 ff 01 03 06 ff 
01 11 00 00 00 00
[    9.190039] saa7133[1]: i2c eeprom 30: 00 00 00 00 00 00 00 00 00 00 
00 00 00 00 00 00
[    9.190046] saa7133[1]: i2c eeprom 40: ff 64 00 c2 14 16 ff ff 00 00 
00 00 00 00 00 00
[    9.190054] saa7133[1]: i2c eeprom 50: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190061] saa7133[1]: i2c eeprom 60: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190069] saa7133[1]: i2c eeprom 70: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190076] saa7133[1]: i2c eeprom 80: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190084] saa7133[1]: i2c eeprom 90: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190092] saa7133[1]: i2c eeprom a0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190099] saa7133[1]: i2c eeprom b0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190107] saa7133[1]: i2c eeprom c0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190114] saa7133[1]: i2c eeprom d0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190122] saa7133[1]: i2c eeprom e0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.190129] saa7133[1]: i2c eeprom f0: ff ff ff ff ff ff ff ff ff ff 
ff ff ff ff ff ff
[    9.191121] saa7133[1]: registered device video2 [v4l2]
[    9.191144] saa7133[1]: registered device vbi2
[    9.280118] saa7134 ALSA driver for DMA sound loaded
[    9.280133] IRQ 16/saa7133[0]: IRQF_DISABLED is not guaranteed on 
shared IRQs
[    9.280158] saa7133[0]/alsa: saa7133[0] at 0xef001000 irq 16 
registered as card -2
[    9.280498] IRQ 17/saa7133[1]: IRQF_DISABLED is not guaranteed on 
shared IRQs
[    9.280518] saa7133[1]/alsa: saa7133[1] at 0xef000000 irq 17 
registered as card -1

[    9.486505] VIA 82xx Audio 0000:00:11.5: PCI INT C -> Link[ALKC] -> 
GSI 22 (level, low) -> IRQ 22
[    9.486675] VIA 82xx Audio 0000:00:11.5: setting latency timer to 64

[   11.931680] DVB: registering new adapter (saa7133[0])
[   11.952584] saa7134 0000:00:08.0: firmware: requesting dvb-fe-nxt2004.fw
[   18.142607] DVB: registering new adapter (saa7133[1])
[   18.162527] saa7134 0000:00:09.0: firmware: requesting dvb-fe-nxt2004.fw
[   24.202541] saa7134 0000:00:09.0: firmware: requesting dvb-fe-nxt2004.fw
[   20.152514] nxt2004: Firmware upload complete
[   26.290014] nxt2004: Firmware upload complete

output of: less /proc/asound/modules when /dev/dsp2 is the audio device 
selected that actually plays back sound.

0 saa7134_alsa
1 saa7134_alsa
2 snd_via82xx

I'm not sure, but I suspect that when sound is working under 
ALSA:default that the output would look like this:

0 snd_via82xx
1 saa7134_alsa
2 saa7134_alsa


More information about the mythtv-users mailing list