mencoder crashing...

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.

mencoder crashing...

Postby rotatorkuf » Sat Feb 14, 2009 9:09 pm

computer: amd athlon x2 2.2 ghz, 2gb ram, vista sp1
connection: ethernet 100mbit
problem: when trying to play videos with avisynth/mencoder/ffmpeg, or just mencoder...the program crashes

log file:
Code: Select all
[Timer-6] DEBUG 13:50:07.331 Buffered Space: 60512256 bytes
[Timer-6] DEBUG 13:50:08.331 Buffered Space: 60090368 bytes
[Timer-6] DEBUG 13:50:09.331 Buffered Space: 60739584 bytes
[Timer-6] DEBUG 13:50:10.331 Buffered Space: 64292864 bytes
[Thread-112] DEBUG 13:50:11.046 Sending stream with premature end : 36732928 bytes of get/0$1$3$9$6/monk.s07e15.720p.mkv. Reason: An existing connection was forcibly closed by the remote host
[Thread-112] DEBUG 13:50:11.046 Ready to Stop: true
[Thread-112] DEBUG 13:50:11.047 Sending stream: 36732928 bytes of get/0$1$3$9$6/monk.s07e15.720p.mkv
[Thread-112] DEBUG 13:50:11.047 Close Connection
[Thread-115] DEBUG 13:50:11.061 Opened handler on socket Socket[addr=/192.168.1.100,port=63175,localport=5001]
[Thread-115] DEBUG 13:50:11.061 Received on socket: GET /get/0$1$3$9$6/monk.s07e15.720p.mkv HTTP/1.1
[Thread-115] DEBUG 13:50:11.061 Received on socket: Host: 192.168.1.103:5001
[Thread-115] DEBUG 13:50:11.061 Received on socket: User-Agent: PLAYSTATION 3
[Thread-115] DEBUG 13:50:11.076 Received on socket: Connection: Keep-Alive
[Thread-115] DEBUG 13:50:11.076 Received on socket: Accept-Encoding: identity
[Thread-115] DEBUG 13:50:11.076 Received on socket: TimeSeekRange.dlna.org: npt=182.000-
[Thread-115] DEBUG 13:50:11.076 Received on socket: transferMode.dlna.org: Streaming
[Thread-115] INFO  13:50:11.076 HTTP: get/0$1$3$9$6/monk.s07e15.720p.mkv / 0-0
[Thread-115] DEBUG 13:50:11.076 Wrote on socket: HTTP/1.1 200 OK
[Thread-115] DEBUG 13:50:11.076 Searching for objectId: 0$1$3$9$6 with children option: false
[Thread-115] DEBUG 13:50:11.076 Asked stream chunk [0-0] timeseek: 182.0 of monk.s07e15.720p.mkv and player MEncoder
[Thread-115] INFO  13:50:11.076 Requesting Time Seeking: 182.0 seconds
[Thread-115] INFO  13:50:11.076 Stopping process: win32/mencoder_mt.exe
[Thread-100] DEBUG 13:50:11.080 EOF
[Thread-100] INFO  13:50:11.081 Disconnected pipe
[win32/mencoder_mt.exe] DEBUG 13:50:11.087 EOF
[Thread-115] INFO  13:50:11.087 Creating pipe \\.\pipe\mencoder1234641011087
[Timer-6] DEBUG 13:50:11.537 Buffered Space: 102074368 bytes
[Timer-7] DEBUG 13:50:11.565 Buffered Space: 0 bytes
[Thread-116] INFO  13:50:11.565 Waiting for pipe connection \\.\pipe\mencoder1234641011087
[win32/mencoder_mt.exe] INFO  13:50:11.615 Starting C:\Program Files\PS3 Media Server\win32\mencoder_mt.exe -ss 182.0 -quiet D:\TV\MonkS7\monk.s07e15.720p.mkv -quiet -quiet -oac copy -of mpeg -mpegopts format=mpeg2:muxrate=500000:vbuf_size=1194:abuf_size=64 -ovc lavc -channels 6 -lavdopts debug=0:threads=2 -lavcopts autoaspect=1:vcodec=mpeg2video:acodec=ac3:abitrate=448:threads=2:keyint=1:vqscale=1:vqmin=1 -alang fre,jpn,ger,eng -subdelay 20000 -quiet -quiet -quiet -quiet -ofps 24000/1001 -quiet -quiet -lavdopts fast -mc 0 -noskip -af lavcresample=48000 -srate 48000 -o \\.\pipe\mencoder1234641011087
[win32/mencoder_mt.exe] INFO  13:50:11.623 Reading pipe: \\.\pipe\mencoder1234641011087
[win32/mencoder_mt.exe] INFO  13:50:11.623 Attaching thread: win32/mencoder_mt.exe
[Thread-119] DEBUG 13:50:11.637 MEncoder MT-SVN-r28311-Build-from-Sherpya-4.2.4 (C) 2000-2009 MPlayer Team
[Thread-119] DEBUG 13:50:11.637 CPU: AMD Athlon(tm) 64 X2 Dual Core Processor 4200+ (Family: 15, Model: 107, Stepping: 2)
[Thread-118] DEBUG 13:50:11.637 3DNow supported but disabled
[Thread-118] DEBUG 13:50:11.637 3DNowExt supported but disabled
[Thread-119] DEBUG 13:50:11.637 CPUflags: Type: 15 MMX: 1 MMX2: 1 3DNow: 0 3DNow2: 0 SSE: 1 SSE2: 1
[Thread-119] DEBUG 13:50:11.637 Compiled for x86 CPU with extensions: MMX MMX2 3DNow 3DNowEx SSE SSE2
[Thread-119] DEBUG 13:50:11.645 success: format: 0  data: 0x0 - 0x45ec14dd
[Thread-119] DEBUG 13:50:11.646 [mkv] Track ID 1: audio (A_AC3), -aid 0, -alang und
[Thread-119] DEBUG 13:50:11.646 [mkv] Track ID 2: video (V_MPEG4/ISO/AVC), -vid 0
[Thread-119] DEBUG 13:50:11.646 [mkv] Will play video track 2.
[Thread-119] DEBUG 13:50:11.646 Matroska file format detected.
[Thread-119] DEBUG 13:50:11.646 VIDEO:  [avc1]  1280x720  24bpp  23.976 fps    0.0 kbps ( 0.0 kbyte/s)
[Thread-119] DEBUG 13:50:11.646 [V] filefmt:31  fourcc:0x31637661  size:1280x720  fps:23.976  ftime:=0.0417
[Thread-119] DEBUG 13:50:11.646 ==========================================================================
[Thread-119] DEBUG 13:50:11.647 Opening audio decoder: [liba52] AC3 decoding with liba52
[Thread-119] DEBUG 13:50:11.647 AUDIO: 48000 Hz, 6 ch, s16le, 384.0 kbit/8.33% (ratio: 48000->576000)
[Thread-119] DEBUG 13:50:11.647 Selected audio codec: [a52] afm: liba52 (AC3-liba52)
[Thread-119] DEBUG 13:50:11.647 ==========================================================================
[Thread-116] INFO  13:50:11.647 Result of \\.\pipe\mencoder1234641011087 : true
[Thread-119] DEBUG 13:50:11.648 PACKET SIZE: 2048 bytes, deltascr: 884
[Thread-119] DEBUG 13:50:11.648 Opening video filter: [expand osd=1]
[Thread-119] DEBUG 13:50:11.648 Expand: -1 x -1, -1 ; -1, osd: 1, aspect: 0.000000, round: 4543336
[Thread-119] DEBUG 13:50:11.648 ==========================================================================
[Thread-119] DEBUG 13:50:11.649 Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
[Thread-119] DEBUG 13:50:11.649 Selected video codec: [ffh264] vfm: ffmpeg (FFmpeg H.264)
[Thread-119] DEBUG 13:50:11.649 ==========================================================================
[Thread-119] DEBUG 13:50:11.650 audiocodec: framecopy (format=2000 chans=6 rate=48000 bits=16 B/s=48000 sample-1)
[Thread-118] DEBUG 13:50:11.664 Using SSE optimized IMDCT transform
[Thread-118] DEBUG 13:50:11.664 Using MMX optimized resampler
[Thread-118] DEBUG 13:50:11.664 Limiting audio preload to 0.4s.
[Thread-118] DEBUG 13:50:11.664 Increasing audio density to 4.
[Thread-114] INFO  13:50:11.760 Destroying buffer
[Thread-119] DEBUG 13:50:11.981 VDec: vo config request - 1280 x 720 (preferred colorspace: Planar YV12)
[Thread-113] INFO  13:50:11.981 Destroying buffer
[Thread-119] DEBUG 13:50:11.981 VDec: using Planar YV12 as output csp (no 0)
[Thread-119] DEBUG 13:50:12.118 Movie-Aspect is 1.78:1 - prescaling to correct movie aspect.
[Thread-119] DEBUG 13:50:12.118 videocodec: libavcodec (1280x720 fourcc=3267706d [mpg2])
[Thread-119] DEBUG 13:50:12.118 [VE_LAVC] Using constant qscale = 1.000000 (VBR).
[Thread-119] DEBUG 13:50:12.118 Writing header...
[Thread-115] DEBUG 13:50:12.465 Wrote on socket: Content-Type: video/mpeg
[Thread-115] DEBUG 13:50:12.465 Wrote on socket: Connection: keep-alive
[Thread-115] DEBUG 13:50:12.465 Wrote on socket: Server: Windows Vista-x86-6.0 UPnP/1.0, PMS
[Thread-115] DEBUG 13:50:12.465 Wrote on socket:
[Thread-115] DEBUG 13:50:12.465 Suspend Read: readCount=0 / writeCount=786432
[Timer-7] DEBUG 13:50:12.565 Buffered Space: 1015808 bytes
[Thread-115] DEBUG 13:50:12.965 Resume Read: readCount=0 / writeCount=2347008
[Thread-115] DEBUG 13:50:13.121 Suspend Read: readCount=1638400 / writeCount=2613248
[Timer-7] DEBUG 13:50:13.565 Buffered Space: 2723840 bytes
[Thread-115] DEBUG 13:50:13.621 Resume Read: readCount=1638400 / writeCount=5246976
[Timer-7] DEBUG 13:50:14.570 Buffered Space: 2101248 bytes
[Timer-7] DEBUG 13:50:15.566 Buffered Space: 4716544 bytes
[Timer-7] DEBUG 13:50:16.565 Buffered Space: 3520512 bytes
[Timer-7] DEBUG 13:50:17.565 Buffered Space: 3622912 bytes
[Timer-7] DEBUG 13:50:18.565 Buffered Space: 7098368 bytes
[Timer-7] DEBUG 13:50:19.566 Buffered Space: 11075584 bytes
[Timer-7] DEBUG 13:50:20.565 Buffered Space: 14854144 bytes
[Thread-116] DEBUG 13:50:20.867 freeMemory: 143836704
[Thread-116] DEBUG 13:50:20.868 totalMemory: 201125888
[Thread-116] DEBUG 13:50:20.868 maxMemory: 799145984
[Thread-116] DEBUG 13:50:20.868 Extending buffer to 419430400
[Thread-116] TRACE 13:50:21.148 FATAL ERROR: OutOfMemory / dumping stats
[Thread-116] DEBUG 13:50:21.149 freeMemory: 147282232
[Thread-116] DEBUG 13:50:21.149 totalMemory: 201125888
[Thread-116] DEBUG 13:50:21.149 maxMemory: 799145984
[Thread-16] INFO  13:50:21.152 Sending BYEBYE...
[Thread-16] DEBUG 13:50:21.153 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.218 Sending message from multicast socket on network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.218 Multicast socket is on interface: /192.168.1.103
[Thread-16] DEBUG 13:50:21.218 Socket Timeout: 0
[Thread-16] DEBUG 13:50:21.218 Socket TTL: 32
[Thread-16] DEBUG 13:50:21.218 Sending this SSDP packet: NOTIFY * HTTP/1.1<CRLF>HOST: 239.255.255.250:1900<CRLF>NT: upnp:rootdevice<CRLF>NTS: ssdp:byebye<CRLF>USN: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::upnp:rootdevice<CRLF><CRLF>
[Thread-23] DEBUG 13:50:21.221 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-23] DEBUG 13:50:21.249 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.279 Sending this SSDP packet: NOTIFY * HTTP/1.1<CRLF>HOST: 239.255.255.250:1900<CRLF>NT: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::<CRLF>NTS: ssdp:byebye<CRLF>USN: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::<CRLF><CRLF>
[Thread-23] DEBUG 13:50:21.279 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-23] DEBUG 13:50:21.309 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.339 Sending this SSDP packet: NOTIFY * HTTP/1.1<CRLF>HOST: 239.255.255.250:1900<CRLF>NT: urn:schemas-upnp-org:device:MediaServer:1<CRLF>NTS: ssdp:byebye<CRLF>USN: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::urn:schemas-upnp-org:device:MediaServer:1<CRLF><CRLF>
[Thread-23] DEBUG 13:50:21.339 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-23] DEBUG 13:50:21.369 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.399 Sending this SSDP packet: NOTIFY * HTTP/1.1<CRLF>HOST: 239.255.255.250:1900<CRLF>NT: urn:schemas-upnp-org:service:ContentDirectory:1<CRLF>NTS: ssdp:byebye<CRLF>USN: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::urn:schemas-upnp-org:service:ContentDirectory:1<CRLF><CRLF>
[Thread-23] DEBUG 13:50:21.400 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-23] DEBUG 13:50:21.429 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] DEBUG 13:50:21.459 Sending this SSDP packet: NOTIFY * HTTP/1.1<CRLF>HOST: 239.255.255.250:1900<CRLF>CACHE-CONTROL: max-age=1800<CRLF>LOCATION: http://192.168.1.103:5001/description/fetch<CRLF>NT: urn:schemas-upnp-org:service:ConnectionManager:1<CRLF>NTS: ssdp:alive<CRLF>Server: Windows Vista-x86-6.0 UPnP/1.0, PMS<CRLF>USN: uuid:7dba409a-0b8f-31ca-a321-fb2c9aa6f25f::urn:schemas-upnp-org:service:ConnectionManager:1<CRLF><CRLF>
[Thread-23] DEBUG 13:50:21.459 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-23] DEBUG 13:50:21.489 Setting multicast network interface: name:eth2 (NVIDIA nForce Networking Controller) index: 8 addresses:
/192.168.1.103;

