[mythtv-users] Just lost a recorded file due to mythtranscode "renaming error"

Jeffrey J. Kosowsky mythtv at kosowsky.org
Tue Jan 12 09:54:27 UTC 2010


mythbackend.log shows:
	2010-01-11 23:53:05.439 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg done
	2010-01-11 23:53:05.494 mythtranscode: Error Renaming '/mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp' to '/mnt/media/mythtv/mythtv-raw/2443_20091108103000.nuv'
			eno: No such file or directory (2)

Indeed the file is not there anymore though the entry is still fine in
the mythconverg database.

Admittedly I had started and stopped transcoding perhaps half a dozen
times. Some in relatively rapid succession. I did this from 2
different frontends (one is on the Linux backend server and the other
is on a Windows laptop) and also from the mythweb interface. I also
crashed the frontend a couple of times and restarted the mythbackend a
couple of times during the transcoding interval -- but that is
probably all a red herring.

I saw mention somewhere that a similar error can happen if permissions are
lacking (which perhaps could be true of the mythweb process??) But I
have no real clue here.

Also, I wouldn't have thought that permissions issues would lead to
actual data loss -- in other words, I would have thought that mythtv
would do everything possible not to delete or overwrite files...

I have never seen this problem before but the following variables have
all changed for me -- first time transcoding under 0.22, first time
toggling transcoding from Windows frontend, first time toggling
transcoding from mythweb. I imagine that one of those things caused
the problem.

Any ideas what may be happening?

Note: the storage directory is mode 775 with user=root,
group=someusers. All the nuv files are root.root with 644 permissions.

--------------------------------------------------------------
Here is some more detail from the log.

