1.6 seems to have issues muxing

For help and support with PS3 Media Server in general
Forum rules
Please make sure you follow the Problem Reporting Guidelines before posting if you want a reply.

1.6 seems to have issues muxing

Postby knicknak » Tue Aug 21, 2012 10:20 am

I was using 1.53 without issue. I installed 1.6 and now audio seems to go out to lunch when streaming MKVs using tsmuxer.

If I watch TrueBlood after the HBO static screen thing at the start, the audio goes haywire.

I have both 1.53 and 1.6 installed, I'm using the same config file. 1.53 works, 1.6 is broken.

Here's the 1.6 debug log:

Code: Select all
INFO  2012-08-21 01:06:18.200 [Request Handler] Starting transcode/remux of True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv
DEBUG 2012-08-21 01:06:18.214 [Request Handler] Creating pipe \\.\pipe\1345536378214ffmpegvideo
DEBUG 2012-08-21 01:06:18.214 [Request Handler] Creating pipe \\.\pipe\1345536378214videoout
DEBUG 2012-08-21 01:06:18.216 [Request Handler] Starting "C:\Program Files (x86)\PS3 Media Server\win32\ffmpeg.exe" -i "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv" -vframes 1 -vcodec copy -f h264 -vbsf h264_mp4toannexb -an -y pipe:
DEBUG 2012-08-21 01:06:18.220 [Thread-111] Waiting for pipe connection \\.\pipe\1345536378214ffmpegvideo
DEBUG 2012-08-21 01:06:18.221 [Request Handler] Attaching thread: ffmpeg.exe-24
DEBUG 2012-08-21 01:06:18.224 [Thread-112] Waiting for pipe connection \\.\pipe\1345536378214videoout
DEBUG 2012-08-21 01:06:18.301 [Thread-114] ffmpeg version N-35509-gfd36cbf-Sherpya, Copyright (c) 2000-2011 the FFmpeg developers
DEBUG 2012-08-21 01:06:18.301 [Thread-114]   built on Dec  7 2011 06:17:11 with gcc 4.6.2
DEBUG 2012-08-21 01:06:18.301 [Thread-114]   libavutil    51. 30. 0 / 51. 30. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libavcodec   53. 41. 0 / 53. 41. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libavformat  53. 24. 0 / 53. 24. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libavdevice  53.  4. 0 / 53.  4. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libavfilter   2. 51. 0 /  2. 51. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libswscale    2.  1. 0 /  2.  1. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   libpostproc  51.  2. 0 / 51.  2. 0
DEBUG 2012-08-21 01:06:18.302 [Thread-114] Input #0, matroska,webm, from 'D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv':
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   Duration: 00:51:36.35, start: 0.000000, bitrate: 4870 kb/s
DEBUG 2012-08-21 01:06:18.302 [Thread-114]     Stream #0:0(eng): Video: h264 (High), yuv420p, 1280x720, SAR 1:1 DAR 16:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
DEBUG 2012-08-21 01:06:18.302 [Thread-114]     Stream #0:1: Audio: ac3, 48000 Hz, stereo, s16, 384 kb/s (default)
DEBUG 2012-08-21 01:06:18.302 [Thread-114] Output #0, h264, to 'pipe:':
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   Metadata:
DEBUG 2012-08-21 01:06:18.302 [Thread-114]     encoder         : Lavf53.24.0
DEBUG 2012-08-21 01:06:18.302 [Thread-114]     Stream #0:0(eng): Video: h264, yuv420p, 1280x720 [SAR 1:1 DAR 16:9], q=2-31, 23.98 fps, 90k tbn, 23.98 tbc (default)
DEBUG 2012-08-21 01:06:18.302 [Thread-114] Stream mapping:
DEBUG 2012-08-21 01:06:18.302 [Thread-114]   Stream #0:0 -> #0:0 (copy)
DEBUG 2012-08-21 01:06:18.302 [Thread-114] Press [q] to stop, [?] for help
DEBUG 2012-08-21 01:06:18.302 [Thread-114] frame=    1 fps=  0 q=-1.0 Lsize=      11kB time=00:00:00.-4 bitrate=-2095.3kbits/s   
DEBUG 2012-08-21 01:06:18.302 [Thread-114]
DEBUG 2012-08-21 01:06:18.302 [Thread-114] video:11kB audio:0kB global headers:0kB muxing overhead 0.358357%
DEBUG 2012-08-21 01:06:18.309 [Request Handler] Creating pipe \\.\pipe\1345536378309ffmpegaudio01
DEBUG 2012-08-21 01:06:18.309 [Request Handler] Creating pipe \\.\pipe\1345536378309audioout
DEBUG 2012-08-21 01:06:18.310 [Thread-120] Waiting for pipe connection \\.\pipe\1345536378309audioout
DEBUG 2012-08-21 01:06:18.310 [Thread-119] Waiting for pipe connection \\.\pipe\1345536378309ffmpegaudio01
DEBUG 2012-08-21 01:06:18.314 [Request Handler] Creating pipe \\.\pipe\1345536378314tsmuxerout.ts
DEBUG 2012-08-21 01:06:18.314 [Thread-122] Waiting for pipe connection \\.\pipe\1345536378314tsmuxerout.ts
DEBUG 2012-08-21 01:06:18.416 [mencoder.exe-25] Starting "C:\Program Files (x86)\PS3 Media Server\win32\mencoder.exe" -ss 0 "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv" -quiet -quiet -really-quiet -msglevel statusline=2 -ovc copy -nosound -mc 0 -noskip -of rawvideo -o \\.\pipe\1345536378214ffmpegvideo
DEBUG 2012-08-21 01:06:18.419 [mencoder.exe-25] Attaching thread: mencoder.exe-25
DEBUG 2012-08-21 01:06:18.518 [mencoder.exe-26] Starting "C:\Program Files (x86)\PS3 Media Server\win32\mencoder.exe" -ss 0 "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv" -quiet -quiet -really-quiet -msglevel statusline=2 -channels 6 -ovc copy -of rawaudio -mc 0 -noskip -oac lavc -fafmttag 0x2000 -lavcopts acodec=ac3:abitrate=448 -af lavcresample=48000 -srate 48000 -quiet -quiet -o \\.\pipe\1345536378309ffmpegaudio01
DEBUG 2012-08-21 01:06:18.521 [mencoder.exe-26] Attaching thread: mencoder.exe-26
DEBUG 2012-08-21 01:06:18.572 [Buffered IO End Checker] Stopping process: ffmpeg.exe-22
DEBUG 2012-08-21 01:06:18.619 [tsMuxeR.exe-27] Starting "C:\Program Files (x86)\PS3 Media Server\win32\tsMuxeR.exe" C:\Users\JT\AppData\Local\Temp\ps3mediaserver\pms-tsmuxer.meta \\.\pipe\1345536378314tsmuxerout.ts
DEBUG 2012-08-21 01:06:18.625 [tsMuxeR.exe-27] Reading pipe: \\.\pipe\1345536378314tsmuxerout.ts
DEBUG 2012-08-21 01:06:18.639 [tsMuxeR.exe-27] Attaching thread: tsMuxeR.exe-27
DEBUG 2012-08-21 01:06:18.696 [Thread-119] Result of \\.\pipe\1345536378309ffmpegaudio01 : true
DEBUG 2012-08-21 01:06:18.708 [Thread-111] Result of \\.\pipe\1345536378214ffmpegvideo : true
DEBUG 2012-08-21 01:06:18.728 [Thread-133] SmartLabs tsMuxeR.  Version 1.10.6  http://www.smlabs.net
DEBUG 2012-08-21 01:06:18.931 [Thread-120] Forced reconnection of \\.\pipe\1345536378309audioout with result : true
DEBUG 2012-08-21 01:06:18.931 [Thread-112] Forced reconnection of \\.\pipe\1345536378214videoout with result : true
DEBUG 2012-08-21 01:06:18.931 [Thread-112] Result of \\.\pipe\1345536378214videoout : true
DEBUG 2012-08-21 01:06:18.931 [Thread-120] Result of \\.\pipe\1345536378309audioout : true
DEBUG 2012-08-21 01:06:18.934 [Thread-133] Decoding H264 stream (track 1): Profile: High@4.1  Resolution: 1280:720p  Frame rate: 23.976
DEBUG 2012-08-21 01:06:18.934 [Thread-133] Change H264 level from 4.1 to 4.1
DEBUG 2012-08-21 01:06:18.934 [Thread-133] H.264 stream does not contain fps field. Muxing fps=23.976
DEBUG 2012-08-21 01:06:18.939 [Thread-122] Result of \\.\pipe\1345536378314tsmuxerout.ts : true
DEBUG 2012-08-21 01:06:18.951 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:18.951 [Thread-133] H264 bitstream changed: insert nal unit delimiters
DEBUG 2012-08-21 01:06:18.951 [Thread-133] H264 bitstream changed: insert pict timing and buffering period SEI units
DEBUG 2012-08-21 01:06:18.951 [Thread-133] Decoding AC3 stream (track 2): Bitrate: 448Kbps Sample Rate: 48KHz Channels: 2
DEBUG 2012-08-21 01:06:18.951 [Thread-133] B-pyramid level 1 detected. Shift DTS to 2 frames
DEBUG 2012-08-21 01:06:18.992 [Buffered IO End Checker] Stopping process: ffmpeg.exe-23
INFO  2012-08-21 01:06:19.133 [StartPlaying Event] renderer: 192.168.3.3, file: D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv
DEBUG 2012-08-21 01:06:19.191 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:19.393 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:19.598 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:19.887 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:20.215 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:20.458 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:20.659 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:20.813 [Buffered IO End Checker] Stopping process: ffmpeg.exe-24
DEBUG 2012-08-21 01:06:20.862 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:21.495 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:23.053 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:24.055 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:26.057 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:27.059 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:28.064 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:29.566 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:30.571 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:32.067 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:33.070 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:35.071 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:35.573 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:36.076 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:37.078 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:38.580 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:39.583 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:40.585 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:41.088 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:43.089 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:44.091 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:45.095 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:45.600 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:46.605 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:48.107 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:49.113 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:50.613 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:52.115 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:53.621 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:55.123 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:56.125 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:57.126 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:58.130 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:06:59.130 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:00.133 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:01.138 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:02.641 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:04.144 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:05.149 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:06.153 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:07.161 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:08.659 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:10.161 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:11.192 [Request Handler] Setting margin to 2Mb
DEBUG 2012-08-21 01:07:11.667 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:12.857 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:13.364 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:14.370 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:15.375 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:16.382 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:17.387 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:18.391 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:19.398 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:20.402 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:20.905 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:21.408 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:21.922 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:22.449 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:22.958 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:23.964 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:24.967 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:26.471 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:27.482 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:28.983 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:30.491 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:31.493 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:32.995 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:33.997 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:35.499 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:36.500 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:38.002 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:39.008 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:40.014 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:41.517 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:42.521 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:44.523 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:48.023 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:49.524 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:51.525 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:52.027 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:54.529 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:07:57.532 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:00.034 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:01.536 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:03.038 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:05.540 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:07.041 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:08.043 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:09.048 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:10.550 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:12.051 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:14.052 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:16.053 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:18.054 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:20.555 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:23.058 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:24.559 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:26.061 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:28.063 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:30.065 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:32.067 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:34.070 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:36.577 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:39.079 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:41.081 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:43.083 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:44.084 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:46.586 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:47.591 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:50.092 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:53.093 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:53.498 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-08-21 01:08:55.094 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:56.603 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:57.605 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:08:59.608 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:01.610 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:03.112 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:04.114 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:05.616 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:06.622 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:08.123 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:09.624 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:11.625 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:12.629 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:14.130 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:15.631 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:16.133 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:16.636 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:17.139 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:17.642 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:18.145 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:19.147 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:19.650 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:20.154 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:21.156 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:21.659 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:22.661 [Thread-133] 100.0% complete
DEBUG 2012-08-21 01:09:25.656 [Buffered IO End Checker] Stopping process: tsMuxeR.exe-27
DEBUG 2012-08-21 01:09:25.656 [Thread-122] Error: null
DEBUG 2012-08-21 01:09:25.657 [Thread-110] Error :null
DEBUG 2012-08-21 01:09:25.658 [Thread-111] Error: null
DEBUG 2012-08-21 01:09:25.656 [Buffered IO End Checker] Stopping process: mencoder.exe-25
DEBUG 2012-08-21 01:09:25.658 [Buffered IO End Checker] Stopping process: mencoder.exe-26
DEBUG 2012-08-21 01:09:25.659 [Thread-119] Error: null
DEBUG 2012-08-21 01:09:25.659 [Thread-112] Disconnected pipe: \\.\pipe\1345536378214videoout
DEBUG 2012-08-21 01:09:25.661 [Thread-120] Disconnected pipe: \\.\pipe\1345536378309audioout
DEBUG 2012-08-21 01:09:25.663 [Thread-118] Error :null
INFO  2012-08-21 01:09:25.864 [Request Handler] Starting transcode/remux of True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv
DEBUG 2012-08-21 01:09:25.868 [Request Handler] Creating pipe \\.\pipe\1345536565868ffmpegvideo
DEBUG 2012-08-21 01:09:25.869 [Request Handler] Creating pipe \\.\pipe\1345536565868videoout
DEBUG 2012-08-21 01:09:25.869 [Thread-135] Waiting for pipe connection \\.\pipe\1345536565868ffmpegvideo
DEBUG 2012-08-21 01:09:25.870 [Request Handler] Starting "C:\Program Files (x86)\PS3 Media Server\win32\ffmpeg.exe" -i "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv" -vframes 1 -vcodec copy -f h264 -vbsf h264_mp4toannexb -an -y pipe:
DEBUG 2012-08-21 01:09:25.875 [Request Handler] Attaching thread: ffmpeg.exe-28
DEBUG 2012-08-21 01:09:25.875 [Thread-136] Waiting for pipe connection \\.\pipe\1345536565868videoout
DEBUG 2012-08-21 01:09:25.997 [Thread-138] ffmpeg version N-35509-gfd36cbf-Sherpya, Copyright (c) 2000-2011 the FFmpeg developers
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   built on Dec  7 2011 06:17:11 with gcc 4.6.2
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libavutil    51. 30. 0 / 51. 30. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libavcodec   53. 41. 0 / 53. 41. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libavformat  53. 24. 0 / 53. 24. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libavdevice  53.  4. 0 / 53.  4. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libavfilter   2. 51. 0 /  2. 51. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libswscale    2.  1. 0 /  2.  1. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   libpostproc  51.  2. 0 / 51.  2. 0
DEBUG 2012-08-21 01:09:25.997 [Thread-138] Input #0, matroska,webm, from 'D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv':
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   Duration: 00:50:04.57, start: 0.000000, bitrate: 4321 kb/s
DEBUG 2012-08-21 01:09:25.997 [Thread-138]     Stream #0:0(eng): Video: h264 (High), yuv420p, 1280x720, SAR 1:1 DAR 16:9, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
DEBUG 2012-08-21 01:09:25.997 [Thread-138]     Stream #0:1: Audio: ac3, 48000 Hz, stereo, s16, 384 kb/s (default)
DEBUG 2012-08-21 01:09:25.997 [Thread-138] Output #0, h264, to 'pipe:':
DEBUG 2012-08-21 01:09:25.997 [Thread-138]   Metadata:
DEBUG 2012-08-21 01:09:25.997 [Thread-138]     encoder         : Lavf53.24.0
DEBUG 2012-08-21 01:09:25.997 [Thread-138]     Stream #0:0(eng): Video: h264, yuv420p, 1280x720 [SAR 1:1 DAR 16:9], q=2-31, 23.98 fps, 90k tbn, 23.98 tbc (default)
DEBUG 2012-08-21 01:09:25.997 [Thread-138] Stream mapping:
DEBUG 2012-08-21 01:09:25.998 [Thread-138]   Stream #0:0 -> #0:0 (copy)
DEBUG 2012-08-21 01:09:25.998 [Thread-138] Press [q] to stop, [?] for help
DEBUG 2012-08-21 01:09:25.998 [Thread-138] frame=    1 fps=  0 q=-1.0 Lsize=       8kB time=00:00:00.-4 bitrate=-1663.3kbits/s   
DEBUG 2012-08-21 01:09:25.998 [Thread-138]
DEBUG 2012-08-21 01:09:25.998 [Thread-138] video:8kB audio:0kB global headers:0kB muxing overhead 0.451860%
DEBUG 2012-08-21 01:09:26.001 [Request Handler] Creating pipe \\.\pipe\1345536566001ffmpegaudio01
DEBUG 2012-08-21 01:09:26.002 [Request Handler] Creating pipe \\.\pipe\1345536566001audioout
DEBUG 2012-08-21 01:09:26.002 [Thread-143] Waiting for pipe connection \\.\pipe\1345536566001ffmpegaudio01
DEBUG 2012-08-21 01:09:26.004 [Request Handler] Creating pipe \\.\pipe\1345536566004tsmuxerout.ts
DEBUG 2012-08-21 01:09:26.005 [Thread-146] Waiting for pipe connection \\.\pipe\1345536566004tsmuxerout.ts
DEBUG 2012-08-21 01:09:26.006 [Thread-144] Waiting for pipe connection \\.\pipe\1345536566001audioout
DEBUG 2012-08-21 01:09:26.106 [mencoder.exe-29] Starting "C:\Program Files (x86)\PS3 Media Server\win32\mencoder.exe" -ss 0 "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv" -quiet -quiet -really-quiet -msglevel statusline=2 -ovc copy -nosound -mc 0 -noskip -of rawvideo -o \\.\pipe\1345536565868ffmpegvideo
DEBUG 2012-08-21 01:09:26.111 [mencoder.exe-29] Attaching thread: mencoder.exe-29
DEBUG 2012-08-21 01:09:26.170 [Thread-135] Result of \\.\pipe\1345536565868ffmpegvideo : true
DEBUG 2012-08-21 01:09:26.208 [mencoder.exe-30] Starting "C:\Program Files (x86)\PS3 Media Server\win32\mencoder.exe" -ss 0 "D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv" -quiet -quiet -really-quiet -msglevel statusline=2 -channels 6 -ovc copy -of rawaudio -mc 0 -noskip -oac lavc -fafmttag 0x2000 -lavcopts acodec=ac3:abitrate=448 -af lavcresample=48000 -srate 48000 -quiet -quiet -o \\.\pipe\1345536566001ffmpegaudio01
DEBUG 2012-08-21 01:09:26.212 [mencoder.exe-30] Attaching thread: mencoder.exe-30
DEBUG 2012-08-21 01:09:26.269 [Thread-143] Result of \\.\pipe\1345536566001ffmpegaudio01 : true
DEBUG 2012-08-21 01:09:26.309 [tsMuxeR.exe-31] Starting "C:\Program Files (x86)\PS3 Media Server\win32\tsMuxeR.exe" C:\Users\JT\AppData\Local\Temp\ps3mediaserver\pms-tsmuxer.meta \\.\pipe\1345536566004tsmuxerout.ts
DEBUG 2012-08-21 01:09:26.313 [tsMuxeR.exe-31] Reading pipe: \\.\pipe\1345536566004tsmuxerout.ts
DEBUG 2012-08-21 01:09:26.323 [tsMuxeR.exe-31] Attaching thread: tsMuxeR.exe-31
DEBUG 2012-08-21 01:09:26.382 [Thread-157] SmartLabs tsMuxeR.  Version 1.10.6  http://www.smlabs.net
DEBUG 2012-08-21 01:09:26.584 [Thread-136] Forced reconnection of \\.\pipe\1345536565868videoout with result : true
DEBUG 2012-08-21 01:09:26.584 [Thread-136] Result of \\.\pipe\1345536565868videoout : true
DEBUG 2012-08-21 01:09:26.585 [Thread-144] Forced reconnection of \\.\pipe\1345536566001audioout with result : true
DEBUG 2012-08-21 01:09:26.585 [Thread-144] Result of \\.\pipe\1345536566001audioout : true
DEBUG 2012-08-21 01:09:26.587 [Thread-157] Decoding H264 stream (track 1): Profile: High@4.1  Resolution: 1280:720p  Frame rate: 23.976
DEBUG 2012-08-21 01:09:26.587 [Thread-157] Change H264 level from 4.1 to 4.1
DEBUG 2012-08-21 01:09:26.587 [Thread-157] H.264 stream does not contain fps field. Muxing fps=23.976
DEBUG 2012-08-21 01:09:26.590 [Thread-146] Result of \\.\pipe\1345536566004tsmuxerout.ts : true
DEBUG 2012-08-21 01:09:26.595 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:26.595 [Thread-157] H264 bitstream changed: insert nal unit delimiters
DEBUG 2012-08-21 01:09:26.595 [Thread-157] H264 bitstream changed: insert pict timing and buffering period SEI units
DEBUG 2012-08-21 01:09:26.595 [Thread-157] Decoding AC3 stream (track 2): Bitrate: 448Kbps Sample Rate: 48KHz Channels: 2
DEBUG 2012-08-21 01:09:26.596 [Thread-157] B-pyramid level 1 detected. Shift DTS to 2 frames
DEBUG 2012-08-21 01:09:26.797 [Thread-157] 100.0% complete
INFO  2012-08-21 01:09:26.810 [StartPlaying Event] renderer: 192.168.3.3, file: D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv
INFO  2012-08-21 01:09:27.223 [StopPlaying Event] renderer: 192.168.3.3, file: D:\TV Shows\TrueBloodMkvs\True.Blood.S05E11.720p.HDTV.x264-EVOLVE.mkv
DEBUG 2012-08-21 01:09:27.255 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:27.437 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:27.655 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:27.915 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:28.118 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:28.328 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:28.501 [Buffered IO End Checker] Stopping process: ffmpeg.exe-28
DEBUG 2012-08-21 01:09:28.548 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:29.161 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:29.669 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:31.213 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:32.216 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:33.716 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:34.720 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:35.726 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:36.232 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:37.241 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:38.244 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:39.250 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:40.257 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:41.763 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:43.768 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:45.269 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:46.771 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:47.274 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:48.776 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:49.279 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:50.282 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:51.285 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:52.292 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:53.298 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:54.799 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:56.300 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:57.306 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:57.815 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:09:59.317 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:00.320 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:01.322 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:02.324 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:03.826 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:04.827 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:06.328 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:07.334 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:08.339 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:09.346 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:10.848 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:11.850 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:12.856 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:13.860 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:15.363 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:16.191 [Request Handler] Setting margin to 2Mb
DEBUG 2012-08-21 01:10:16.370 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:18.533 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:19.536 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:20.539 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:21.551 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:22.558 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:23.564 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:24.565 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:25.571 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:27.073 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:28.574 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:29.075 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:29.580 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:30.087 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:30.605 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:31.630 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:32.637 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:33.641 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:34.647 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:36.647 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:39.148 [Thread-157] 100.0% complete
DEBUG 2012-08-21 01:10:42.416 [Buffered IO End Checker] Stopping process: tsMuxeR.exe-31
DEBUG 2012-08-21 01:10:42.416 [Thread-134] Error :null
DEBUG 2012-08-21 01:10:42.416 [Thread-146] Error: null
DEBUG 2012-08-21 01:10:42.416 [Thread-135] Error: null
DEBUG 2012-08-21 01:10:42.416 [Buffered IO End Checker] Stopping process: mencoder.exe-29
DEBUG 2012-08-21 01:10:42.417 [Thread-143] Error: null
DEBUG 2012-08-21 01:10:42.417 [Buffered IO End Checker] Stopping process: mencoder.exe-30
DEBUG 2012-08-21 01:10:42.422 [Thread-136] Disconnected pipe: \\.\pipe\1345536565868videoout
DEBUG 2012-08-21 01:10:42.423 [Thread-144] Disconnected pipe: \\.\pipe\1345536566001audioout
DEBUG 2012-08-21 01:10:42.427 [Thread-142] Error :null
INFO  2012-08-21 01:10:43.917 [StopPlaying Event] renderer: 192.168.3.3, file: D:\TV Shows\TrueBloodMkvs\True.Blood.S05E10.720p.HDTV.x264-EVOLVE.mkv
DEBUG 2012-08-21 01:11:18.174 [UPNP-AliveMessageSender] Error while sending periodic alive message: sleep interrupted
INFO  2012-08-21 01:11:18.173 [PMS Listeners Stopper] Sending BYEBYE...
Last edited by chocolateboy on Tue Aug 21, 2012 2:15 pm, edited 1 time in total.
Reason: reformatted: please read the FAQ: http://tinyurl.com/4294qo2
User avatar
knicknak
 
Posts: 67
Joined: Wed Apr 15, 2009 1:52 am

Re: 1.6 seems to have issues muxing

Postby yodada69 » Wed Aug 22, 2012 9:13 am

I had that exact problem last night. Was trying to watch a episode of Game Of Thrones and the start was fine, the intro music messed up and then no sound at all :?

Had no idea why... but I am sure this is the issue...

Strangely enough I then chose to watch an episode of Homeland and that worked without any problems...

Game.. was with added Danish Subtitles

Homeland, no subtitles...

Could that help in figuring out whats wrong

Guess I have to find an old version of PS3 Media Server ;)
yodada69
 
Posts: 1
Joined: Wed Aug 22, 2012 9:08 am

Re: 1.6 seems to have issues muxing

Postby knicknak » Thu Mar 07, 2013 8:37 am

Evidently UMS does not have this issue. I just tried the same True Blood episode and it had no problems.
User avatar
knicknak
 
Posts: 67
Joined: Wed Apr 15, 2009 1:52 am


Return to General Help and Support

Who is online

Users browsing this forum: No registered users and 7 guests