[Thread-16] INFO  13:50:21.519 Forcing shutdown of all active processes
[Thread-16] DEBUG 13:50:21.519 Forcing shutdown of process java.lang.ProcessImpl@3e1d25
[Thread-16] INFO  13:50:21.519 Stopping server on host 192.168.1.103 and port 5001...
rotatorkuf
 
Posts: 9
Joined: Mon Jan 19, 2009 9:08 am

Re: mencoder crashing...

Postby shagrath » Sat Feb 14, 2009 11:42 pm

FATAL ERROR: OutOfMemory / dumping stats


make sure you have enough RAM left for your 400Mb transcode buffer to initialize
shagrath
Project Lead
 
Posts: 2667
Joined: Wed Jan 14, 2009 1:39 pm

Re: mencoder crashing...

Postby rotatorkuf » Sat Feb 21, 2009 8:42 pm

i lowered the limit to 200, and same thing

i have about 900mb free when i run the video file on ps3, this appears to only happen when i skip forward a couple of minutes

another question, why does it only happen with mencoder? if the limit buffer seems to be non-dependent on the encoder......tsmuxer works fine
rotatorkuf
 
Posts: 9
Joined: Mon Jan 19, 2009 9:08 am


Return to General Help and Support

Who is online

Users browsing this forum: Bing [Bot] and 20 guests