[mythtv-users] mythtranscode recording duration incorrect after lossless transcode

Sat Sep 29 21:05:27 UTC 2012

I'm finding that when running a transcode on recordings the reported
recording duration gets mangled.  I first thought this was a problem
with recordings with a cutlist but the log below is from a recording
that doesn't have a cutlist.   The recordings seem to play back okay.

Before transcode Duration: 00:13:56.36, start: 29057.392911, bitrate: 3279 kb/s
After transcode Duration: 26:30:43.57, start: 0.360000, bitrate: 26 kb/s

Any thoughts?

Cheers
Stephen

stephen at bressay:~$ mythtranscode --chanid 1005 --starttime
20120927073300 --mpeg2
2012-09-29 21:57:06.294151 C  mythtranscode version: master
[v0.26-rc2-50-g73f41b0] www.mythtv.org
2012-09-29 21:57:06.294166 C  Qt version: compile: 4.8.1, runtime: 4.8.1
2012-09-29 21:57:06.294173 N  Enabled verbose msgs:  general
2012-09-29 21:57:06.294183 N  Setting Log Level to LOG_INFO
2012-09-29 21:57:06.294400 I  Added logging to the console
2012-09-29 21:57:06.295322 I  Setup Interrupt handler
2012-09-29 21:57:06.295332 I  Setup Terminated handler
2012-09-29 21:57:06.295340 I  Setup Segmentation fault handler
2012-09-29 21:57:06.295349 I  Setup Aborted handler
2012-09-29 21:57:06.295356 I  Setup Bus error handler
2012-09-29 21:57:06.295364 I  Setup Floating point exception handler
2012-09-29 21:57:06.295372 I  Setup Illegal instruction handler
2012-09-29 21:57:06.295383 I  Setup Real-time signal 0 handler
2012-09-29 21:57:06.295410 N  Using runtime prefix = /usr
2012-09-29 21:57:06.295425 N  Using configuration directory =
/home/stephen/.mythtv
2012-09-29 21:57:06.295479 I  Assumed character encoding: en_GB.UTF-8
2012-09-29 21:57:06.295762 N  Empty LocalHostName.
2012-09-29 21:57:06.295770 I  Using localhost value of bressay
2012-09-29 21:57:06.306572 N  Setting QT default locale to en_GB
2012-09-29 21:57:06.306632 I  Current locale en_GB
2012-09-29 21:57:06.306673 N  Reading locale defaults from
/usr/share/mythtv//locales/en_gb.xml
2012-09-29 21:57:06.310500 I  Loading en_gb translation for module mythfrontend
2012-09-29 21:57:06.312219 N  Transcoding from
/media/500G/1005_20120927073300.mpg to
/media/500G/1005_20120927073300.mpg.tmp
2012-09-29 21:57:06.416557 I  Opening /media/500G/1005_20120927073300.mpg
2012-09-29 21:57:06.448253 I  Invalid extradata, subtitle streams may
be combined!
2012-09-29 21:57:06.448375 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.448393 I  write_section_data: PID 0x91b CRC error
2012-09-29 21:57:06.452156 I  write_section_data: PID 0x91b CRC error
2012-09-29 21:57:06.452496 I  write_section_data: PID 0x91b CRC error
2012-09-29 21:57:06.452515 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.469718 I  max_analyze_duration 5000000 reached at 5016000
2012-09-29 21:57:06.470184 I  start time is not set in estimate_timings_from_pts
2012-09-29 21:57:06.470193 I  start time is not set in estimate_timings_from_pts
2012-09-29 21:57:06.470200 I  start time is not set in estimate_timings_from_pts
2012-09-29 21:57:06.470206 I  start time is not set in estimate_timings_from_pts
2012-09-29 21:57:06.470316 I  write_section_data: PID 0x91b CRC error
2012-09-29 21:57:06.470437 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.470945 I  PES packet size mismatch
2012-09-29 21:57:06.470960 I  PES packet size mismatch
2012-09-29 21:57:06.471006 I  Input #0, mpegts, from
'/media/500G/1005_20120927073300.mpg':
2012-09-29 21:57:06.471026 I    Duration: 00:13:56.36, start:
29057.392911, bitrate: 3279 kb/s
2012-09-29 21:57:06.471097 I      Stream #0:0[0xb86]: Video:
mpeg2video (Main), yuv420p, 704x576 [SAR 16:11 DAR 16:9], 15000 kb/s,
25 fps, 25 tbr, 90k tbn, 50 tbc
2012-09-29 21:57:06.471125 I      Stream #0:1[0xb23](eng): Audio: mp2,
48000 Hz, stereo, s16, 192 kb/s
2012-09-29 21:57:06.471142 I      Stream #0:2[0xb25](eng): Audio: mp2,
48000 Hz, mono, s16, 64 kb/s
2012-09-29 21:57:06.471157 I      Stream #0:3[0xb24](eng): Subtitle:
dvb_subtitle
2012-09-29 21:57:06.471170 I      Stream #0:4[0x856]: Data: dsmcc_b
2012-09-29 21:57:06.471182 I      Stream #0:5[0x91b]: Data: dsmcc_b
2012-09-29 21:57:06.471194 I      Stream #0:6[0x91c]: Data: dsmcc_b
2012-09-29 21:57:06.471223 E  Skipping unsupported codec 3 on stream 3
2012-09-29 21:57:06.471232 E  Skipping unsupported codec 2 on stream 4
2012-09-29 21:57:06.471240 E  Skipping unsupported codec 2 on stream 5
2012-09-29 21:57:06.471248 E  Skipping unsupported codec 2 on stream 6
2012-09-29 21:57:06.471315 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.471331 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.472642 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.472719 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.472769 I  write_section_data: PID 0x91c CRC error
2012-09-29 21:57:06.472974 I  write_section_data: PID 0x91b CRC error
2012-09-29 21:57:06.474658 I  #0 PTS:08:04:18.074 Delta: 0.0ms queue: 21
2012-09-29 21:57:06.474716 I  #1 PTS:08:04:18.064 Delta: 9.46667ms queue: 8
2012-09-29 21:57:06.474743 I  #2 PTS:08:04:18.064 Delta: 9.46667ms queue: 2
2012-09-29 21:57:06.488468 I  Mux rate: 15.51 Mbit/s
2012-09-29 21:57:06.629403 I  Added logging to mythlogserver at TCP:35327
2012-09-29 21:57:18.968643 I  PES packet size mismatch
2012-09-29 21:57:18.968672 I  PES packet size mismatch
2012-09-29 21:57:19.126290 I  Inserting 2 I-Frames after #2
2012-09-29 21:57:19.129557 I  Generating Keyframe Index
2012-09-29 21:57:19.129567 I  Opening /media/500G/1005_20120927073300.mpg.tmp
2012-09-29 21:57:19.145125 I  Input #0, mpeg, from
'/media/500G/1005_20120927073300.mpg.tmp':
2012-09-29 21:57:19.145140 I    Duration: 26:30:43.57, start:
0.360000, bitrate: 26 kb/s
2012-09-29 21:57:19.145169 I      Stream #0:0[0x1e0]: Video:
mpeg2video (Main), yuv420p, 704x576 [SAR 16:11 DAR 16:9], 15000 kb/s,
25 fps, 25 tbr, 90k tbn, 50 tbc
2012-09-29 21:57:19.145181 I      Stream #0:1[0x1c0]: Audio: mp2,
48000 Hz, stereo, s16, 192 kb/s
2012-09-29 21:57:19.145190 I      Stream #0:2[0x1c1]: Audio: mp2,
48000 Hz, mono, s16, 64 kb/s
2012-09-29 21:57:19.911398 I  Adjusting PTS forward
2012-09-29 21:57:19.911755 I  Adjusting PTS forward
2012-09-29 21:57:19.912113 I  Invalid timestamps stream=0, pts=19800,
dts=75240852, size=2015
2012-09-29 21:57:19.912223 N  Transcode Completed
2012-09-29 21:57:20.038337 N  Transcoding
/media/500G/1005_20120927073300.mpg done