mythbuntu-bugs team mailing list archive

Thread
Date
[Bug 1238321] Re: after upgrade to 0.27 transcoded files no longer have audio

To: mythbuntu-bugs@xxxxxxxxxxxxxxxxxxx
From: James Harris <jlaunchpad@xxxxxxxxxxxxxxx>
Date: Sun, 17 Nov 2013 04:28:07 -0000
Reply-to: Bug 1238321 <1238321@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
I have the same problem in 0.27 with missing audio after transcoding.

But.... sometimes I can transcode and audio still works. I think I've
narrowed it down to the scenarios below.


WORKING AUDIO - 
1. mythtranscode with lossless mpeg2 and honor cutlist
2. mythtranscode with mpeg4 and NO cutlist

==== output from avplay for transcoded file with audio working (mpeg2 trimmed by cutlist) ====
james@tvserver:/var/lib/mythtv/livetv$ avplay cutmpeg2.nuv 
avplay version 0.8.8-4:0.8.8-0ubuntu0.12.04.1, Copyright (c) 2003-2013 the Libav developers
  built on Oct 22 2013 12:31:55 with gcc 4.6.3
[mpeg @ 0x7f04200008c0] max_analyze_duration reached
Input #0, mpeg, from 'cutmpeg2.nuv':
  Duration: 00:00:59.95, start: 0.310533, bitrate: 2869 kb/s
    Stream #0.0[0x1e0]: Video: mpeg2video (Main), yuv420p, 704x480 [PAR 10:11 DAR 4:3], 15000 kb/s, 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc
    Stream #0.1[0x80]: Audio: ac3, 48000 Hz, stereo, s16, 192 kb/s
   1.10 A-V: -0.010 s:0.0 aq=  320KB vq= 3986KB sq=    0B f=0/0   f=0/0
=============================================================================

Note the audio stream above just says "stereo".


MISSING AUDIO - 
1. mythtranscode with mpeg4 and honor cutlist

==== Output from avplay for transcoded file with no audio (mpeg4 trimmed by cutlist) ====
james@tvserver:/var/lib/mythtv/livetv$ avplay cutmpeg4.nuv 
avplay version 0.8.8-4:0.8.8-0ubuntu0.12.04.1, Copyright (c) 2003-2013 the Libav developers
  built on Oct 22 2013 12:31:55 with gcc 4.6.3
[nuv @ 0x7fb2c00008c0] max_analyze_duration reached
[nuv @ 0x7fb2c00008c0] Estimating duration from bitrate, this may be inaccurate
Input #0, nuv, from 'cutmpeg4.nuv':
  Duration: 00:03:57.05, start: 0.033000, bitrate: 1411 kb/s
    Stream #0.0: Video: mpeg4, yuv420p, 1056x720, PAR 10:11 DAR 4:3, 30.30 fps, 29.97 tbr, 1k tbn, 1k tbc
    Stream #0.1: Audio: mp3, 48000 Hz, 2 channels, s16, 1411 kb/s
0.00 A-V: -1.969 s:0.0 aq=    0KB vq=15370KB sq=    0B f=0/0   f=0/0 
=========================================================================

I can't seem to get avplay to admit that there is no audio. But nothing comes out. 
The only difference between this output and one where audio works is the "max_analyze_duration reached" message and that the audio stream says it is "2 channels".


