View unanswered posts    View active topics

All times are UTC - 6 hours





Post new topic Reply to topic  [ 12 posts ] 
Print view Previous topic   Next topic  
Author Message
Search for:
PostPosted: Tue Dec 31, 2013 2:07 pm 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
after numerous issues with burning dvd's and archives with lines 7.x, i was anxiously awaiting the release of linhes 8.0

that release helped, though there were still bugs with mythtv .25

after updating to linhes 8.1, i am now able to burn an archive containing videos, but i am still having issues burning a dvd of a video and a dvd of a recording. i will document the recordings -> dvd here and ask for any suggestions

the mythburn.py appears to hang once mythffmpeg is initiated:

Code:
013-12-31 14:07:55 *************************************************************
2013-12-31 14:07:55 Processing recording 1: '/data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20131225010000.mpg'
2013-12-31 14:07:55 *************************************************************
2013-12-31 14:07:55 File type is 'mpegts'
2013-12-31 14:07:55 Video codec is 'mpeg2video (Main)'
2013-12-31 14:07:55 Video /data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20131225010000.mpg aspect ratio is: 1.77777777778
2013-12-31 14:07:55 Preferred audio languages eng and eng
2013-12-31 14:07:55 Video id: 0x31, Audio1: [1] 0x34 (AC3 (AC-3 / 0X332D4341), spa), Audio2: [-1] - 0x-1 (N/A, N/A)
2013-12-31 14:07:55 Aspect ratio is 16:9
2013-12-31 14:07:55 Re-encoding audio and video
2013-12-31 14:07:55 Using encoder profiles from /usr/share/mythtv/mytharchive/encoder_profiles/ffmpeg_dvd_ntsc.xml
2013-12-31 14:07:55 Encoding profile (SP) found
2013-12-31 14:07:55 mythffmpeg -threads 8 -v 1 -i "/data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20131225010000.mpg" -r ntsc -target ntsc-dvd -b:v 4771k -s 720x480 -acodec ac3 -b:a 192k -ac 2 -copyts -aspect 16:9 "/myth/tmp/work/1/newfile2.mpg" -map 0:0 -map 0:1


i can see the process running:

Code:
mythtv   30210 30170 99 14:07 ?        00:59:08 mythffmpeg -threads 8 -v 1 -i /data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20131225010000.mpg -r ntsc -target ntsc-dvd -b:v 4771k -s 720x480 -acodec ac3 -b:a 192k -ac 2 -copyts -aspect 16:9 /myth/tmp/work/1/newfile2.mpg -map 0:0 -map 0:1


however, the output file is zero length. if i run the command manually i get the same result...no screen output and a zero length file.

i did find it interesting last evening when a video that i was watching started stuttering badly. upon investigation, i noticed two mythffmpeg process running and consuming large amount of cpu. at that time i theorized that these process were the result of burn jobs that i had kicked off hours earlier. at the time, i did not investigate that further. this morning i rebooted the box so as to get rid of any zombie processes and start testing again with a clean slate.

stracing the mythffmpeg process doenst show anything interesting to me. it just keeps on spewing:

Code:
futex(0x7445bc, FUTEX_WAIT_PRIVATE, 813, NULL) = -1 EAGAIN (Resource temporarily unavailable)
futex(0x744618, FUTEX_WAKE_PRIVATE, 1)  = 0
futex(0x7445ec, FUTEX_CMP_REQUEUE_PRIVATE, 1, 2147483647, 0x744618, 7326) = 9
futex(0x744618, FUTEX_WAKE_PRIVATE, 1)  = 1
futex(0x7445bc, FUTEX_WAIT_PRIVATE, 815, NULL) = 0
futex(0x744618, FUTEX_WAKE_PRIVATE, 1)  = 0
futex(0x7445ec, FUTEX_CMP_REQUEUE_PRIVATE, 1, 2147483647, 0x744618, 7344) = 9


so, i will be curious to see if the mythffmpeg process starts processing the video file in several hours, but once again, i am frustrated when it comes to archiving

does anyone have any suggestions on what to look at next?

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Tue Dec 31, 2013 4:09 pm 
Offline
Joined: Fri Jul 21, 2006 11:12 pm
Posts: 1194
Location: SC
Does the drive that /myth points to have enough empty space?


Top
 Profile  
 
PostPosted: Tue Dec 31, 2013 6:26 pm 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
about 600 gig free on a 2 tb disk:

Quote:
[mythtv@mythtv tmp]$ df -k .
Filesystem 1K-blocks Used Available Use% Mounted on
/dev/sdb1 1952558588 1294512036 658046552 67% /data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044
[mythtv@mythtv tmp]$ pwd
/myth/tmp

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Tue Dec 31, 2013 7:02 pm 
Offline
Joined: Fri Jul 21, 2006 11:12 pm
Posts: 1194
Location: SC
Only other thing I can think of at the moment is maybe a permissions issue with either the infile or the output dir.


