LinHES Forums
http://forum.linhes.org/

R5B7: mythtranscode not working
http://forum.linhes.org/viewtopic.php?f=17&t=9489		 Page 1 of 4
Author:  Lueddich [ Wed Apr 05, 2006 1:56 am ]
Post subject:  R5B7: mythtranscode not working
Hi,

I have installed the R5B7 and it works nearly perfect, but I can't transcode any recorded shows. I record with one DVB-T (Hauppauge Nova-T) and a DVB-S (skystar2), so I have MPEG2-recordings and activated "Losless Transcoding". But when I mark the commercials and start transcoding, it works and works about 5 min, saying that 0% is completed in Informations=>System State (don't know the exact name, I use the frontend in german). When I have a look in the recordings folder on my hd, I can see the new file growing to nearly the right size and being deleted at the end. Then, the job is marked as "failed" and my recordings isn't commercial-free...

Another point I don't understand: Some recordings have "nuv" as ending and some "mpg". There is no difference transcoding them: It ends up with the same error "unknown socket closing"...

Here's the relevant part of my backend's log:

Code:
2006-04-02 15:49:51.900 Transcoding from /myth/tv/1019_20060401180000.mpg to /myth/tv/1019_20060401180000.mpg.tmp
2006-04-02 15:49:51.966 Connecting to backend server: 127.0.0.1:6543 (try 1 of 5)
2006-04-02 15:49:51.978 Using protocol version 26
2006-04-02 15:49:51.986 MainServer::HandleAnnounce Monitor
2006-04-02 15:49:51.987 adding: mythtv as a client (events: 0)
0: start_time: 4659.991 duration: 350.654
1: start_time: 4659.962 duration: 350.633
2: start_time: 4659.969 duration: 350.626
stream: start_time: 51777.356 duration: 3896.478 bitrate=4403 kb/s
2006-04-02 15:49:52.446 AFD: Opened codec 0x80f6740, id(MPEG2VIDEO) type(Video)
2006-04-02 15:49:52.467 AFD: Opened codec 0x80f6bf0, id(MP3) type(Audio)
2006-04-02 15:49:52.470 AFD: Opened codec 0x80f7170, id(AC3) type(Audio)
2006-04-02 15:49:52.573 New DB connection, total: 3
2006-04-02 15:49:52.576 Connected to database 'mythconverg' at host: localhost
2006-04-02 15:49:52.584 Switching to MPEG-2 transcoder.
2006-04-02 15:49:52.594 Opening /myth/tv/1019_20060401180000.mpg
2006-04-02 15:49:52.627 Input #0, mpegts, from '/myth/tv/1019_20060401180000.mpg':
2006-04-02 15:49:52.629   Duration: N/A, bitrate: N/A
2006-04-02 15:49:52.631   Stream #0.0[0xff], 25.00 fps(r): Video: mpeg2video, yuv420p, 720x576, 15000 kb/s
2006-04-02 15:49:52.633   Stream #0.1[0x100](deu): Audio: mp2, 48000 Hz, stereo, 192 kb/s
2006-04-02 15:49:52.635   Stream #0.2[0x101](deu): Audio: ac3, 48000 Hz, stereo, 448 kb/s
2006-04-02 15:49:52.642 #0 PTS:14:22:57.674 Delta: 0.0ms queue: 10
2006-04-02 15:49:52.644 #1 PTS:14:22:57.668 Delta: 6.01111ms queue: 3
2006-04-02 15:49:52.646 #2 PTS:14:22:57.653 Delta: 20.8444ms queue: 2
2006-04-02 15:49:55.345 Converting frame #0 from B to I
2006-04-02 15:49:55.404 Converting frame #1 from B to I
Mux rate: 15.90 Mbit/s
2006-04-02 15:50:19.169 Converting frame #0 from B to I
2006-04-02 15:50:19.467 Converting frame #1 from B to I
2006-04-02 15:50:23.822 Converting frame #0 from B to I
2006-04-02 15:50:23.898 Converting frame #1 from B to I
2006-04-02 15:51:07.010 Converting frame #6 from B to I
2006-04-02 15:51:07.052 Converting frame #7 from B to I
2006-04-02 15:51:07.073 Converting frame #8 from P to I
2006-04-02 15:51:12.525 Converting frame #0 from B to I
2006-04-02 15:51:12.980 Converting frame #1 from B to I
2006-04-02 15:51:29.876 Converting frame #3 from B to I
2006-04-02 15:51:30.265 Converting frame #4 from B to I
2006-04-02 15:51:30.286 Converting frame #5 from P to I
2006-04-02 15:51:34.670 Unknown socket closing
2006-04-02 15:51:36.294 Transcode Errored for Relic Hunter - Die Schatzj\xe4gerin "Das Zepter": 2.0 GB => 0 bytes (Autodetect)
2006-04-02 15:52:26.968 Running HouseKeeping


Does anybody have an idea? I have full web- and ssh-access to my machine from work, everything else could be done this evening ;)

THX!!
Author:  mac [ Wed Apr 05, 2006 2:20 am ]
Post subject: 
I have the same problem when doing losless transcoding -- Running from the command
Code:
mythtranscode --honorcutlist --mpeg2 --infile 1010_20060405112431.mpg --outfile transcode_test.mpg

line, I see that mythtranscode segfaults. I really have not dug too much yet to try to figure out why..
Author:  Lueddich [ Wed Apr 05, 2006 2:31 am ]
Post subject: 
same error here trying it from the command:

Code:
$ mythtranscode --honorcutlist --mpeg2 --infile /myth/tv/2010_20060328004500.mpg --outfile transcode_test.mpg
2006-04-05 10:23:01.173 Using runtime prefix = /usr
2006-04-05 10:23:01.184 New DB connection, total: 1
2006-04-05 10:23:01.188 Enabled verbose msgs: important
2006-04-05 10:23:01.192 New DB connection, total: 2
Mux rate: 7.31 Mbit/s
Segmentation fault


Is there a debug mode I could activate giving more information?
Author:  Lueddich [ Wed Apr 05, 2006 2:35 am ]
Post subject: 
I took a look in my directory, ther is a file now and it is smaller than the original one...

Code:
mythtv@mythtv:~$ ls -l /myth/tv/2010_20060328004500.mpg
-rw-r--r--  1 mythtv mythtv 2768913444 Mar 28 02:25 /myth/tv/2010_20060328004500.mpg
mythtv@mythtv:~$ ls -l transcode_test.mpg
-rw-r--r--  1 mythtv mythtv 1535197184 Apr  5 10:25 transcode_test.mpg


But I can't have a look at it from work...
Author:  mac [ Wed Apr 05, 2006 5:07 am ]
Post subject: 
Yes this will turn all the debugging -- not sure where it'll go, but it shouldn't be to hard to find..
edit: all the debugging goes to standard out!!

going to need "> debugging 2>&1"

Code:
--verbose all

I'll give it try with debugging on to see if I get anything useful.

I'll also have a look at file the it left behind to see what was cut..
Author:  Lueddich [ Wed Apr 05, 2006 7:18 am ]
Post subject: 
Wow, this is a long detailed logfile ;)

My box is still workin' on it, I hope I can locate something useful at the end of the output. I'll post it than...
Author:  Lueddich [ Wed Apr 05, 2006 8:12 am ]
Post subject: 
The last parts of the file:

Code:
2006-04-05 16:07:55.901 VID: B #:9 nb: 2 pts: 01:39:55.188 dts: 01:39:55.188 pos: 2768489692
2006-04-05 16:07:55.901 Id:0 01:39:55.188 V:189 EXT: 165
2006-04-05 16:07:55.901 VID: B #:10 nb: 2 pts: 01:39:55.228 dts: 01:39:55.228 pos: 2768500032
2006-04-05 16:07:55.901 Id:0 01:39:55.228 V:188 EXT: 165
2006-04-05 16:07:55.901 AUD #1: pts: 01:39:54.780 pos: 2768423704
2006-04-05 16:07:55.902 Id:1 01:39:54.780 V:187 EXT: 165
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.804 pos: 2768423704
2006-04-05 16:07:55.902 Id:1 01:39:54.804 V:187 EXT: 164
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.828 pos: 2768455664
2006-04-05 16:07:55.902 Id:1 01:39:54.828 V:187 EXT: 163
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.852 pos: 2768455664
2006-04-05 16:07:55.902 Id:1 01:39:54.852 V:187 EXT: 162
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.876 pos: 2768455664
2006-04-05 16:07:55.902 Id:1 01:39:54.876 V:187 EXT: 161
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.900 pos: 2768455664
2006-04-05 16:07:55.902 Id:1 01:39:54.900 V:187 EXT: 160
2006-04-05 16:07:55.902 AUD #1: pts: 01:39:54.924 pos: 2768455664
2006-04-05 16:07:55.903 Id:1 01:39:54.924 V:187 EXT: 159
2006-04-05 16:07:55.903 AUD #1: pts: 01:39:54.948 pos: 2768494016
2006-04-05 16:07:55.903 Id:1 01:39:54.948 V:187 EXT: 158
2006-04-05 16:07:55.903 AUD #1: pts: 01:39:54.972 pos: 2768494016
2006-04-05 16:07:55.903 Id:1 01:39:54.972 V:187 EXT: 157
2006-04-05 16:07:55.903 AUD #1: pts: 01:39:54.996 pos: 2768494016
2006-04-05 16:07:55.903 Id:1 01:39:54.996 V:187 EXT: 156
2006-04-05 16:07:55.903 AUD #1: pts: 01:39:55.020 pos: 2768494016
2006-04-05 16:07:55.903 Id:1 01:39:55.020 V:187 EXT: 155
2006-04-05 16:07:55.903 AUD #1: pts: 01:39:55.044 pos: 2768494016
2006-04-05 16:07:55.904 Id:1 01:39:55.044 V:187 EXT: 154
2006-04-05 16:07:55.904 AUD #1: pts: 01:39:55.068 pos: 2768549664
2006-04-05 16:07:55.904 Id:1 01:39:55.068 V:187 EXT: 153
2006-04-05 16:07:55.904 unused:22 704x576 P:1080000 #:0 F:2 fl:11 pos: 2768555868
2006-04-05 16:07:55.904 AUD #1: pts: 01:39:55.092 pos: 2768549664
2006-04-05 16:07:55.904 Id:1 01:39:55.092 V:187 EXT: 152
2006-04-05 16:07:55.904 unused:22 704x576 P:1080000 #:1 F:2 fl:11 pos: 2768564140
2006-04-05 16:07:55.904 AUD #1: pts: 01:39:55.116 pos: 2768549664
2006-04-05 16:07:55.904 Id:1 01:39:55.116 V:187 EXT: 151
2006-04-05 16:07:55.905 unused:22 704x576 P:1080000 #:5 F:2 fl:10 pos: 2768572224
2006-04-05 16:07:55.905 AUD #1: pts: 01:39:55.140 pos: 2768549664
2006-04-05 16:07:55.905 Id:1 01:39:55.140 V:187 EXT: 150
2006-04-05 16:07:55.905 AUD #1: pts: 01:39:55.164 pos: 2768549664
2006-04-05 16:07:55.905 Id:1 01:39:55.164 V:187 EXT: 149
2006-04-05 16:07:55.905 AUD #1: pts: 01:39:55.188 pos: 2768594784
2006-04-05 16:07:55.905 Id:1 01:39:55.188 V:187 EXT: 148
2006-04-05 16:07:55.905 AUD #1: pts: 01:39:55.212 pos: 2768594784
2006-04-05 16:07:56.499 Id:1 01:39:55.212 V:187 EXT: 147
2006-04-05 16:07:56.499 unused:22 704x576 P:1080000 #:3 F:2 fl:11 pos: 2768589332
2006-04-05 16:07:56.499 AUD #1: pts: 01:39:55.236 pos: 2768594784
2006-04-05 16:07:56.499 Id:1 01:39:55.236 V:187 EXT: 146
2006-04-05 16:07:56.499 unused:22 704x576 P:1080000 #:4 F:2 fl:11 pos: 2768601364
2006-04-05 16:07:56.500 unused:22 704x576 P:1080000 #:8 F:2 fl:10 pos: 2768610200
2006-04-05 16:07:56.500 unused:22 704x576 P:1080000 #:6 F:2 fl:11 pos: 2768626556
2006-04-05 16:07:56.500 unused:22 704x576 P:1080000 #:7 F:2 fl:11 pos: 2768637460
2006-04-05 16:07:56.500 unused:22 704x576 P:1080000 #:11 F:2 fl:10 pos: 2768645356
2006-04-05 16:07:56.501 unused:22 704x576 P:1080000 #:9 F:2 fl:11 pos: 2768660208
2006-04-05 16:07:56.501 unused:22 704x576 P:1080000 #:10 F:2 fl:11 pos: 2768668668
2006-04-05 16:07:56.501 unused:115 704x576 P:1080000 10:46:59:010 #:2 F:2 fl:9 pos: 2768676564
2006-04-05 16:07:56.502 VID: I #:2 nb: 2 pts: 01:39:55.388 dts: 01:39:55.268 pos: 2768509620
2006-04-05 16:07:56.502 Id:0 01:39:55.388 V:187 EXT: 145
2006-04-05 16:07:56.502 VID: B #:0 nb: 2 pts: 01:39:55.308 dts: 01:39:55.308 pos: 2768555868
2006-04-05 16:07:56.502 Id:0 01:39:55.308 V:186 EXT: 145
2006-04-05 16:07:56.502 VID: B #:1 nb: 2 pts: 01:39:55.348 dts: 01:39:55.348 pos: 2768564140
2006-04-05 16:07:56.502 Id:0 01:39:55.348 V:185 EXT: 145
2006-04-05 16:07:56.502 VID: P #:5 nb: 2 pts: 01:39:55.508 dts: 01:39:55.388 pos: 2768572224
2006-04-05 16:07:56.503 Id:0 01:39:55.508 V:184 EXT: 145
2006-04-05 16:07:56.503 VID: B #:3 nb: 2 pts: 01:39:55.428 dts: 01:39:55.428 pos: 2768589332
2006-04-05 16:07:56.503 Id:0 01:39:55.428 V:183 EXT: 145
2006-04-05 16:07:56.503 VID: B #:4 nb: 2 pts: 01:39:55.468 dts: 01:39:55.468 pos: 2768601364
2006-04-05 16:07:56.503 Id:0 01:39:55.468 V:182 EXT: 145
2006-04-05 16:07:56.503 VID: P #:8 nb: 2 pts: 01:39:55.628 dts: 01:39:55.508 pos: 2768610200
2006-04-05 16:07:56.503 Id:0 01:39:55.628 V:181 EXT: 145
2006-04-05 16:07:56.503 VID: B #:6 nb: 2 pts: 01:39:55.548 dts: 01:39:55.548 pos: 2768626556
2006-04-05 16:07:56.504 Id:0 01:39:55.548 V:180 EXT: 145
2006-04-05 16:07:56.504 VID: B #:7 nb: 2 pts: 01:39:55.588 dts: 01:39:55.588 pos: 2768637460
2006-04-05 16:07:56.504 Id:0 01:39:55.588 V:179 EXT: 145
2006-04-05 16:07:56.504 VID: P #:11 nb: 2 pts: 01:39:55.748 dts: 01:39:55.628 pos: 2768645356
2006-04-05 16:07:56.504 Id:0 01:39:55.748 V:178 EXT: 145
2006-04-05 16:07:56.504 VID: B #:9 nb: 2 pts: 01:39:55.668 dts: 01:39:55.668 pos: 2768660208
2006-04-05 16:07:56.504 Id:0 01:39:55.668 V:177 EXT: 145
2006-04-05 16:07:56.504 VID: B #:10 nb: 2 pts: 01:39:55.708 dts: 01:39:55.708 pos: 2768668668
2006-04-05 16:07:56.505 Id:0 01:39:55.708 V:176 EXT: 145
2006-04-05 16:07:56.505 AUD #1: pts: 01:39:55.260 pos: 2768594784
2006-04-05 16:07:56.505 Id:1 01:39:55.260 V:175 EXT: 145
2006-04-05 16:07:56.505 AUD #1: pts: 01:39:55.284 pos: 2768594784
2006-04-05 16:07:56.505 Id:1 01:39:55.284 V:175 EXT: 144
2006-04-05 16:07:56.505 AUD #1: pts: 01:39:55.308 pos: 2768616780
2006-04-05 16:07:56.505 Id:1 01:39:55.308 V:175 EXT: 143
2006-04-05 16:07:56.505 AUD #1: pts: 01:39:55.332 pos: 2768616780
2006-04-05 16:07:56.506 Id:1 01:39:55.332 V:175 EXT: 142
2006-04-05 16:07:56.506 AUD #1: pts: 01:39:55.356 pos: 2768616780
2006-04-05 16:07:56.506 Id:1 01:39:55.356 V:175 EXT: 141
2006-04-05 16:07:56.506 AUD #1: pts: 01:39:55.380 pos: 2768616780
2006-04-05 16:07:56.506 Id:1 01:39:55.380 V:175 EXT: 140
2006-04-05 16:07:56.506 AUD #1: pts: 01:39:55.404 pos: 2768616780
2006-04-05 16:07:56.506 Id:1 01:39:55.404 V:175 EXT: 139
2006-04-05 16:07:56.506 AUD #1: pts: 01:39:55.428 pos: 2768648740
2006-04-05 16:07:56.506 Id:1 01:39:55.428 V:175 EXT: 138
2006-04-05 16:07:56.507 AUD #1: pts: 01:39:55.452 pos: 2768648740
2006-04-05 16:07:56.507 Id:1 01:39:55.452 V:175 EXT: 137
2006-04-05 16:07:56.507 AUD #1: pts: 01:39:55.476 pos: 2768648740
2006-04-05 16:07:56.507 Id:1 01:39:55.476 V:175 EXT: 136
2006-04-05 16:07:56.507 AUD #1: pts: 01:39:55.500 pos: 2768648740
2006-04-05 16:07:56.507 Id:1 01:39:55.500 V:175 EXT: 135
2006-04-05 16:07:56.507 AUD #1: pts: 01:39:55.524 pos: 2768648740
2006-04-05 16:07:56.507 Id:1 01:39:55.524 V:175 EXT: 134
2006-04-05 16:07:56.507 AUD #1: pts: 01:39:55.548 pos: 2768704952
2006-04-05 16:07:56.508 Id:1 01:39:55.548 V:175 EXT: 133
2006-04-05 16:07:56.508 AUD #1: pts: 01:39:55.572 pos: 2768704952
2006-04-05 16:07:56.508 Id:1 01:39:55.572 V:175 EXT: 132
2006-04-05 16:07:56.511 unused:22 704x576 P:1080000 #:0 F:2 fl:11 pos: 2768722060
2006-04-05 16:07:56.511 AUD #1: pts: 01:39:55.596 pos: 2768704952
2006-04-05 16:07:56.511 Id:1 01:39:55.596 V:175 EXT: 131
2006-04-05 16:07:56.511 AUD #1: pts: 01:39:55.620 pos: 2768704952
2006-04-05 16:07:56.511 Id:1 01:39:55.620 V:175 EXT: 130
2006-04-05 16:07:56.511 unused:22 704x576 P:1080000 #:1 F:2 fl:11 pos: 2768732964
2006-04-05 16:07:56.511 AUD #1: pts: 01:39:55.644 pos: 2768704952
2006-04-05 16:07:56.512 Id:1 01:39:55.644 V:175 EXT: 129
2006-04-05 16:07:56.512 AUD #1: pts: 01:39:55.668 pos: 2768750824
2006-04-05 16:07:56.512 Id:1 01:39:55.668 V:175 EXT: 128
2006-04-05 16:07:56.512 unused:22 704x576 P:1080000 #:5 F:2 fl:10 pos: 2768745184
2006-04-05 16:07:56.512 AUD #1: pts: 01:39:55.692 pos: 2768750824
2006-04-05 16:07:56.512 Id:1 01:39:55.692 V:175 EXT: 127
2006-04-05 16:07:56.512 AUD #1: pts: 01:39:55.716 pos: 2768750824
2006-04-05 16:07:56.513 Id:1 01:39:55.716 V:175 EXT: 126
2006-04-05 16:07:56.513 unused:22 704x576 P:1080000 #:3 F:2 fl:11 pos: 2768761916
2006-04-05 16:07:56.513 unused:22 704x576 P:1080000 #:4 F:2 fl:11 pos: 2768773572
2006-04-05 16:07:56.513 unused:22 704x576 P:1080000 #:8 F:2 fl:10 pos: 2768781092
2006-04-05 16:07:56.513 unused:22 704x576 P:1080000 #:6 F:2 fl:11 pos: 2768797072
2006-04-05 16:07:56.513 unused:22 704x576 P:1080000 #:7 F:2 fl:11 pos: 2768807224
2006-04-05 16:07:56.514 unused:22 704x576 P:1080000 #:11 F:2 fl:10 pos: 2768813804
2006-04-05 16:07:56.514 unused:22 704x576 P:1080000 #:9 F:2 fl:11 pos: 2768816812
2006-04-05 16:07:56.514 unused:22 704x576 P:1080000 #:10 F:2 fl:11 pos: 2768826400
2006-04-05 16:07:56.514 unused:115 704x576 P:1080000 10:46:59:022 #:2 F:2 fl:9 pos: 2768834860
2006-04-05 16:07:56.515 VID: I #:2 nb: 2 pts: 01:39:55.868 dts: 01:39:55.748 pos: 2768676564
2006-04-05 16:07:56.515 Id:0 01:39:55.868 V:175 EXT: 125
2006-04-05 16:07:56.515 VID: B #:0 nb: 2 pts: 01:39:55.788 dts: 01:39:55.788 pos: 2768722060
2006-04-05 16:07:56.515 Id:0 01:39:55.788 V:174 EXT: 125
2006-04-05 16:07:56.515 VID: B #:1 nb: 2 pts: 01:39:55.828 dts: 01:39:55.828 pos: 2768732964
2006-04-05 16:07:56.515 Id:0 01:39:55.828 V:173 EXT: 125
2006-04-05 16:07:56.515 VID: P #:5 nb: 2 pts: 01:39:55.988 dts: 01:39:55.868 pos: 2768745184
2006-04-05 16:07:56.515 Id:0 01:39:55.988 V:172 EXT: 125
2006-04-05 16:07:56.516 VID: B #:3 nb: 2 pts: 01:39:55.908 dts: 01:39:55.908 pos: 2768761916
2006-04-05 16:07:56.516 Id:0 01:39:55.908 V:171 EXT: 125
2006-04-05 16:07:56.516 VID: B #:4 nb: 2 pts: 01:39:55.948 dts: 01:39:55.948 pos: 2768773572
2006-04-05 16:07:56.516 Id:0 01:39:55.948 V:170 EXT: 125
2006-04-05 16:07:56.516 VID: P #:8 nb: 2 pts: 01:39:56.108 dts: 01:39:55.988 pos: 2768781092
2006-04-05 16:07:56.516 Id:0 01:39:56.108 V:169 EXT: 125
2006-04-05 16:07:56.516 VID: B #:6 nb: 2 pts: 01:39:56.028 dts: 01:39:56.028 pos: 2768797072
2006-04-05 16:07:56.516 Id:0 01:39:56.028 V:168 EXT: 125
2006-04-05 16:07:56.516 VID: B #:7 nb: 2 pts: 01:39:56.068 dts: 01:39:56.068 pos: 2768807224
2006-04-05 16:07:56.517 Id:0 01:39:56.068 V:167 EXT: 125
2006-04-05 16:07:56.517 VID: P #:11 nb: 2 pts: 01:39:56.228 dts: 01:39:56.108 pos: 2768813804
2006-04-05 16:07:56.517 Id:0 01:39:56.228 V:166 EXT: 125
2006-04-05 16:07:56.517 VID: B #:9 nb: 2 pts: 01:39:56.148 dts: 01:39:56.148 pos: 2768816812
2006-04-05 16:07:56.517 Id:0 01:39:56.148 V:165 EXT: 125
2006-04-05 16:07:56.517 VID: B #:10 nb: 2 pts: 01:39:56.188 dts: 01:39:56.188 pos: 2768826400
2006-04-05 16:07:56.517 Id:0 01:39:56.188 V:164 EXT: 125
2006-04-05 16:07:56.517 AUD #1: pts: 01:39:55.740 pos: 2768750824
2006-04-05 16:07:56.517 Id:1 01:39:55.740 V:163 EXT: 125
2006-04-05 16:07:56.517 AUD #1: pts: 01:39:55.764 pos: 2768750824
2006-04-05 16:07:56.518 Id:1 01:39:55.764 V:163 EXT: 124
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.788 pos: 2768785792
2006-04-05 16:07:56.518 Id:1 01:39:55.788 V:163 EXT: 123
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.812 pos: 2768785792
2006-04-05 16:07:56.518 Id:1 01:39:55.812 V:163 EXT: 122
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.836 pos: 2768785792
2006-04-05 16:07:56.518 Id:1 01:39:55.836 V:163 EXT: 121
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.860 pos: 2768785792
2006-04-05 16:07:56.518 Id:1 01:39:55.860 V:163 EXT: 120
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.884 pos: 2768785792
2006-04-05 16:07:56.518 Id:1 01:39:55.884 V:163 EXT: 119
2006-04-05 16:07:56.518 AUD #1: pts: 01:39:55.908 pos: 2768812488
2006-04-05 16:07:56.519 Id:1 01:39:55.908 V:163 EXT: 118
2006-04-05 16:07:56.519 AUD #1: pts: 01:39:55.932 pos: 2768812488
2006-04-05 16:07:56.519 Id:1 01:39:55.932 V:163 EXT: 117
2006-04-05 16:07:56.519 AUD #1: pts: 01:39:55.956 pos: 2768812488
2006-04-05 16:07:56.519 Id:1 01:39:55.956 V:163 EXT: 116
2006-04-05 16:07:56.519 AUD #1: pts: 01:39:55.980 pos: 2768812488
2006-04-05 16:07:56.519 Id:1 01:39:55.980 V:163 EXT: 115
2006-04-05 16:07:57.032 AUD #1: pts: 01:39:56.004 pos: 2768812488
2006-04-05 16:07:57.032 Id:1 01:39:56.004 V:163 EXT: 114
2006-04-05 16:07:57.032 AUD #1: pts: 01:39:56.028 pos: 2768845576
2006-04-05 16:07:57.032 Id:1 01:39:56.028 V:163 EXT: 113
2006-04-05 16:07:57.032 AUD #1: pts: 01:39:56.052 pos: 2768845576
2006-04-05 16:07:57.033 Id:1 01:39:56.052 V:163 EXT: 112
2006-04-05 16:07:57.033 AUD #1: pts: 01:39:56.076 pos: 2768845576
2006-04-05 16:07:57.033 Id:1 01:39:56.076 V:163 EXT: 111
2006-04-05 16:07:57.033 unused:22 704x576 P:1080000 #:0 F:2 fl:11 pos: 2768881672
2006-04-05 16:07:57.033 AUD #1: pts: 01:39:56.100 pos: 2768845576
2006-04-05 16:07:57.033 Id:1 01:39:56.100 V:163 EXT: 110
2006-04-05 16:07:57.033 unused:22 704x576 P:1080000 #:1 F:2 fl:11 pos: 2768892012
2006-04-05 16:07:57.034 AUD #1: pts: 01:39:56.124 pos: 2768845576
2006-04-05 16:07:57.034 Id:1 01:39:56.124 V:163 EXT: 109
2006-04-05 16:07:57.034 AUD #1: pts: 01:39:56.148 pos: 2768907052
2006-04-05 16:07:57.034 Id:1 01:39:56.148 V:163 EXT: 108
2006-04-05 16:07:57.034 unused:22 704x576 P:1080000 #:5 F:2 fl:10 pos: 2768900660
2006-04-05 16:07:57.034 VID: I #:2 nb: 2 pts: 01:39:56.348 dts: 01:39:56.228 pos: 2768834860
2006-04-05 16:07:57.034 Id:0 01:39:56.348 V:163 EXT: 107
2006-04-05 16:07:57.035 VID: B #:0 nb: 2 pts: 01:39:56.268 dts: 01:39:56.268 pos: 2768881672
2006-04-05 16:07:57.035 Id:0 01:39:56.268 V:162 EXT: 107
2006-04-05 16:07:57.035 VID: B #:1 nb: 2 pts: 01:39:56.308 dts: 01:39:56.308 pos: 2768892012
2006-04-05 16:07:57.035 Id:0 01:39:56.308 V:161 EXT: 107
2006-04-05 16:07:57.035 PTS discrepency: 539682173 != 539674973 on P-Type (5)
2006-04-05 16:07:57.078 unused:40245 704x576 P:1080000 10:46:59:022 #:2 F:2 fl:9 pos: 2768834860
2006-04-05 16:07:57.081 unused:8070 704x576 P:1080000 10:46:59:022 #:0 F:2 fl:11 pos: 2768881672
2006-04-05 16:07:57.084 unused:6966 704x576 P:1080000 10:46:59:022 #:1 F:2 fl:11 pos: 2768892012
2006-04-05 16:07:57.086 unused:9713 704x576 P:1080000 10:46:59:022 #:5 F:2 fl:10 pos: 2768900660
2006-04-05 16:07:57.088 unused:9713 704x576 P:1080000 10:46:59:022 #:6 F:2 fl:10 pos: 2768900660
2006-04-05 16:07:57.184 unused:44810 704x576 P:1080000 00:00:00:000 #:0 F:2 fl:9 pos: 2768900660
2006-04-05 16:07:57.189 unused:44806 704x576 P:1080000 00:00:00:000 #:0 F:2 fl:9 pos: 2768900660
2006-04-05 16:07:57.190 Inserting 2 I-Frames after #5 ins0
2006-04-05 16:07:57.190 unused:21 704x576 P:1080000 #:6 F:2 fl:9 pos: 2768900660
2006-04-05 16:07:57.190 unused:21 704x576 P:1080000 #:7 F:2 fl:9 pos: 2768900660
2006-04-05 16:07:57.190 VID: P #:5 nb: 2 pts: 01:39:56.388 dts: 01:39:56.348 pos: 2768900660
2006-04-05 16:07:57.191 Id:0 01:39:56.388 V:160 EXT: 107
2006-04-05 16:07:57.191 VID: I #:6 nb: 2 pts: 01:39:56.428 dts: 01:39:56.388 pos: 2768900660
2006-04-05 16:07:57.191 Id:0 01:39:56.428 V:159 EXT: 107
2006-04-05 16:07:57.191 VID: I #:7 nb: 2 pts: 01:39:56.468 dts: 01:39:56.428 pos: 2768900660
2006-04-05 16:07:57.191 Id:0 01:39:56.468 V:158 EXT: 107
Segmentation fault
mythtv@mythtv:~$


