FIXED playback issue / version 1.71 (EDIT: DLNA 7531 Error)

[phu5ion]

I just upgraded to version 1.71, and when I try to watch an mp4, after 2-3 minutes the audio starts cutting out for 5 seconds followed by the video while it's waiting for the audio to "catch up". I'm running Xubuntu 12.04 LTS with openjdk-6-jre. I've also noticed that ps3mediaserver is using an entire core's worth of CPU time even when I'm not streaming. I've tried both the ffmpeg and mplayer video encoders and have encountered the same behavior.

I don't know if this is related because I've seen this before in my log, but I'm getting the following exception in my debug file. No other errors are sticking out in the trace.

Code: Select all

INFO  2012-11-12 20:40:26.234 [AWT-EventQueue-0] Exception in thread "AWT-EventQueue-0" java.lang.UnsupportedOperationException: Desktop API is not supported on the current platform
INFO  2012-11-12 20:40:26.235 [AWT-EventQueue-0]    at java.awt.Desktop.getDesktop(Desktop.java:144)
INFO  2012-11-12 20:40:26.236 [AWT-EventQueue-0]    at net.pms.newgui.TracesTab$3.mouseClicked(TracesTab.java:147)
INFO  2012-11-12 20:40:26.238 [AWT-EventQueue-0]    at java.awt.AWTEventMulticaster.mouseClicked(AWTEventMulticaster.java:270)
INFO  2012-11-12 20:40:26.244 [AWT-EventQueue-0]    at java.awt.Component.processMouseEvent(Component.java:6392)
INFO  2012-11-12 20:40:26.245 [AWT-EventQueue-0]    at javax.swing.JComponent.processMouseEvent(JComponent.java:3268)
INFO  2012-11-12 20:40:26.248 [AWT-EventQueue-0]    at java.awt.Component.processEvent(Component.java:6154)
INFO  2012-11-12 20:40:26.249 [AWT-EventQueue-0]    at java.awt.Container.processEvent(Container.java:2045)
INFO  2012-11-12 20:40:26.253 [AWT-EventQueue-0]    at java.awt.Component.dispatchEventImpl(Component.java:4750)
INFO  2012-11-12 20:40:26.253 [AWT-EventQueue-0]    at java.awt.Container.dispatchEventImpl(Container.java:2103)
INFO  2012-11-12 20:40:26.253 [AWT-EventQueue-0]    at java.awt.Component.dispatchEvent(Component.java:4576)
INFO  2012-11-12 20:40:26.253 [AWT-EventQueue-0]    at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4633)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.LightweightDispatcher.processMouseEvent(Container.java:4306)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.LightweightDispatcher.dispatchEvent(Container.java:4227)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.Container.dispatchEventImpl(Container.java:2089)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.Window.dispatchEventImpl(Window.java:2518)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.Component.dispatchEvent(Component.java:4576)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.EventQueue.dispatchEventImpl(EventQueue.java:672)
INFO  2012-11-12 20:40:26.254 [AWT-EventQueue-0]    at java.awt.EventQueue.access$400(EventQueue.java:96)
INFO  2012-11-12 20:40:26.255 [AWT-EventQueue-0]    at java.awt.EventQueue$2.run(EventQueue.java:631)
INFO  2012-11-12 20:40:26.255 [AWT-EventQueue-0]    at java.awt.EventQueue$2.run(EventQueue.java:629)
INFO  2012-11-12 20:40:26.255 [AWT-EventQueue-0]    at java.security.AccessController.doPrivileged(Native Method)
INFO  2012-11-12 20:40:26.261 [AWT-EventQueue-0]    at java.security.AccessControlContext$1.doIntersectionPrivilege(AccessControlContext.java:105)
INFO  2012-11-12 20:40:26.261 [AWT-EventQueue-0]    at java.security.AccessControlContext$1.doIntersectionPrivilege(AccessControlContext.java:116)
INFO  2012-11-12 20:40:26.261 [AWT-EventQueue-0]    at java.awt.EventQueue$3.run(EventQueue.java:645)
INFO  2012-11-12 20:40:26.261 [AWT-EventQueue-0]    at java.awt.EventQueue$3.run(EventQueue.java:643)
INFO  2012-11-12 20:40:26.261 [AWT-EventQueue-0]    at java.security.AccessController.doPrivileged(Native Method)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.security.AccessControlContext$1.doIntersectionPrivilege(AccessControlContext.java:105)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventQueue.dispatchEvent(EventQueue.java:642)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.pumpOneEventForFilters(EventDispatchThread.java:275)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.pumpEventsForFilter(EventDispatchThread.java:200)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:190)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:185)
INFO  2012-11-12 20:40:26.262 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:177)
INFO  2012-11-12 20:40:26.263 [AWT-EventQueue-0]    at java.awt.EventDispatchThread.run(EventDispatchThread.java:138)


Any suggestions would be appreciated. Thanks.

[chocolateboy]

I'm getting the following exception in my debug file.

Thanks. Fixed. As the error message suggests, the debug.log button in the Traces tab doesn't work on your platform.

[phu5ion]

No problem.

Any thoughts on my issue with playback? Is there any other information which I can provide to help troubleshoot?

EDIT: some more info, I was able to play a video without issue on my tv, so I'm wondering if it could be something with the PS3's seek feature. Also, once I finished watching, I started getting "badly parsed" info messages in trace, and it's eating CPU cycles again. It repeats this same series of messages over and over again every few seconds. And the I/O server worker part, it seems like it's running at most 6 different workers. Short of unsharing the folder, I'm at a bit of a loss.

Code: Select all

INFO  2012-11-13 20:03:30.434 [New I/O server worker #1-4] The file /home/phu5ion/Pictures/wallpapers/Autodromo Nazionale Monza_1.jpg was badly parsed. It will be hidden
INFO  2012-11-13 20:03:30.435 [New I/O server worker #1-4] The file /home/phu5ion/Pictures/wallpapers/Eiger Nordwand Short Track.jpg was badly parsed. It will be hidden
INFO  2012-11-13 20:03:30.437 [New I/O server worker #1-4] The file /home/phu5ion/Pictures/wallpapers/Grand Valley East.jpg was badly parsed. It will be hidden
INFO  2012-11-13 20:03:30.438 [New I/O server worker #1-4] The file /home/phu5ion/Pictures/wallpapers/Grand Valley East_1.jpg was badly parsed. It will be hidden
INFO  2012-11-13 20:03:30.439 [New I/O server worker #1-4] The file /home/phu5ion/Pictures/wallpapers/mazda-rx8-111920.jpg was badly parsed. It will be hidden

[happy.neko]

I had several 100% CPU (one core) deadlocks too with pre 1.71.0 ps3ms versions. Killing java process and restarting ps3ms helps.
This is not related to JRE version, this is definitely ps3ms bug.

[phu5ion]

So I think I've figured out what when wrong. I was only having problems with my PS3, when I was using my LG TV I was able to play media perfectly. I also started seeing a DLNA error code 7531. I did a web search and found someone that fixed it by navigating on their PS3 to "Settings" => "Network Settings" => "Media Server Connection" and then disabling it and re-enabling it. Seems like this clears out some internal PS3 data and refreshes the connection to PMS.

My PS3 is no longer causing my PC to run wild with CPU usage.