Top
 Profile  
 
PostPosted: Wed Jan 01, 2014 8:41 am 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
i ran the mythffpmeg command manually, removing the "-v 1" so as to see the output

when doing so on a sampling of recorded files i see:

Code:
 mythffmpeg -threads 8 -i /data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20140101010000.mpg -r ntsc -target ntsc-dvd -b:v 4771k -s 720x480 -acodec ac3 -b:a 192k -ac 2 -copyts -aspect 16:9 /myth/tmp/work/1/foo222.mpg  -map 0:0 -map 0:1
ffmpeg version 1.2.2 Copyright (c) 2000-2013 the FFmpeg developers
  built on Dec 16 2013 23:08:12 with gcc 4.7.2 (GCC)

snip

Trailing options were found on the commandline.
[mpegts @ 0x23fb160] PES packet size mismatch
Input #0, mpegts, from '/data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20140101010000.mpg':
  Duration: 01:00:00.15, start: 21737.305233, bitrate: 15387 kb/s
    Stream #0:0[0x31]: Video: mpeg2video (Main), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc
    Stream #0:1[0x34](eng): Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 384 kb/s
    Stream #0:2[0x35](spa): Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s
Output #0, dvd, to '/myth/tmp/work/1/foo222.mpg':
  Metadata:
    encoder         : Lavf54.63.104
    Stream #0:0: Video: mpeg2video, yuv420p, 720x480 [SAR 32:27 DAR 16:9], q=2-31, 4771 kb/s, 90k tbn, 29.97 tbc
    Stream #0:1(eng): Audio: ac3, 48000 Hz, stereo, fltp, 192 kb/s
Stream mapping:
  Stream #0:0 -> #0:0 (mpeg2video -> mpeg2video)
  Stream #0:1 -> #0:1 (ac3 -> ac3)
Press [q] to stop, [?] for help



but it just sits there after creating the zero length output file. hitting "q" does nothing, i have to control-c to terminate the process

i left the archive job that i kicked off via the archive interface run overnight. it too created the zero length file. given that it has run for 16+ hours, i doubt that it is going to produce any output.

when running with /usr/bin/ffmpeg using the same inputs, the file transcodes and produces this truncated output:

Code:
Stream mapping:
  Stream #0:0 -> #0:0 (mpeg2video -> mpeg2video)
  Stream #0:1 -> #0:1 (ac3 -> ac3)
Press [q] to stop, [?] for help
[ac3 @ 0x8cba60] frame sync error
Error while decoding stream #0:1
[mpegts @ 0x8c7220] Adjusting PTS forward
    Last message repeated 25 times
Adjusting PTS forward=2.0 size=     300kB time=00:00:03.29 bitrate= 746.8kbits/s dup=14 drop=0   
[mpegts @ 0x8c7220] Adjusting PTS forward
    Last message repeated 23 times


i've tried this on several input files and also ran mythcommflag --rebuild to try to repair any issues with the recorded files

so...i guess my question is at this point, is there a bug with mythffmpeg given my input files? while i didnt do extensive testing prior to upgrading to 8.1, i find it curious that mythffmpeg doesnt like any of my recorded files

also, is it safe to replace mythffmpeg with ffmpeg as a workaround?

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Wed Jan 01, 2014 8:51 am 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
i neglected to mention that i also simplified the mythffmpeg command and was able to see that it would transcode the recording without the dvd related arguements:

mythffmpeg -threads 8 -i /data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20140101010000.mpg /myth/tmp/foo3333.mpg
ffmpeg version 1.2.2 Copyright (c) 2000-2013 the FFmpeg developers
built on Dec 16 2013 23:08:12 with gcc 4.7.2 (GCC)

snip
Code:
[mpegts @ 0x925040] PES packet size mismatch
Input #0, mpegts, from '/data/storage/WDCWD2000FYYZ-01UL1B1_WD-WCC1P0896044/media/tv/1081_20140101010000.mpg':
  Duration: 01:00:00.15, start: 21737.305233, bitrate: 15387 kb/s
    Stream #0:0[0x31]: Video: mpeg2video (Main), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc
    Stream #0:1[0x34](eng): Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 384 kb/s
    Stream #0:2[0x35](spa): Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s
[mpeg @ 0x92a260] VBV buffer size not set, muxing may fail
Output #0, mpeg, to '/myth/tmp/foo3333.mpg':
  Metadata:
    encoder         : Lavf54.63.104
    Stream #0:0: Video: mpeg1video, yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], q=2-31, 200 kb/s, 90k tbn, 29.97 tbc
    Stream #0:1(eng): Audio: mp2, 48000 Hz, stereo, s16, 128 kb/s