I can't see a reason for the error, do you or does anybody else?
Author:  Lueddich [ Wed Apr 05, 2006 8:24 am ]
Post subject: 
Interesting: During the whole process, I didn't see these files:

Code:
-rwx------  1 mythtv mythtv          0 Apr  5 16:19 ins0.enc
-rwx------  1 mythtv mythtv          0 Apr  5 16:19 ins0.enc.yuv
-rwx------  1 mythtv mythtv          0 Apr  5 16:19 ins0.enc.yuv.enc
-rwx------  1 mythtv mythtv          0 Apr  5 16:19 ins0.yuv


Now I have these 4 files in the same directory as

Code:
-rw-r--r--  1 mythtv mythtv   38674432 Apr  5 16:19 mythtranscode.log
-rw-r--r--  1 mythtv mythtv 1496154112 Apr  5 16:19 transcode_test.mpg


38,6 MB logfile! ;)
Author:  mac [ Wed Apr 05, 2006 8:37 am ]
Post subject: 
I don't think we are going to get anyting useful from the debugging output...
Something else to try:

* Time how long it takes blow up.
* delete the output file and rerun the transcode
* about 5 minutes before is going to segfault
-- Get the pid of process with "ps aux|grep mythtranscode"
-- Attach an strace process to it before it crashes with "strace -p <trascode's pid>