==== mythtranscode output when using mpeg4 and honor cutlist ====
james@tvserver:/var/lib/mythtv/livetv$ mythtranscode -i 2223_20131117010600.mpg -o cutmpeg4.nuv -p "High Quality" --honorcutlist
2013-11-16 20:13:12.990782 C  mythtranscode version: fixes/0.27 [v0.27-75-g45459f9] www.mythtv.org
2013-11-16 20:13:12.990795 C  Qt version: compile: 4.8.1, runtime: 4.8.1
2013-11-16 20:13:12.990802 N  Enabled verbose msgs:  general
2013-11-16 20:13:12.990809 N  Setting Log Level to LOG_INFO
2013-11-16 20:13:13.001482 I  Added logging to the console
2013-11-16 20:13:13.002141 I  Setup Interrupt handler
2013-11-16 20:13:13.002154 I  Setup Terminated handler
2013-11-16 20:13:13.002165 I  Setup Segmentation fault handler
2013-11-16 20:13:13.002175 I  Setup Aborted handler
2013-11-16 20:13:13.002185 I  Setup Bus error handler
2013-11-16 20:13:13.002196 I  Setup Floating point exception handler
2013-11-16 20:13:13.002206 I  Setup Illegal instruction handler
2013-11-16 20:13:13.002221 I  Setup Real-time signal 0 handler
2013-11-16 20:13:13.002265 N  Using runtime prefix = /usr
2013-11-16 20:13:13.002278 N  Using configuration directory = /home/james/.mythtv
2013-11-16 20:13:13.002357 I  Assumed character encoding: en_US.UTF-8
2013-11-16 20:13:13.002766 N  Empty LocalHostName.
2013-11-16 20:13:13.002775 I  Using localhost value of tvserver
2013-11-16 20:13:13.002817 I  Testing network connectivity to '192.168.1.4'
2013-11-16 20:13:13.004212 I  Starting process manager
2013-11-16 20:13:13.004186 I  Starting IO manager (read)
2013-11-16 20:13:13.004240 I  Starting process signal handler
2013-11-16 20:13:13.004376 I  Starting IO manager (write)
2013-11-16 20:13:13.103557 I  New Client:  (#1)
2013-11-16 20:13:13.118989 N  Setting QT default locale to EN_US
2013-11-16 20:13:13.119076 I  Current locale EN_US
2013-11-16 20:13:13.119127 N  Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
2013-11-16 20:13:13.126350 I  Loading en_us translation for module mythfrontend
2013-11-16 20:13:13.128557 N  Transcoding from 2223_20131117010600.mpg to cutmpeg4.nuv
2013-11-16 20:13:13.157261 I  AFD: codec AC3 has 2 channels
2013-11-16 20:13:13.157620 I  AFD: Opened codec 0x18aa000, id(AC3) type(Audio)
2013-11-16 20:13:13.160513 I  AFD: Opened codec 0x18a95a0, id(MPEG2VIDEO) type(Video)
2013-11-16 20:13:13.160687 N  AudioPlayer: Enabling Audio
2013-11-16 20:13:13.172275 I  Honoring the cutlist while transcoding
2013-11-16 20:13:13.173138 I  Cutlist        : 0-2353,4150-11802
2013-11-16 20:13:13.173149 I  Original Length: 11802 frames
2013-11-16 20:13:13.173154 I  New Length     : 1797 frames
2013-11-16 20:13:13.186324 I  Resizing from 704x480 to 1056x720
2013-11-16 20:13:13.190327 I  MythCoreContext: Connecting to backend server: 192.168.1.4:6543 (try 1 of 1)
2013-11-16 20:13:13.191959 I  Using protocol version 77
2013-11-16 20:13:13.216344 I  Copying Audio while transcoding Video
2013-11-16 20:13:13.223271 I  Player(0): Fast-Forwarding from 0 to 2353
2013-11-16 20:13:25.233450 I  Player(0): Fast-Forwarding from 4150 to 11802
2013-11-16 20:13:25.321820 N  Transcoding 2223_20131117010600.mpg done
2013-11-16 20:13:25.321933 I  Waiting for threads to exit.
Error: Not all threads were shut down properly: 
Thread TFWSync is still running
Thread TFWWrite is still running
============================================================

Note the only error from mythtranscode is "Not all threads were shut
down properly".



Here is the version I am using on the backend.
james@tvserver:~/mythtv/livetv$ apt-cache policy mythtv-backend
mythtv-backend:
  Installed: 2:0.27.0+fixes.20131108.45459f9-0ubuntu0mythbuntu2
  Candidate: 2:0.27.0+fixes.20131115.4ca9300-0ubuntu0mythbuntu2
  Version table:
     2:0.27.0+fixes.20131115.4ca9300-0ubuntu0mythbuntu2 0
        500 http://ppa.launchpad.net/mythbuntu/0.27/ubuntu/ precise/main amd64 Packages
 *** 2:0.27.0+fixes.20131108.45459f9-0ubuntu0mythbuntu2 0
        100 /var/lib/dpkg/status
     2:0.25.3+fixes.20130813.b5adf03-0ubuntu0mythbuntu2 0
        500 http://ppa.launchpad.net/mythbuntu/0.25/ubuntu/ precise/main amd64 Packages
     2:0.25.2+fixes.20120802.46cab93-0ubuntu1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise-updates/multiverse amd64 Packages
     2:0.25.0+fixes.20120410.1f5962a-0ubuntu1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/multiverse amd64 Packages

-- 
You received this bug notification because you are a member of Mythbuntu
Bug Team, which is subscribed to mythtv in Ubuntu.
https://bugs.launchpad.net/bugs/1238321

Title:
  after upgrade to 0.27 transcoded files no longer have audio

Status in “mythtv” package in Ubuntu:
  New

Bug description:
  recently upgraded from 0.25 to 0.27 on Ubuntu 12.04.1 LTS

  among a few other issues, I have noticed transcoding doesn't work
  properly any more

  tried it four or five times now, with different audio options selected
  in the frontend and also with different audio options on the "Low
  Quality" transcoder configuration in the backend

  no matter what I try, every time I transcode a recording, the
  resulting file has no audio (I have confirmed by manually playing the
  nuv file in vlc)

  here is a log:
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: C thread_unknown mythcommandlineparser.cpp:2594 (ConfigureLogging) mythtranscode version: fixes/0.27 [v0.27-11-ga179aae] www.mythtv.org
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: C thread_unknown mythcommandlineparser.cpp:2596 (ConfigureLogging) Qt version: compile: 4.8.1, runtime: 4.8.1
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N thread_unknown mythcommandlineparser.cpp:2598 (ConfigureLogging) Enabled verbose msgs:  general
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N thread_unknown logging.cpp:914 (logStart) Setting Log Level to LOG_INFO
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Interrupt handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Terminated handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Segmentation fault handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Aborted handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Bus error handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Floating point exception handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Illegal instruction handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) Setup Real-time signal 0 handler
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N thread_unknown mythdirs.cpp:55 (InitializeMythDirs) Using runtime prefix = /usr
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N thread_unknown mythdirs.cpp:68 (InitializeMythDirs) Using configuration directory = /home/mythtv/.mythtv
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I CoreContext mythcorecontext.cpp:249 (Init) Assumed character encoding: en_AU.UTF-8
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N CoreContext mythcontext.cpp:504 (LoadDatabaseSettings) Empty LocalHostName.
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I CoreContext mythcontext.cpp:512 (LoadDatabaseSettings) Using localhost value of rem
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I Logger logging.cpp:315 (run) Added logging to the console
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N CoreContext mythcorecontext.cpp:1294 (InitLocale) Setting QT default locale to en_US
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I CoreContext mythcorecontext.cpp:1327 (SaveLocaleDefaults) Current locale en_US
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N CoreContext mythlocale.cpp:121 (LoadDefaultsFromXML) Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I LogForward loggingserver.cpp:1372 (forwardMessage) New Client:  (#1)
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I LogForward loggingserver.cpp:295 (SyslogLogger) Added syslogging
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: I CoreContext mythtranslation.cpp:65 (load) Loading en_gb translation for module mythfrontend
  Oct 11 09:56:42 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:566 (main) Transcoding from /stuff/recordings/1003_20131009015800.mpg to /stuff/recordings/1003_20131009015800.mpg.tmp
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I SendMessage mythcorecontext.cpp:418 (ConnectCommandSocket) MythCoreContext: Connecting to backend server: 192.168.1.108:6543 (try 1 of 1)
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I SendMessage mythcorecontext.cpp:1207 (CheckProtoVersion) Using protocol version 77
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext avformatdecoder.cpp:1898 (ScanStreams) AFD: codec MP2 has 2 channels
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext avformatdecoder.cpp:2378 (OpenAVCodec) AFD: Opened codec 0x958b000, id(MP2) type(Audio)
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext avformatdecoder.cpp:2378 (OpenAVCodec) AFD: Opened codec 0x95ddf20, id(MPEG2VIDEO) type(Video)
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: N CoreContext audioplayer.cpp:164 (ReinitAudio) AudioPlayer: Enabling Audio
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:310 (TranscodeFile) Honoring the cutlist while transcoding
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:343 (TranscodeFile) Cutlist        : 0-30001,37501-99972
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:345 (TranscodeFile) Original Length: 99972 frames
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:347 (TranscodeFile) New Length     : 7500 frames
  Oct 11 09:56:43 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:692 (TranscodeFile) Resizing from 720x576 to 640x512
  Oct 11 09:56:44 rem mythtranscode: mythtranscode[22517]: I CoreContext transcode.cpp:1026 (TranscodeFile) Transcoding Video and Audio
  Oct 11 09:56:44 rem mythtranscode: mythtranscode[22517]: I VideoDecodeBuffer mythplayer.cpp:4593 (TranscodeGetNextFrame) Player(0): Fast-Forwarding from 0 to 30001
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: I VideoDecodeBuffer mythplayer.cpp:4593 (TranscodeGetNextFrame) Player(0): Fast-Forwarding from 37501 to 99972
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:686 (main) Transcoding /stuff/recordings/1003_20131009015800.mpg done
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:804 (WaitToDelete) Transcode: delete old file: waiting while program is in use.
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:836 (WaitToDelete) Transcode: program is no longer in use.
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:735 (transUnlink) Requesting delete for file 'myth://Default@[FE80::219:D1FF:FEDE:5E19]:6543/1003_20131009015800.mpg.old'.
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: N CoreContext main.cpp:735 (transUnlink) Requesting delete for file 'myth://Default@[FE80::219:D1FF:FEDE:5E19]:6543/1003_20131009015800.mpg.png'.
  Oct 11 09:58:18 rem mythtranscode: mythtranscode[22517]: I CoreContext mythcontext.cpp:1194 (~MythContext) Waiting for threads to exit.

  
  here is the precise version I am using-
  $ apt-cache policy mythtv
  mythtv:
    Installed: 2:0.27.0+fixes.20130926.a179aae-0ubuntu0mythbuntu2
    Candidate: 2:0.27.0+fixes.20130926.a179aae-0ubuntu0mythbuntu2
    Version table:
   *** 2:0.27.0+fixes.20130926.a179aae-0ubuntu0mythbuntu2 0
          500 http://ppa.launchpad.net/mythbuntu/0.27/ubuntu/ precise/main i386 Packages
          100 /var/lib/dpkg/status
       2:0.25.2+fixes.20120802.46cab93-0ubuntu1 0
          500 http://ftp.iinet.net.au/pub/ubuntu/ precise-updates/multiverse i386 Packages
          500 http://archive.ubuntu.com/ubuntu/ precise-updates/multiverse i386 Packages
       2:0.25.0+fixes.20120410.1f5962a-0ubuntu1 0
          500 http://ftp.iinet.net.au/pub/ubuntu/ precise/multiverse i386 Packages
          500 http://archive.ubuntu.com/ubuntu/ precise/multiverse i386 Packages

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/mythtv/+bug/1238321/+subscriptions
References

[Bug 1238321] [NEW] after upgrade to 0.27 transcoded files no longer have audio
From: Conrad Firm, 2013-10-10