Stream mapping:
  Stream #0:0 -> #0:0 (mpeg2video -> mpeg1video)
  Stream #0:1 -> #0:1 (ac3 -> mp2)
Press [q] to stop, [?] for help
[ac3 @ 0x9289c0] frame sync error
Error while decoding stream #0:1: Operation not permitted
[mpeg @ 0x92a260] st:0 PTS: 12058 DTS: 12058 < 12779 invalid, clipping
frame= 2317 fps=231 q=31.0 size=   32392kB time=00:01:17.24 bitrate=3435.3kbits/s dup=14 drop=0

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Wed Jan 01, 2014 1:12 pm 
Offline
Joined: Mon Apr 23, 2007 1:45 pm
Posts: 405
Location: Fargo, ND, USA
Do you happen to have your operating system on a SSD drive?
TVBox

_________________
TVBox
LinHES R8.6.1


Top
 Profile  
 
PostPosted: Wed Jan 01, 2014 2:21 pm 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
Yes, my boot disk is an ssd drive and data is on a conventional drive setup via the add_storage.py script

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Wed Jan 01, 2014 9:40 pm 
Offline
Joined: Mon Apr 23, 2007 1:45 pm
Posts: 405
Location: Fargo, ND, USA
To tell you the truth this may not have anything to do with your setup but here it is anyway. My setup had a small SSD drive and a large data hard disk. It seemed to me that everything DVD related (temp files, iso) was only wrote to the #1 data drive which was full except for a couple of hundred megabyte. It would only write to #1 data drive and completely ignored #2 data drive sitting there empty. I have no idea if anything has changed in this area since Beta R8. About this same time I lost my data drive and never did followup and fix the problem.

Last two posts
http://forums.linhes.org/viewtopic.php?f=21&t=23755

TVBox

_________________
TVBox
LinHES R8.6.1


Top
 Profile  
 
PostPosted: Thu Jan 02, 2014 4:44 am 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
thanks for the hint, i do have a small ssd for boot and a large data drive similar to your setup. however, i have reconfigured my system such that /myth/tmp is on the large conventional drive with sufficient space

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Sun Jan 05, 2014 5:31 pm 
Offline
Joined: Sat Jan 06, 2007 7:08 pm
Posts: 125
this appears to have gotten better, but not fixed with the recently released mytharchive-0.27-9 pacakge

previously, mythffmpeg would create a zero length output file and hang

now, mythffmpeg is able to create an output file

using a test file of a 30 minute sitcom, the input length is reported as:

Code:
Duration: 00:29:59.64, start: 9110.055033, bitrate: 15378 kb/s


the output file is of similar, but not exactly the same length:

Code:
Duration: 00:29:59.53, start: 0.533367, bitrate: 5257 kb/s


but, the process hangs. running the command manually after removing the -v 1 argument so as to be able to see the activity shows output running up to the 29:58.59 time:


Code:
[mpeg2video @ 0xcc2c00] Warning MVs not available
[mpeg2video @ 0xcc2c00] concealing 5736 DC, 5736 AC, 5736 MV errors in I frame
buffer underflow i=1 bufi=1115 size=1536B time=00:03:00.64 bitrate=5129.3kbits/s dup=13 drop=1   
[dvd @ 0xcc4100] buffer underflow i=1 bufi=1115 size=1536
buffer underflow i=1 bufi=914 size=1536kB time=00:26:34.75 bitrate=5260.9kbits/s dup=13 drop=1   
[dvd @ 0xcc4100] buffer underflow i=1 bufi=914 size=1536
ac-tex damaged at 17 64.0 size= 1154532kB time=00:29:58.59 bitrate=5258.5kbits/s dup=13 drop=1   



but then the cpu of my box hits 400% for a few minutes, after which i see this odd output indicating the time is now at 3 hours:

Code:
[mpeg2video @ 0xcc2c00] concealing 480 DC, 480 AC, 480 MV errors in B frame
[mpeg2video @ 0xcc2c00] ac-tex damaged at 55 0
[mpeg2video @ 0xcc2c00] concealing 8160 DC, 8160 AC, 8160 MV errors in B frame
frame=326969 fps=647 q=2.0 size= 1154732kB time=03:01:49.79 bitrate= 867.1kbits/s dup=273048 drop=1   


i am unable to do a simple "kill" to terminate this process. i am able to control-c in the terminal window to kill the process. a kill -9 is also able to terminate the process

_________________
DH87MC i7-4770 16GB ram Xonar Essence ST geforce 710 LinHes 8.6


Top
 Profile  
 
PostPosted: Mon Jan 06, 2014 5:45 pm 
Offline
Joined: Fri Jul 21, 2006 11:12 pm
Posts: 1194
Location: SC
I have tried this on 2 of my R8.1 machines now and they both worked. One was a combined BE/FE the other was a FE only connected to the previous BE.