The last few lines of the strace will tell what it was doing when it walked off the cliff.

Don't know if I will have a chance to play with for while.. will be in India for a few weeks..

My debugging died with:
Code:
2006-04-05 19:24:55.685 Id:0 00:39:39.904 V:82 EXT: 8
2006-04-05 19:24:55.686 VID: B #:9 nb: 2 pts: 00:39:39.824 dts: 00:39:39.824 pos: 1531975694
2006-04-05 19:24:55.686 Id:0 00:39:39.824 V:81 EXT: 8
2006-04-05 19:24:55.687 VID: B #:10 nb: 2 pts: 00:39:39.864 dts: 00:39:39.864 pos: 1531994126
2006-04-05 19:24:55.688 Id:0 00:39:39.864 V:80 EXT: 8
2006-04-05 19:24:55.688 AUD #1: pts: 00:39:39.420 pos: 1531815950
2006-04-05 19:24:55.689 Id:1 00:39:39.420 V:79 EXT: 8
2006-04-05 19:24:55.689 AUD #1: pts: 00:39:39.444 pos: 1531856910
2006-04-05 19:24:55.690 Id:1 00:39:39.444 V:79 EXT: 7
2006-04-05 19:24:55.690 AUD #1: pts: 00:39:39.468 pos: 1531856910
2006-04-05 19:24:55.691 Id:1 00:39:39.468 V:79 EXT: 6
2006-04-05 19:24:55.691 AUD #1: pts: 00:39:39.492 pos: 1531883534
2006-04-05 19:24:55.691 Id:1 00:39:39.492 V:79 EXT: 5
2006-04-05 19:24:55.692 AUD #1: pts: 00:39:39.516 pos: 1531883534
2006-04-05 19:24:55.692 Id:1 00:39:39.516 V:79 EXT: 4
2006-04-05 19:24:55.692 AUD #1: pts: 00:39:39.540 pos: 1531924494
2006-04-05 19:24:55.693 Id:1 00:39:39.540 V:79 EXT: 3
2006-04-05 19:24:55.693 AUD #1: pts: 00:39:39.564 pos: 1531924494
2006-04-05 19:24:55.694 Id:1 00:39:39.564 V:79 EXT: 2
2006-04-05 19:24:55.694 AUD #1: pts: 00:39:39.588 pos: 1531965454
2006-04-05 19:24:55.695 Id:1 00:39:39.588 V:79 EXT: 1
2006-04-05 19:24:55.695 AUD #1: pts: 00:39:39.612 pos: 1532006414
2006-04-05 19:24:55.695 Id:1 00:39:39.612 V:79 EXT: 0
Author:  Lueddich [ Wed Apr 05, 2006 10:32 am ]
Post subject: 
Allright, I can reproduce exactly the same error in nearly the same time with exactly the same error and the resulting file has exactly the same length. When I play that file, I can see, that nothing is cut of, even when the filesize is smaller. The original file is 2641MB, the new one 2405MB. I thought, the cutting is done "on the fly" while writing the new file down, so I don't understand, why the marked parts of the recording are in the resulting file...

