[mythtv-users] PVR 150-MCE won't record

Wed Sep 28 17:20:34 UTC 2005

I'm seeing something similar, mythtv can't seem to get a file handle.

I'ts not a read write issue, the files are being created,

I'm not sure what's going on but i did see a change related to this in the
change log.

Mik Luich
[root at mythserver var]# ls -rl Multimedia/
total 8
drwxrwxr-x 2 mythtv mythtv 4096 Sep 28 12:15 videos
drwxrwxrwx 2 root mythtv 4096 Sep 28 13:16 tv
[root at mythserver var]# ls -rl Multimedia/tv
total 0
-rw-r--r-- 1 root mythtv 0 Sep 28 13:16 nfslockfile.lock
-rw-r--r-- 1 root root 0 Sep 28 13:16 1063_20050928131600.mpg
-rw-r--r-- 1 root root 0 Sep 28 13:10 1063_20050928131000.mpg
-rw-r--r-- 1 root root 0 Sep 28 13:05 1063_20050928130500.mpg
[root at mythserver var]#

[root at mythserver ~]# mythbackend
2005-09-28 13:16:12.318 Using runtime prefix = /usr/local
2005-09-28 13:16:12.465 New DB connection, total: 1
Starting up as the master server.
2005-09-28 13:16:12.551 New DB connection, total: 2
2005-09-28 13:16:12.601 Channel(/dev/video0): CheckChannel failed. Please
verify channel "244" in the "mythtv-setup" Channel Editor.
2005-09-28 13:16:12.630 New DB scheduler connection
is defined, but isn't attached to a cardinput.
2005-09-28 13:16:12.643 mythbackend version: 0.19.20050712-1
www.mythtv.org<http://www.mythtv.org>
2005-09-28 13:16:12.643 Enabled verbose msgs : important general
2005-09-28 13:16:12.645 New DB connection, total: 3
2005-09-28 13:16:12.668 AutoExpire: Found 1 recorders w/max rate of 72
MiB/min
2005-09-28 13:16:12.672 AutoExpire: space: 2.1 GB w/freq: 10 min
2005-09-28 13:16:14.689 Reschedule requested for id -1.
2005-09-28 13:16:15.721 Scheduled 1 items in 1.0 = 0.95 match + 0.06 place
2005-09-28 13:16:15.729 Recording starts soon, AUTO-Startup assumed
2005-09-28 13:16:15.779 Started recording Buck Rogers in the 25th Century
"Buck's Duel to the Death": channel 1063 on cardid 1, sourceid 1
2005-09-28 13:16:16.905 ret_pid(0) child(2820) status(0x0)
2005-09-28 13:16:17.907 ret_pid(0) child(2820) status(0x0)
2005-09-28 13:16:18.909 ret_pid(2820) child(2820) status(0x0)
2005-09-28 13:16:18.909 External Tuning program exited with no error
2005-09-28 13:16:19.180 TVRec(1): Changing from None to RecordingOnly
2005-09-28 13:16:19.260 Prog title: Buck Rogers in the 25th Century
2005-09-28 13:16:19.273 TVRec(1): Waiting for recorder to start
2005-09-28 13:16:19.274 Can't enable VBI recording
vbi: Invalid argument
2005-09-28 13:16:19.275 Can't enable VBI recording
vbi: Invalid argument
2005-09-28 13:16:19.279 TVRec(1): Recorder started
2005-09-28 13:16:22.715 Commercial Flagging Starting for Buck Rogers in the
25th Century "Buck's Duel to the Death" recorded from channel 1063 at Wed
Sep 28 13:16:00 2005
2005-09-28 13:16:23.087 Using runtime prefix = /usr/local
2005-09-28 13:16:23.183 New DB connection, total: 1
2005-09-28 13:16:23.222 New DB connection, total: 2
2005-09-28 13:16:23.243 Invalid file handle when opening
/var/Multimedia/tv/1063_20050928131600.mpg. 4 retries remaining.
2005-09-28 13:16:23.747 Invalid file handle when opening
/var/Multimedia/tv/1063_20050928131600.mpg. 3 retries remaining.
2005-09-28 13:16:24.249 Invalid file handle when opening
/var/Multimedia/tv/1063_20050928131600.mpg. 2 retries remaining.
2005-09-28 13:16:24.754 Invalid file handle when opening
/var/Multimedia/tv/1063_20050928131600.mpg. 1 retries remaining.
select timeout
2005-09-28 13:16:25.256 Invalid file handle when opening
/var/Multimedia/tv/1063_20050928131600.mpg. 0 retries remaining.
2005-09-28 13:16:25.891 Connecting to backend server:
192.168.1.200:6543<http://192.168.1.200:6543>(try 1 of 5)
2005-09-28 13:16:25.900 MainServer::HandleAnnounce Playback
2005-09-28 13:16:25.901 adding: mythserver.luich as a client (events: 0)
2005-09-28 13:16:26.012 MainServer::HandleAnnounce Playback
2005-09-28 13:16:26.013 adding: mythserver.luich as a client (events: 1)
select timeout
2005-09-28 13:16:30.037 NVP::OpenFile(): Error, file not found:
/var/Multimedia/tv/1063_20050928131600.mpg
2005-09-28 13:16:30.215 Finished, 0 break(s) found.