To make sure we are on the same page this is what I did:
Optical Disks --> Archive Files --> Create DVD
Single Layer DVD
Checked Make ISO
Unchecked Burn DVD
Simple - AutoPlay for the theme
Add a Recording
Selected the Recording
Hit Next and away it went.

The log that you posted above looks to be the progress.log. Here is mine taken from where you started yours:
Code:
2014-01-06 16:36:39 *************************************************************
2014-01-06 16:36:39 Processing recording 1: '/data/storage/SAMSUNGHD204UI_S2H7J1AZ908734/media/tv/4911_20131213005900.mpg'
2014-01-06 16:36:39 *************************************************************
2014-01-06 16:36:39 File type is 'mpeg'
2014-01-06 16:36:39 Video codec is 'mpeg2video (Main)'
2014-01-06 16:36:39 Running mythtranscode --mpeg2 to fix any errors
2014-01-06 16:37:15 File will be re-encoded using profile SP
2014-01-06 16:37:15 Video /myth/tmp/work/1/newfile.mpg aspect ratio is: 1.77777777778
2014-01-06 16:37:15 Preferred audio languages eng and eng
2014-01-06 16:37:15 Video id: 0x1e0, Audio1: [1] 0x80 (AC3, N/A), Audio2: [-1] - 0x-1 (N/A, N/A)
2014-01-06 16:37:15 Aspect ratio is 16:9
2014-01-06 16:37:15 Re-encoding audio and video
2014-01-06 16:37:15 Using encoder profiles from /usr/share/mythtv/mytharchive/encoder_profiles/ffmpeg_dvd_ntsc.xml
2014-01-06 16:37:15 Encoding profile (SP) found
2014-01-06 16:37:15 mythffmpeg -threads 3 -v 1 -i "/myth/tmp/work/1/newfile.mpg" -r ntsc -target ntsc-dvd -b:v 4771k -s 720x480 -acodec copy -copyts -aspect 16:9 "/myth/tmp/work/1/newfile2.mpg" -map 0:0 -map 0:1
2014-01-06 16:50:02 Video /myth/tmp/work/1/newfile2.mpg aspect ratio is: 1.77777777778
2014-01-06 16:50:02 Preferred audio languages eng and eng
2014-01-06 16:50:02 Video id: 0x1e0, Audio1: [1] 0x80 (AC3, N/A), Audio2: [-1] - 0x-1 (N/A, N/A)
2014-01-06 16:50:02 Splitting MPEG stream into audio and video parts
2014-01-06 16:50:02 Running: mythreplex --demux --fix_sync -o "/myth/tmp/work/1/stream" -v 224 -c 128 "/myth/tmp/work/1/newfile2.mpg"
2014-01-06 16:50:33 Finished processing '/data/storage/SAMSUNGHD204UI_S2H7J1AZ908734/media/tv/4911_20131213005900.mpg'
2014-01-06 16:50:33 *************************************************************
2014-01-06 16:50:33 Creating DVD XML file for dvd author (No Menus)
2014-01-06 16:50:33 Adding item 1
2014-01-06 16:50:33 aspect ratio is: 1.77777777778
2014-01-06 16:50:33 Fixed length chapters: 00:00:00,00:05:00,00:10:00,00:15:00,00:20:00
2014-01-06 16:50:33 Total video  678.07 Mb, audio 57.32 Mb, menus 0.00 Mb.
2014-01-06 16:50:33 Unpackaged total 735.39 Mb. About 3574 Mb will be unused.
2014-01-06 16:50:33 Multiplexing MPEG stream to /myth/tmp/work/1/final.vob
2014-01-06 16:50:33 Adding sync offset of -350ms
2014-01-06 16:50:33 Available streams - video and one audio stream
2014-01-06 16:50:33 Multiplex started PID=1140
2014-01-06 16:50:33 Starting dvdauthor
2014-01-06 16:50:58 Finished  dvdauthor
2014-01-06 16:50:58 Creating ISO image
2014-01-06 16:51:07 Finished creating ISO image
2014-01-06 16:51:07 Removing all archive items from the archiveitems DB table
2014-01-06 16:51:07 Finished processing jobs!!!
 


The main differences I see between my log and yours are:
- my file type was mpeg so it ran mythtrancode
- in the mythffmpeg cmd my infile is /myth/tmp/work/1/newfile.mpg. This is what it should be as mythburn.py handles storage groups for both recordings and videos by finding the video in the storage group and copying it using the myth protocol to the local work dir. Why your infile in the mythffmpeg cmd is directly to the file I am not sure.


Top
 Profile  
 

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


All times are UTC - 6 hours




Who is online

Users browsing this forum: No registered users and 26 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:  
cron
Powered by phpBB® Forum Software © phpBB Group

Theme Created By ceyhansuyu