2010-01-11 23:26:37.467 Connected to database 'mythconverg' at host: localhost
2010-01-11 23:26:37.500 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
...
2010-01-11 23:28:57.911 Transcoding STOPped by JobQueue
2010-01-11 23:28:58.059 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg stopped because of stop command
2010-01-11 23:28:58.092 Deleting /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:28:58.163 JobQueue: Transcode Errored: Ask This Old House "Installing Sliding Glass Door": High Quality (exit status 240, job status was "Aborted")
...
2010-01-11 23:29:41.474 JobQueue: Transcode Starting for Ask This Old House "Installing Sliding Glass Door": High Quality (949.4 MB)
...
2010-01-11 23:29:45.412 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
...
2010-01-11 23:29:48.300 Honoring the cutlist while transcoding
2010-01-11 23:29:48.327 Cutlist        : 0-230,2223-4074,43763-53869
2010-01-11 23:29:48.353 Original Length: 53869 frames
2010-01-11 23:29:48.375 New Length     : 41682 frames
2010-01-11 23:29:48.487 SampleRate: Attempted to add a rate 32000 Hz, which is not in the list of allowed rates.
2010-01-11 23:29:48.603 Copying Audio while transcoding Video
2010-01-11 23:29:48.641 Fast-Forwarding from 0 to 230
...
2010-01-11 23:31:07.694 Fast-Forwarding from 2223 to 4074
...
2010-01-11 23:42:47.597 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:47.980 MythContext: Connecting to backend server: 127.0.0.1:6543 (try 1 of 1)
....
2010-01-11 23:42:48.573 AFD: Opened codec 0x8a07280, id(MPEG2VIDEO) type(Video)
2010-01-11 23:42:48.615 AFD: codec AC3 has 2 channels
2010-01-11 23:42:48.641 AFD: Opened codec 0x8a0fba0, id(AC3) type(Audio)
2010-01-11 23:42:48.665 AFD: codec AC3 has 1 channels
2010-01-11 23:42:48.691 AFD: Opened codec 0x8a10130, id(AC3) type(Audio)
2010-01-11 23:42:48.791 Honoring the cutlist while transcoding
2010-01-11 23:42:48.817 Cutlist        : 0-230,2223-4074,43763-53869
2010-01-11 23:42:48.848 Original Length: 53869 frames
2010-01-11 23:42:48.873 New Length     : 41682 frames
2010-01-11 23:42:48.900 Transcoding aborted, cutlist changed
2010-01-11 23:42:48.931 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg aborted because of cutlist update
2010-01-11 23:42:48.959 Deleting /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:49.031 JobQueue: Transcode Starting for Ask This Old House "Installing Sliding Glass Door": High Quality (949.4 MB)
....
2010-01-11 23:42:49.847 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:50.221 MythContext: Connecting to backend server: 127.0.0.1:6543 (try 1 of 1)
2010-01-11 23:42:50.348 Using protocol version 50
2010-01-11 23:42:50.375 MainServer::ANN Monitor
2010-01-11 23:42:50.444 adding: consult.pretender as a client (events: 0)
2010-01-11 23:42:50.471 MainServer::ANN Monitor
2010-01-11 23:42:50.510 adding: consult.pretender as a client (events: 1)
2010-01-11 23:42:50.723 AFD: Opened codec 0x969d080, id(MPEG2VIDEO) type(Video)
2010-01-11 23:42:50.775 AFD: codec AC3 has 2 channels
2010-01-11 23:42:50.795 AFD: Opened codec 0x96a5ba0, id(AC3) type(Audio)
2010-01-11 23:42:50.820 AFD: codec AC3 has 1 channels
2010-01-11 23:42:50.846 AFD: Opened codec 0x96a5f60, id(AC3) type(Audio)
2010-01-11 23:42:50.956 Honoring the cutlist while transcoding
2010-01-11 23:42:50.988 Cutlist        : 0-230,2223-4074,43763-53869
2010-01-11 23:42:51.011 Original Length: 53869 frames
2010-01-11 23:42:51.037 New Length     : 41682 frames
2010-01-11 23:42:51.072 Transcoding aborted, cutlist changed
2010-01-11 23:42:51.102 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg aborted because of cutlist update
2010-01-11 23:42:51.135 Deleting /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:51.197 JobQueue: Transcode Starting for Ask This Old House "Installing Sliding Glass Door": High Quality (949.4 MB)
....
2010-01-11 23:42:51.952 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:52.345 MythContext: Connecting to backend server: 127.0.0.1:6543 (try 1 of 1)
2010-01-11 23:42:52.475 Using protocol version 50
2010-01-11 23:42:52.505 MainServer::ANN Monitor
2010-01-11 23:42:52.546 adding: consult.pretender as a client (events: 0)
2010-01-11 23:42:52.572 MainServer::ANN Monitor
2010-01-11 23:42:52.638 adding: consult.pretender as a client (events: 1)
2010-01-11 23:42:52.850 AFD: Opened codec 0xa13a7d0, id(MPEG2VIDEO) type(Video)
2010-01-11 23:42:52.913 AFD: codec AC3 has 2 channels
2010-01-11 23:42:52.939 AFD: Opened codec 0xa13ced0, id(AC3) type(Audio)
2010-01-11 23:42:52.963 AFD: codec AC3 has 1 channels
2010-01-11 23:42:52.988 AFD: Opened codec 0xa13d460, id(AC3) type(Audio)
2010-01-11 23:42:53.092 Honoring the cutlist while transcoding
2010-01-11 23:42:53.124 Cutlist        : 0-230,2223-4074,43763-53869
2010-01-11 23:42:53.154 Original Length: 53869 frames
2010-01-11 23:42:53.180 New Length     : 41682 frames
2010-01-11 23:42:53.210 Transcoding aborted, cutlist changed
2010-01-11 23:42:53.246 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg aborted because of cutlist update
2010-01-11 23:42:53.278 Deleting /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:53.339 JobQueue: Transcode Starting for Ask This Old House "Installing Sliding Glass Door": High Quality (949.4 MB)
....
2010-01-11 23:42:54.299 Transcoding from /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg to /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:54.679 MythContext: Connecting to backend server: 127.0.0.1:6543 (try 1 of 1)
2010-01-11 23:42:54.806 Using protocol version 50
2010-01-11 23:42:54.831 MainServer::ANN Monitor
2010-01-11 23:42:54.910 adding: consult.pretender as a client (events: 0)
2010-01-11 23:42:54.956 MainServer::ANN Monitor
2010-01-11 23:42:54.997 adding: consult.pretender as a client (events: 1)
2010-01-11 23:42:55.246 AFD: Opened codec 0x91d8080, id(MPEG2VIDEO) type(Video)
2010-01-11 23:42:55.284 AFD: codec AC3 has 2 channels
2010-01-11 23:42:55.310 AFD: Opened codec 0x91e0ba0, id(AC3) type(Audio)
2010-01-11 23:42:55.334 AFD: codec AC3 has 1 channels
2010-01-11 23:42:55.360 AFD: Opened codec 0x91e0f60, id(AC3) type(Audio)
2010-01-11 23:42:55.462 Honoring the cutlist while transcoding
2010-01-11 23:42:55.487 Cutlist        : 0-230,2223-4074,43763-53869
2010-01-11 23:42:55.518 Original Length: 53869 frames
2010-01-11 23:42:55.543 New Length     : 41682 frames
2010-01-11 23:42:55.569 Transcoding aborted, cutlist changed
2010-01-11 23:42:55.602 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg aborted because of cutlist update
2010-01-11 23:42:55.632 Deleting /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp
2010-01-11 23:42:55.731 JobQueue: Transcode Errored: Ask This Old House "Installing Sliding Glass Door": High Quality (exit status 231, job status was "Retrying")
...
2010-01-11 23:53:04.948 Fast-Forwarding from 43763 to 53869
...
2010-01-11 23:53:05.439 Transcoding /mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg done
2010-01-11 23:53:05.494 mythtranscode: Error Renaming '/mnt/media/mythtv/mythtv-raw/2443_20091108103000.mpg.tmp' to '/mnt/media/mythtv/mythtv-raw/2443_20091108103000.nuv'
			eno: No such file or directory (2)










More information about the mythtv-users mailing list