On 8/23/05, Ryan Oleston <ryan.oleston at gmail.com> wrote:
>
> I have recently installed mythtv on FC3 following Jarod's guide. I can
> watch and pause live TV using 150-mce, but I can't record any shows. I can
> start the record and stop the record, but when I check the file sizes they
> are 0 GB. Here are my backend and frontend logs:
> mythbackend
> 2005-08-23 17:48:18.616 New DB connection, total: 1
> Starting up as the master server.
> 2005-08-23 17:48:18.626 New DB connection, total: 2
> 2005-08-23 17:48:18.653 New DB connection, total: 3
> 2005-08-23 17:48:18.955 New DB scheduler connection
> 2005-08-23 17:48:18.959 mythbackend version: 0.18.1.20050523-1
> www.mythtv.org <http://www.mythtv.org/>
> 2005-08-23 17:48:18.959 Enabled verbose msgs : important general
> 2005-08-23 17:48:20.959 Reschedule requested for id -1.
> 2005-08-23 17:48:20.972 Scheduled 0 items in 0.0 = 0.01 match + 0.00 place
> 2005-08-23 17:48:20.974 Seem to be woken up by USER
> 2005-08-23 17:49:09.668 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:09.668 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:09.786 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:09.786 adding: mythtv as a client (events: 1)
> 2005-08-23 17:49:18.173 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:18.173 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:18.218 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:18.218 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:18.224 adding: mythtv as a remote ringbuffer
> 2005-08-23 17:49:18.233 Changing from None to WatchingLiveTV
> 2005-08-23 17:49:33.432 Reschedule requested for id 5.
> 2005-08-23 17:49:33.564 Scheduled 1 items in 0.1 = 0.12 match + 0.01 place
> 2005-08-23 17:49:33.728 Changing from WatchingLiveTV to None
> 2005-08-23 17:49:33.809 Started recording "NBC Nightly News" on channel:
> 1005 on cardid: 1, sourceid 1
> 2005-08-23 17:49:34.189 Changing from None to RecordingOnly
> 2005-08-23 17:49:34.337 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:34.338 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:36.935 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:36.935 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:37.952 Reschedule requested for id 5.
> 2005-08-23 17:49:37.981 Scheduled 13 items in 0.0 = 0.01 match + 0.02place
> 2005-08-23 17:49:39.491 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:39.491 adding: mythtv as a client (events: 0)
> 2005-08-23 17:49:42.056 MainServer::HandleAnnounce Playback
> 2005-08-23 17:49:42.056 adding: mythtv as a client (events: 0)
>
> frontend
> 2005-08-23 17:52:42.852 Unknown state transition: 0 to 0
> 2005-08-23 17:52:42.853 write->8 27 GET_RECORDER_FROM_NUM[]:[]1:
> 2005-08-23 17:52:42.861 write->14 21 MYTH_PROTO_VERSION 15:
> 2005-08-23 17:52:42.867 Using protocol version 15
> 2005-08-23 17:52:42.868 write->14 21 ANN Playback mythtv 0:
> 2005-08-23 17:52:42.875 write->14 33 QUERY_RECORDER 1[]:[]IS_RECORDING:
> 2005-08-23 17:52:42.882 write->14 34 QUERY_RECORDER 1[]:[]GET_RECORDING:
> 2005-08-23 17:52:42.889 write->8 403 FILL_PROGRAM_INFO[]:[]mythtv[] :[]NBC
> N...
> 2005-08-23 17:52:42.927 Invalid file handle when opening
> /var/video/recordings/1005_20050823175000_20050823180000.nuv. 4 retries
> remaining.
> 2005-08-23 17:52:43.429 Invalid file handle when opening
> /var/video/recordings/1005_20050823175000_20050823180000.nuv. 3 retries
> remaining.
> 2005-08-23 17:52:43.931 Invalid file handle when opening
> /var/video/recordings/1005_20050823175000_20050823180000.nuv. 2 retries
> remaining.
> 2005-08-23 17:52:44.433 Invalid file handle when opening
> /var/video/recordings/1005_20050823175000_20050823180000.nuv. 1 retries
> remaining.
> 2005-08-23 17:52:44.935 Invalid file handle when opening
> /var/video/recordings/1005_20050823175000_20050823180000.nuv. 0 retries
> remaining.
> 2005-08-23 17:52:45.436 Unknown state transition: 0 to 0
>
> Does anybody know what the invalid file handle errors are? Has anybody
> else seen this problem?
> Thanks!
> Ryan
>
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-users
>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://mythtv.org/pipermail/mythtv-users/attachments/20050928/b33eb0c9/attachment.htm