The strace didn't work, my system doesn't know this command. Do I have to install it? Didn't know it yet...

Any idea?
Author:  mac [ Wed Apr 05, 2006 11:01 pm ]
Post subject: 
you can install strace with:

apt-get install strace
Author:  Lueddich [ Thu Apr 06, 2006 1:36 am ]
Post subject: 
Allright, here's the result of the strace-file:

Code:
gettimeofday({1144305443, 195845}, NULL) = 0
write(1, "2006-04-06 08:37:23.195 unused:2"..., 82) = 82
read(9, "+\307^ \203\fgx\303\10!f\336 \203\35\357XE\6l]S\f\351-"..., 32768) = 17444
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 196229}, NULL) = 0
write(1, "2006-04-06 08:37:23.196 AUD #1: "..., 66) = 66
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 196512}, NULL) = 0
write(1, "2006-04-06 08:37:23.196 Id:1 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 196805}, NULL) = 0
write(1, "2006-04-06 08:37:23.196 unused:2"..., 82) = 82
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 197076}, NULL) = 0
write(1, "2006-04-06 08:37:23.197 AUD #1: "..., 66) = 66
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 197356}, NULL) = 0
write(1, "2006-04-06 08:37:23.197 Id:1 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 197629}, NULL) = 0
write(1, "2006-04-06 08:37:23.197 AUD #1: "..., 66) = 66
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 197905}, NULL) = 0
write(1, "2006-04-06 08:37:23.197 Id:1 01:"..., 57) = 57
read(9, "", 32768)                      = 0
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 198208}, NULL) = 0
write(1, "2006-04-06 08:37:23.198 unused:2"..., 82) = 82
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 198442}, NULL) = 0
write(1, "2006-04-06 08:37:23.198 VID: I #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 198756}, NULL) = 0
write(1, "2006-04-06 08:37:23.198 Id:0 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 199040}, NULL) = 0
write(1, "2006-04-06 08:37:23.199 VID: B #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 199346}, NULL) = 0
write(1, "2006-04-06 08:37:23.199 Id:0 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 199579}, NULL) = 0
write(1, "2006-04-06 08:37:23.199 VID: B #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 199881}, NULL) = 0
write(1, "2006-04-06 08:37:23.199 Id:0 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 200109}, NULL) = 0
write(1, "2006-04-06 08:37:23.200 PTS disc"..., 78) = 78
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb4d18000
brk(0x86e2000)                          = 0x86e2000
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb4cb4000
brk(0x8713000)                          = 0x8713000
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb47aa000
brk(0x8745000)                          = 0x8745000
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 244524}, NULL) = 0
write(1, "2006-04-06 08:37:23.244 unused:4"..., 97) = 97
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 247990}, NULL) = 0
write(1, "2006-04-06 08:37:23.247 unused:8"..., 97) = 97
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 250882}, NULL) = 0
write(1, "2006-04-06 08:37:23.250 unused:6"..., 97) = 97
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 253219}, NULL) = 0
write(1, "2006-04-06 08:37:23.253 unused:9"..., 97) = 97
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 255500}, NULL) = 0
write(1, "2006-04-06 08:37:23.255 unused:9"..., 97) = 97
open("ins0.yuv", O_WRONLY|O_CREAT|O_TRUNC|O_LARGEFILE, 0700) = 10
write(10, "\17\17\20\21\21\21\20\17\21\21\21\21\21\21\21\21\21\21"..., 405504) = 405504
write(10, "|\201\203\201\200\202\202\201\202\202\202\202\202\202\202"..., 101376) = 101376
write(10, "\202\202\200\177\177\177\200\200\177\177\177\177\177\177"..., 101376) = 101376
close(10)                               = 0
mmap2(NULL, 815104, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb46e3000
mmap2(NULL, 450560, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb4675000
brk(0x8778000)                          = 0x8778000
open("ins0.enc", O_WRONLY|O_CREAT|O_TRUNC|O_LARGEFILE, 0700) = 10
write(10, "\0\0\1\263,\2@\23\377\377\343\320\0\0\1\265\24\202\0\1"..., 44810) = 44810
close(10)                               = 0
open("ins0.enc.yuv.enc", O_WRONLY|O_CREAT|O_TRUNC|O_LARGEFILE, 0700) = 10
write(10, "\0\0\1\263,\2@\23\377\377\343\320\0\0\1\265\24\202\0\1"..., 44810) = 44810
close(10)                               = 0
mmap2(NULL, 1224704, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb454a000
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb44e6000
brk(0x87ac000)                          = 0x87ac000
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb4482000
brk(0x87de000)                          = 0x87de000
mmap2(NULL, 409600, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb441e000
brk(0x880f000)                          = 0x880f000
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 403126}, NULL) = 0
write(1, "2006-04-06 08:37:23.403 unused:4"..., 97) = 97
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 408223}, NULL) = 0
write(1, "2006-04-06 08:37:23.408 unused:4"..., 97) = 97
open("ins0.enc.yuv", O_WRONLY|O_CREAT|O_TRUNC|O_LARGEFILE, 0700) = 10
write(10, "\20\20\21\21\21\21\21\20\21\21\21\21\21\21\21\21\21\21"..., 405504) = 405504
write(10, "\177\202\203\202\201\202\203\202\203\203\203\203\203\203"..., 101376) = 101376
write(10, "\201\200\200\177\177\177\177\177~~~~~~~~\177\177\177\177"..., 101376) = 101376
close(10)                               = 0
munmap(0xb44e6000, 409600)              = 0
munmap(0xb4482000, 409600)              = 0
munmap(0xb441e000, 409600)              = 0
brk(0x8794000)                          = 0x8794000
munmap(0xb454a000, 1224704)             = 0
munmap(0xb4675000, 450560)              = 0
brk(0x8745000)                          = 0x8745000
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 422086}, NULL) = 0
write(1, "2006-04-06 08:37:23.422 Insertin"..., 59) = 59
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 422536}, NULL) = 0
write(1, "2006-04-06 08:37:23.422 unused:2"..., 81) = 81
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 422838}, NULL) = 0
write(1, "2006-04-06 08:37:23.422 unused:2"..., 81) = 81
munmap(0xb46e3000, 815104)              = 0
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 423157}, NULL) = 0
write(1, "2006-04-06 08:37:23.423 VID: P #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 423496}, NULL) = 0
write(1, "2006-04-06 08:37:23.423 Id:0 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 423739}, NULL) = 0
write(1, "2006-04-06 08:37:23.423 VID: I #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 424043}, NULL) = 0
write(1, "2006-04-06 08:37:23.424 Id:0 01:"..., 57) = 57
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 424324}, NULL) = 0
write(1, "2006-04-06 08:37:23.424 VID: I #"..., 93) = 93
time([1144305443])                      = 1144305443
gettimeofday({1144305443, 424643}, NULL) = 0
write(1, "2006-04-06 08:37:23.424 Id:0 01:"..., 57) = 57
futex(0x80d8630, FUTEX_WAKE, 1)         = 1
futex(0x80d862c, FUTEX_WAKE, 1)         = 1
futex(0x80d8614, FUTEX_WAKE, 1)         = 1
futex(0xb55dfbf8, FUTEX_WAIT, 18223, NULL) = -1 EINTR (Interrupted system call)
+++ killed by SIGSEGV +++


Any idea?
Author:  mac [ Thu Apr 06, 2006 2:34 am ]
Post subject: 
Sorry about leading you on a wild goose chase!

This looks like it might be the bug: --- seach for mythtranscode on svn.mythtv.org to see the other tickets
http://svn.mythtv.org/trac/ticket/1510

Rebuiding and install mythtv debs with latest fixes might fix the problem:

http://mysettopbox.tv/phpBB2/viewtopic.php?t=9042
Author:  Lueddich [ Thu Apr 06, 2006 6:35 am ]
Post subject: 
No prob, I'm glad having somebody helping me ;) I'm still learning about Linux and MythTV and things like strace are new to me... Thanks for the help!

I'll try the rebuild at home, but I don't know, when I can do it. Maybe tomorrow evening... I'll post the results again!
Author:  Lueddich [ Fri Apr 07, 2006 3:23 am ]
Post subject: 
What do you think about this one? Sounds like our problem... But how do I install a patch like this?

http://svn.mythtv.org/trac/changeset/9252
Page 1 of 4 All times are UTC - 6 hours
Powered by phpBB® Forum Software © phpBB Group
http://www.phpbb.com/