View unanswered posts    View active topics

All times are UTC - 6 hours





Post new topic Reply to topic  [ 1 post ] 
Print view Previous topic   Next topic  
Author Message
Search for:
PostPosted: Thu Sep 22, 2005 6:25 pm 
Offline
Joined: Tue Nov 16, 2004 5:05 am
Posts: 39
Hi,

I've recently (last couple of months) upgraded from R4V5 to R5A16 with Two avermedia DVB-T 771s as my tuners. In R4V5 I never had the issue that I'm currently experiencing which can best be described as an intermittend refusal of one of the two cards (it isn't one card in particular, just one or the other) to feed data into MythTV. I have some logs below to help explain what I'm seeing.

I'd been noticing that some of my recordings were blank since upgrading to R5A16 (as mentioned, nothing has changed in the hardware deparments except I have a new DVD drive). I would go to watch recordings and see a black preview, with a message in the logs, not enough video to make a thubmnail. I knew that I hadn't seen this in R4V5 but because it only happened 2 or 3 times over a 2 month period, that I must have had a really bad signal for some reason, and I didn't think any more about it. Last night however I had the issue on a show I was hoping to record, and when I went to check how it was going and got the blank recording, I decided to investigate further.

Here is what I have managed to gather with the assistance of the logs below.

This is last nights viewing
Quote:
2005-09-22 18:00:02.663 Started recording "The Simpsons" on channel: 1017 on cardid: 1, sourceid 1
2005-09-22 18:00:03.810 DVB#0 DVB signal e43 | snr 0 | ber 0 | unc 4
2005-09-22 18:00:04.610 DVB#0 Status: LOCK.
2005-09-22 18:00:04.612 DVB#0 Multiplex Locked
2005-09-22 18:00:05.206 DVB#0 Successfully tuned to channel 10.
2005-09-22 18:00:05.597 Changing from None to RecordingOnly
2005-09-22 18:00:05.985 DVB#0 Recorder: Card opened successfully (using TS mode).
2005-09-22 18:00:06.027 DVB#0 Data read from DMX - This is for debugging with transform.c
2005-09-22 18:16:53.206 IOBOUND - blocking in ThreadedFileWriter::Write()
2005-09-22 18:30:02.597 Finished recording The Simpsons on channel: 1017
2005-09-22 18:30:02.708 Changing from RecordingOnly to None
2005-09-22 18:30:02.714 Closing DVB recorder


seems normal enough. Card #0 seems to get chosen as the first card to record with. Later on "Law and Order" started recording on card #0 without issue (not shown in this message) and then "Ghost in the Shell" was scheduled to start. Here is it's message log

Quote:
2005-09-22 22:00:02.844 Started recording "Ghost in the Shell: Stand Alone Complex" on channel: 1022 on cardid: 2, sourceid 1
2005-09-22 22:00:04.010 DVB#1 DVB signal 1204 | snr bebe | ber 0 | unc 18
2005-09-22 22:00:04.819 DVB#1 Status: LOCK.
2005-09-22 22:00:04.835 DVB#1 Multiplex Locked
2005-09-22 22:00:12.492 DVB#1 Timeout Getting PMT
2005-09-22 22:00:12.495 DVB#1 ERROR - Tuning for channel #3 failed.
2005-09-22 22:00:12.851 Changing from None to RecordingOnly
2005-09-22 22:00:12.950 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-22 22:00:14.491 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:00:15.497 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:00:16.502 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:00:17.507 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:00:18.512 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:00:19.529 DVB#1 WARNING - No data from card in 1 second.


When I went to view the recording later on (it was still technically recording at this stage), this message came up
Quote:
2005-09-22 22:32:51.699 Invalid file handle when opening /myth/tv/1022_20050922220000_20050922223000.nuv. 4 retries remaining.
.
.
.
File not found: /myth/tv/1022_20050922220000_20050922223000.nuv
2005-09-22 22:33:16.150 Not enough video to make thumbnail


As I mentioned it was still recording, so when it was due to finish recording the following appeared in the log (after a very large number of no data in 1 second messages)

Quote:
2005-09-22 22:33:20.009 Finished recording Ghost in the Shell: Stand Alone Complex on channel: 1022
2005-09-22 22:33:20.076 Changing from RecordingOnly to None
2005-09-22 22:33:20.076 Reschedule requested for id 0.
2005-09-22 22:33:20.282 Scheduled 23 items in 0.2 = 0.01 match + 0.20 place
2005-09-22 22:33:20.716 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:33:20.719 Closing DVB recorder


I then decided to try and watch live TV to work out what was going on. As I mentioend, L&O was still recording, so when I hit the Watch TV menu option, it used card #1 (which had just failed to record GITS). This is what I got.

Quote:
2005-09-22 22:33:20.806 Reschedule requested for id 0.
2005-09-22 22:33:20.902 Scheduled 23 items in 0.1 = 0.00 match + 0.09 place
2005-09-22 22:33:29.762 MainServer::HandleAnnounce Playback
2005-09-22 22:33:29.765 adding: mythtv as a client (events: 0)
2005-09-22 22:33:29.809 MainServer::HandleAnnounce Playback
2005-09-22 22:33:29.812 adding: mythtv as a client (events: 0)
2005-09-22 22:33:29.820 adding: mythtv as a remote ringbuffer
2005-09-22 22:33:29.835 Changing from None to WatchingLiveTV
2005-09-22 22:33:29.875 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-22 22:33:30.880 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:33:31.891 DVB#1 WARNING - No data from card in 1 second.
2005-09-22 22:33:32.894 DVB#1 WARNING - No data from card in 1 second.


No luck. Couldn't watch live TV. I gave up and went to bed. Next morning, I fired up Myth to do some research.

Switched on and entered Watch TV. Got the following message.

Quote:
2005-09-23 08:48:03.580 Changing from None to WatchingLiveTV
2005-09-23 08:48:03.737 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:48:03.777 DVB#1 Data read from DMX - This is for debugging with transform.c
2005-09-23 08:48:04.695 Reschedule requested for id 0.
2005-09-23 08:48:04.889 Scheduled 16 items in 0.2 = 0.01 match + 0.17 place
2005-09-23 08:48:16.529 Reschedule requested for id 0.
2005-09-23 08:48:16.632 Scheduled 16 items in 0.1 = 0.01 match + 0.09 place


Then decided to click record to make sure that I could record from watching live TV. Got the following

Quote:
2005-09-23 08:48:20.893 Reschedule requested for id 243.
2005-09-23 08:48:21.049 Scheduled 17 items in 0.2 = 0.06 match + 0.09 place
2005-09-23 08:48:21.133 Started recording "Sunrise" on channel: 1004 on cardid: 1, sourceid 1
2005-09-23 08:48:22.205 DVB#0 DVB signal f03 | snr 0 | ber 0 | unc 0
2005-09-23 08:48:23.045 DVB#0 Status: LOCK.
2005-09-23 08:48:23.054 DVB#0 Multiplex Locked
2005-09-23 08:48:23.369 DVB#0 Successfully tuned to channel 7.
2005-09-23 08:48:23.533 Changing from None to RecordingOnly
2005-09-23 08:48:23.649 DVB#0 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:48:23.682 DVB#0 Data read from DMX - This is for debugging with transform.c
.


No problem, it picked up card #0 and used it to start recording, and left me on card #1 watching the same channel. I changed channel and then hit record on another channel, so that both cards would be in use. Got the following.

Quote:
2005-09-23 08:49:10.333 Changing from None to WatchingLiveTV
2005-09-23 08:49:10.375 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:49:10.399 DVB#1 Data read from DMX - This is for debugging with transform.c
2005-09-23 08:49:15.864 Reschedule requested for id 244.
2005-09-23 08:49:15.993 Scheduled 18 items in 0.1 = 0.02 match + 0.10 place
2005-09-23 08:49:16.166 Changing from WatchingLiveTV to None
2005-09-23 08:49:16.172 Closing DVB recorder
2005-09-23 08:49:16.195 Started recording "Today" on channel: 1010 on cardid: 2, sourceid 1
2005-09-23 08:49:16.289 Changing from None to RecordingOnly
2005-09-23 08:49:16.339 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:49:16.347 DVB#1 Data read from DMX - This is for debugging with transform.c
2005-09-23 08:49:16.539 MainServer::HandleAnnounce Playback
2005-09-23 08:49:16.569 adding: mythtv as a client (events: 0)
2005-09-23 08:49:17.127 MainServer::HandleAnnounce Playback
2005-09-23 08:49:17.130 adding: mythtv as a client (events: 0)
adding pes stream at pid 0x207 with type 2
adding pes stream at pid 0x2d0 with type 4
adding pes stream at pid 0x2d1 with type 129
2005-09-23 08:49:29.217 Not enough video to make thumbnail
adding pes stream at pid 0x207 with type 2
adding pes stream at pid 0x2d0 with type 4
adding pes stream at pid 0x2d1 with type 129
adding pes stream at pid 0x302 with type 3
adding pes stream at pid 0x301 with type 2
2005-09-23 08:49:32.263 MainServer::HandleAnnounce Playback
2005-09-23 08:49:32.269 adding: mythtv as a client (events: 0)
2005-09-23 08:49:55.721 MainServer::HandleAnnounce Playback
2005-09-23 08:49:55.724 adding: mythtv as a client (events: 0)


No problems so far. I stopped both recordings from the Media library screen and started the next test. This time, rather than record from watching TV, I decided to record from the schedule. I fired up the schedule and set two programs that were already part way through showing, to record so that they would record immediately. I got the following.

Quote:
2005-09-23 08:53:03.231 Started recording "Play with Me Sesame" on channel: 1001 on cardid: 1, sourceid 1
2005-09-23 08:53:04.332 DVB#0 DVB signal f03 | snr d2d2 | ber 0 | unc 0
2005-09-23 08:53:05.131 DVB#0 Status: LOCK.
2005-09-23 08:53:05.135 DVB#0 Multiplex Locked
2005-09-23 08:53:09.433 Reschedule requested for id 246.
2005-09-23 08:53:09.552 Scheduled 20 items in 0.1 = 0.03 match + 0.09 place
2005-09-23 08:53:09.643 Started recording "Spanish News" on channel: 1022 on cardid: 2, sourceid 1
QSettings: error creating /.qt
2005-09-23 08:53:09.757 New DB connection, total: 4
2005-09-23 08:53:10.871 DVB#1 DVB signal 2c0 | snr b6b6 | ber 0 | unc 0
2005-09-23 08:53:11.648 DVB#0 Timeout Getting PMT
2005-09-23 08:53:11.651 DVB#0 ERROR - Tuning for channel #2 failed.
2005-09-23 08:53:11.674 DVB#1 Status: LOCK.
2005-09-23 08:53:11.717 DVB#1 Multiplex Locked
2005-09-23 08:53:11.784 Changing from None to RecordingOnly
2005-09-23 08:53:11.828 DVB#0 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:53:12.094 DVB#1 Successfully tuned to channel 3.
2005-09-23 08:53:12.194 Changing from None to RecordingOnly
2005-09-23 08:53:12.237 DVB#1 Recorder: Card opened successfully (using TS mode).
2005-09-23 08:53:12.242 DVB#1 Data read from DMX - This is for debugging with transform.c
2005-09-23 08:53:12.835 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:13.840 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:14.844 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:15.848 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:16.851 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:17.853 DVB#0 WARNING - No data from card in 1 second.
2005-09-23 08:53:18.857 DVB#0 WARNING - No data from card in 1 second.


What you can see from the above is that card #0 locked, but couldn't get a PMT. Card #1 locked and successfully tuned to channel. Now the channels all work, on both cards. What's wierd is that I can't lock this down to either one card or one channel. It's happening on both card #0 and card #1 (card #0 this morning, card #1 last night), and in the above examples, on two different channels (channel 3 last night, channel 2 this morning).

Any thoughts would be appreciated. I've set up the cards to use TS mode (this can be seen in the logs), but I haven't enabled the setting to only access the card when needed, but I can't see a correlation to this function, because the card is accessible, it's just not locking to the signal and supplying data. I'm going to be away for a couple of days, so don't think I'm ignoring you if I can't get back to you before Monday.

Cheers
Simon


Top
 Profile  
 

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


All times are UTC - 6 hours




Who is online

Users browsing this forum: Bing [Bot] and 23 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