1.10.5 & svn 358: thumbnails, but no video

For help and support with issues specific to Linux/Unix
Forum rules
Please make sure you follow the Problem Reporting Guidelines before posting if you want a reply.

1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Wed Sep 02, 2009 2:42 am

I've been using pms to stream a bunch of home videos to a ps3. The videos are mp4's encoded for level 4.1. The mp4's will play on the ps3 if burned to disc. Firmware 2.80 on ps3.

Under a main folder, the videos are arranged by year. The main folder is the navigation folder in pms. This used to work beautifully, but the disk with pms died. :(

I've now tried tried both svn 358 (1.20) and 1.10.5. In each case, I find the mediaserver, and the folders. When I enter the year folder, I see a thumbnail of the video. But when I select the video, nothing. No error, just black screen.

Nothing in the trace, except when I select the *trancode* folder (which shouldn't be necessary).

[Thread-21] TRACE 21:03:13.591 Sending ALIVE...
[Thread-224] TRACE 21:05:54.057 Starting transcode/remux of 1984-Xmas-Baltimore.mp4
[Thread-21] TRACE 21:06:18.289 Sending ALIVE...
[Thread-267] TRACE 21:06:19.264 Starting transcode/remux of 1984-Xmas-Baltimore.mp4


How do I debug this?

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Mon Sep 14, 2009 11:58 pm

OK, updated to svn 359 and firmware 3.0. Same result.

I've looked at debug.log. As far as I can tell, pms thinks it's streaming the jpg:

[New I/O server worker #1-3] DEBUG 18:50:35.796 Opened handler on socket /10.10.11.130:56254 // Playstation 3
[New I/O server worker #1-3] DEBUG 18:50:35.796 Handler infos: HTTP/1.1 : GET : get/0$1$2$1/p3210118.jpg
[New I/O server worker #1-3] DEBUG 18:50:35.796 Received on socket: Accept-Encoding: identity
[New I/O server worker #1-3] DEBUG 18:50:35.796 Received on socket: Connection: Keep-Alive
[New I/O server worker #1-3] DEBUG 18:50:35.796 Received on socket: Host: 10.10.11.1:5001
[New I/O server worker #1-3] DEBUG 18:50:35.797 Received on socket: Range: bytes=0-
[New I/O server worker #1-3] DEBUG 18:50:35.797 Received on socket: transferMode.dlna.org: Interactive
[New I/O server worker #1-3] DEBUG 18:50:35.797 Received on socket: User-Agent: PLAYSTATION 3
[New I/O server worker #1-3] INFO 18:50:35.797 HTTP: get/0$1$2$1/p3210118.jpg / 0-100000000000
[New I/O server worker #1-3] DEBUG 18:50:35.797 Searching for objectId: 0$1$2$1 with children option: false
[New I/O server worker #1-3] DEBUG 18:50:35.797 Asked stream chunk [0-100000000000] timeseek: 0.0 of p3210118.jpg and player null
[New I/O server worker #1-3] DEBUG 18:50:35.803 Sent to socket: Accept-Ranges: bytes
[New I/O server worker #1-3] DEBUG 18:50:35.803 Sent to socket: Connection: keep-alive
[New I/O server worker #1-3] DEBUG 18:50:35.803 Sent to socket: Content-Length: 3549460
[New I/O server worker #1-3] DEBUG 18:50:35.803 Sent to socket: Content-Range: bytes 0-3549459/3549460
[New I/O server worker #1-3] DEBUG 18:50:35.804 Sent to socket: Content-Type: image/jpeg
[New I/O server worker #1-3] DEBUG 18:50:35.804 Sent to socket: Server: Linux-amd64-2.6.30.5-43.fc11.x86_64, UPnP/1.0, PMS/1.20
[New I/O server worker #1-3] DEBUG 18:50:35.804 Sent to socket: TransferMode.DLNA.ORG: Interactive
[New I/O server worker #1-3] DEBUG 18:51:06.052 future: isSuccess() = false


But it doesn't show on the ps3.

What does an * mean following the item name: such as p3210118.jpg* or Xmas.mp4* ? All the jpeg's and video's have them.

When I try to stream a video, again pms seems to think it's working. The ps3 goes gray. It's as if the ps3 is receiving gray as the stream and playing it.

Anyone have any clue?

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Tue Sep 15, 2009 12:31 am

Further to this, while the ps3 just shows gray, the Status page of pms shows, at bottom left:

Serving 1984-Xmas.mp4[container: mov][video: h264]

and the transcoder buffer is empty.

As I look at debug.log,I don't see any errors. In fact pms thinks it's streaming the video.

[New I/O server worker #2-4] DEBUG 19:18:38.819 Opened handler on socket /10.10.11.130:56104 // Playstation 3
[New I/O server worker #2-4] DEBUG 19:18:38.819 Handler infos: HTTP/1.1 : GET : get/0$1$0$0/1984-Xmas.mp4
[New I/O server worker #2-4] DEBUG 19:18:38.819 Received on socket: Accept-Encoding: identity
[New I/O server worker #2-4] DEBUG 19:18:38.819 Received on socket: Connection: Keep-Alive
[New I/O server worker #2-4] DEBUG 19:18:38.819 Received on socket: Host: 10.10.11.1:5001
[New I/O server worker #2-4] DEBUG 19:18:38.820 Received on socket: Range: bytes=0-
[New I/O server worker #2-4] DEBUG 19:18:38.820 Received on socket: transferMode.dlna.org: Streaming
[New I/O server worker #2-4] DEBUG 19:18:38.820 Received on socket: User-Agent: PLAYSTATION 3
[New I/O server worker #2-4] INFO 19:18:38.820 HTTP: get/0$1$0$0/1984-Xmas.mp4 / 0-100000000000
[New I/O server worker #2-4] DEBUG 19:18:38.820 Searching for objectId: 0$1$0$0 with children option: false
[New I/O server worker #2-4] DEBUG 19:18:38.820 Asked stream chunk [0-100000000000] timeseek: 0.0 of 1984-Xmas.mp4 and player null
[New I/O server worker #2-4] DEBUG 19:18:38.822 Sent to socket: Accept-Ranges: bytes
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: Connection: keep-alive
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: Content-Length: 243389448
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: Content-Range: bytes 0-243389447/243389448
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: Content-Type: video/mp4
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: Server: Linux-amd64-2.6.30.5-43.fc11.x86_64, UPnP/1.0, PMS/1.20
[New I/O server worker #2-4] DEBUG 19:18:38.823 Sent to socket: TransferMode.DLNA.ORG: Streaming

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby meskibob » Tue Sep 15, 2009 12:52 am

Looks like the PS3 doesn't like your H264 video (especially since it's labeled as an MP4 container but recognized as MOV), as PMS is serving it as is. Have you tried transcoding?

And the "*" is to show that the given media is not on the PS3's local drive (actually it's for media not from a "certified" media server, but I have yet to see any not have the *)
I provide NO application support via PM or email, so please post your question to the forum per the Forum Rules.
meskibob
Moderator
 
Posts: 4784
Joined: Mon Jan 19, 2009 4:11 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Tue Sep 15, 2009 2:25 am

Thanks for the reply.

Yes I've tried transcoding it. Same result. BTW, if I burn the video to a cd, the ps3 will play it.

One of reasons I tried the jpeg's was to test an obvious format a ps3 can play. They also don't show on the ps3.

I think this is the debug log output from making a thumbnail (which does show on the ps3):

[pool-29-thread-1] INFO 19:18:26.418 Starting ffmpeg -ss 1 -i /opt/1500gig/video/family/family_video/1984/1984-Xmas.mp4 -an -an -s 320x180 -vframes 1 -f image2 pipe:
[pool-29-thread-1] INFO 19:18:26.452 Attaching thread: ffmpeg
[Thread-13] DEBUG 19:18:26.453 FFmpeg version SVN-r19828, Copyright (c) 2000-2009 Fabrice Bellard, et al.
[Thread-13] DEBUG 19:18:26.453 configuration: --prefix=/usr --bindir=/usr/bin --datadir=/usr/share/ffmpeg --libdir=/usr/lib64 --mandir=/usr/share/man --shlibdir=/usr/lib64 --extra-cflags='-O3 -march=native -mtune=native -msse4.1 -ftree-vectorize -floop-interchange -floop-strip-mine -floop-block -mfpmath=sse -I/usr/include/openjpeg' --enable-static --enable-shared --enable-gpl --enable-nonfree --enable-postproc --enable-avfilter --enable-avfilter-lavf --enable-pthreads --enable-libdirac --disable-decoder=libdirac --enable-libfaac --enable-libfaad --enable-libfaadbin --enable-libgsm --enable-libmp3lame --enable-libopenjpeg --enable-libschroedinger --disable-encoder=libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-zlib --disable-debug --cpu=core2 --arch=x86_64
[Thread-13] DEBUG 19:18:26.453 libavutil 50. 3. 0 / 50. 3. 0
[Thread-13] DEBUG 19:18:26.454 libavcodec 52.35. 0 / 52.35. 0
[Thread-13] DEBUG 19:18:26.454 libavformat 52.38. 0 / 52.38. 0
[Thread-13] DEBUG 19:18:26.454 libavdevice 52. 2. 0 / 52. 2. 0
[Thread-13] DEBUG 19:18:26.454 libavfilter 0. 5. 0 / 0. 5. 0
[Thread-13] DEBUG 19:18:26.454 libswscale 0. 7. 1 / 0. 7. 1
[Thread-13] DEBUG 19:18:26.454 libpostproc 51. 2. 0 / 51. 2. 0
[Thread-13] DEBUG 19:18:26.454 built on Sep 12 2009 18:00:23, gcc: 4.4.1 20090725 (Red Hat 4.4.1-2)
[Thread-13] DEBUG 19:18:26.571 Seems stream 0 codec frame rate differs from container frame rate: 59.94 (60000/1001) -> 29.97 (30000/1001)
[Thread-13] DEBUG 19:18:26.571 Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/opt/1500gig/video/family/family_video/1984/1984-Xmas.mp4':
[Thread-13] DEBUG 19:18:26.572 Duration: 00:14:36.94, start: 0.000000, bitrate: 2220 kb/s
[Thread-13] DEBUG 19:18:26.572 Stream #0.0(und): Video: h264, yuv420p, 720x480 [PAR 8:9 DAR 4:3], 29.97 tbr, 30k tbn, 59.94 tbc
[Thread-13] DEBUG 19:18:26.572 Stream #0.1(und): Audio: aac, 48000 Hz, 2 channels, s16
[Thread-13] DEBUG 19:18:26.584 Output #0, image2, to 'pipe:':
[Thread-13] DEBUG 19:18:26.584 Stream #0.0(und): Video: mjpeg, yuvj420p, 320x180 [PAR 3:4 DAR 4:3], q=2-31, 200 kb/s, 90k tbn, 29.97 tbc
[Thread-13] DEBUG 19:18:26.584 Stream mapping:
[Thread-13] DEBUG 19:18:26.584 Stream #0.0 -> #0.0
[Thread-13] DEBUG 19:18:26.584 Press [q] to stop encoding
[Thread-13] DEBUG 19:18:26.768 video:6kB audio:0kB global headers:0kB muxing overhead -100.333535%
[pool-29-thread-1] DEBUG 19:18:26.770 EOF
[pool-29-thread-1] DEBUG 19:18:26.786 Ready to Stop: true
[pool-29-thread-1] DEBUG 19:18:26.841 Media info of : /opt/1500gig/video/family/family_video/1984/1984-Xmas.mp4 / mimeType: video/mp4 / container: mov / bitrate: 2273280 / size: 243389448 / codecV: h264 / duration: 00:14:36.940 / width: 720 / height: 480 / frameRate: 29.97 / thumb size : 6710
audio: id=1 / lang: und / codec: aac / sf:48000
[New I/O server worker #2-3] DEBUG 19:18:26.841 End of analysis

Puzzled.

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby meskibob » Tue Sep 15, 2009 2:51 am

And you've updated all your binaries? viewtopic.php?f=3&t=1508
I provide NO application support via PM or email, so please post your question to the forum per the Forum Rules.
meskibob
Moderator
 
Posts: 4784
Joined: Mon Jan 19, 2009 4:11 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Tue Sep 15, 2009 3:06 am

Looking at debug.log, transcode is strange:

[New I/O server worker #1-1] INFO 21:59:09.973 HTTP: get/0$0$11$1$11$5$11$1$7/thumbnail00001985-xmas.mp4 / 0-0
[New I/O server worker #1-1] DEBUG 21:59:10.044 Searching for objectId: 0$0$11$1$11$5$11$1$7 with children option: false
[New I/O server worker #1-1] DEBUG 21:59:10.188 Available Content-Length: 6435
[New I/O server worker #1-1] DEBUG 21:59:10.189 future: wrote the last chunk, remaining6435
[New I/O server worker #1-1] DEBUG 21:59:10.189 Sent to socket: Accept-Ranges: bytes
[New I/O server worker #1-1] DEBUG 21:59:10.189 Sent to socket: Connection: keep-alive
[New I/O server worker #1-1] DEBUG 21:59:10.189 Sent to socket: Content-Length: 6435
[New I/O server worker #1-1] DEBUG 21:59:10.190 Sent to socket: Content-Type: image/jpeg
[New I/O server worker #1-1] DEBUG 21:59:10.190 Sent to socket: Expires: Fri, 08 Jan 2010 19:45:50 GMT
[New I/O server worker #1-1] DEBUG 21:59:10.190 Sent to socket: Server: Linux-amd64-2.6.30.5-43.fc11.x86_64, UPnP/1.0, PMS/1.20
[New I/O server worker #1-1] DEBUG 21:59:10.190 Sent to socket: TransferMode.DLNA.ORG: Interactive
[Thread-72] INFO 21:59:10.403 Destroying buffer
[Thread-40] INFO 21:59:14.914 Stopping process: ffmpeg
[Thread-40] DEBUG 21:59:14.915 Killing the Unix process: 11360
[Thread-41] INFO 21:59:14.915 Stopping process: ffmpeg
[Thread-42] INFO 21:59:14.915 Stopping process: ffmpeg
[Thread-41] DEBUG 21:59:14.915 Killing the Unix process: 11364
[Thread-42] DEBUG 21:59:14.918 Killing the Unix process: 11365
[Thread-40] INFO 21:59:14.935 Destroying buffer
[Thread-90] DEBUG 21:59:14.935 kill 11364: No such process
[Thread-41] INFO 21:59:14.935 Destroying buffer
[Thread-89] DEBUG 21:59:14.935 kill 11360: No such process
[Thread-93] DEBUG 21:59:15.234 kill 11365: No such process
[Thread-54] INFO 21:59:15.378 Stopping process: ffmpeg
[Thread-42] INFO 21:59:15.234 Destroying buffer
[Thread-54] DEBUG 21:59:15.379 Killing the Unix process: 11376
[Thread-59] INFO 21:59:15.595 Stopping process: ffmpeg
[Thread-59] DEBUG 21:59:15.595 Killing the Unix process: 11383
[Thread-63] INFO 21:59:15.595 Stopping process: ffmpeg
[Thread-63] DEBUG 21:59:15.599 Killing the Unix process: 11389
[Thread-54] INFO 21:59:15.607 Destroying buffer

So it streams the thumbnail (which does show up on the ps3 - why won't my jpeg's show?) , but then there all these ffmpeg messages?

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby meskibob » Tue Sep 15, 2009 3:08 am

It's my understanding that FFmepg is used for the initial thumbnail and video analysis and then the subsequent piping to stream the file. I'm guessing it's failing on some of that video analysis. But this would be better left for shagrath to interpret.
I provide NO application support via PM or email, so please post your question to the forum per the Forum Rules.
meskibob
Moderator
 
Posts: 4784
Joined: Mon Jan 19, 2009 4:11 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby shagrath » Tue Sep 15, 2009 12:35 pm

I already seen a few cases of mp4 videos not played through streaming, but perfectly through usb drive... didn't find the cause at the time...
maybe if I could got a sample (but it seems to be a family video :p)
shagrath
Project Lead
 
Posts: 2667
Joined: Wed Jan 14, 2009 1:39 pm

Re: 1.10.5 & svn 358: thumbnails, but no video

Postby seandarcy » Sat Sep 19, 2009 3:46 am

I'd be happy to share those home videos. You might like 3rd grade plays :) . But to make it easier let's focus on jpeg's.

If I go on the PS3 to photos, and go to a folder with jpegs, the thumbnails never come up. The symbol just continues to rotate. You can see the titles of the jpeg's in the folder. I can also use the triangle and request Information on the jpeg. That works.

But if you request a jpeg, nothing happens - in fact usually the ps3 locks up. Even the front on/off switch doesn't work. You have to use the switch on the back.

On the pms status page lower left, it shows "Serving p5300005.jpg".

Here's debug.log:

[New I/O server worker #1-2] DEBUG 22:17:46.795 Opened handler on socket /10.10.11.130:56638 // Playstation 3
[New I/O server worker #1-2] DEBUG 22:17:46.795 Handler infos: HTTP/1.1 : GET : get/0$0$11$1$7$1$8$4/p5300005.jpg
[New I/O server worker #1-2] DEBUG 22:17:46.795 Received on socket: Accept-Encoding: identity
[New I/O server worker #1-2] DEBUG 22:17:46.795 Received on socket: Connection: Keep-Alive
[New I/O server worker #1-2] DEBUG 22:17:46.796 Received on socket: Host: 10.10.11.1:5001
[New I/O server worker #1-2] DEBUG 22:17:46.796 Received on socket: Range: bytes=0-
[New I/O server worker #1-2] DEBUG 22:17:46.796 Received on socket: transferMode.dlna.org: Interactive
[New I/O server worker #1-2] DEBUG 22:17:46.796 Received on socket: User-Agent: PLAYSTATION 3
[New I/O server worker #1-2] INFO 22:17:46.796 HTTP: get/0$0$11$1$7$1$8$4/p5300005.jpg / 0-100000000000
[New I/O server worker #1-2] DEBUG 22:17:46.796 Searching for objectId: 0$0$11$1$7$1$8$4 with children option: false
[New I/O server worker #1-2] DEBUG 22:17:46.796 Asked stream chunk [0-100000000000] timeseek: 0.0 of p5300005.jpg and player null
[New I/O server worker #1-2] DEBUG 22:17:46.821 Sent to socket: Accept-Ranges: bytes
[New I/O server worker #1-2] DEBUG 22:17:46.822 Sent to socket: Connection: keep-alive
[New I/O server worker #1-2] DEBUG 22:17:46.822 Sent to socket: Content-Length: 4400008
[New I/O server worker #1-2] DEBUG 22:17:46.823 Sent to socket: Content-Range: bytes 0-4400007/4400008
[New I/O server worker #1-2] DEBUG 22:17:46.823 Sent to socket: Content-Type: image/jpeg
[New I/O server worker #1-2] DEBUG 22:17:46.823 Sent to socket: Server: Linux-amd64-2.6.30.5-43.fc11.x86_64, UPnP/1.0, PMS/1.20
[New I/O server worker #1-2] DEBUG 22:17:46.823 Sent to socket: TransferMode.DLNA.ORG: Interactive

It looks to me like pms sure thinks it's serving the jpeg. So what's going on?

I've uploaded the full debug.log

sean
seandarcy
 
Posts: 9
Joined: Sun Apr 12, 2009 4:21 pm

Next

Return to Linux/Unix Support

Who is online

Users browsing this forum: No registered users and 3 guests