PMS disappears from PS3/vice versa

[Raptor399]

I've used PMS for years without a single problem until today. It was working this morning even. This afternoon I did a normal reboot of my PC, and since then PMS will not show up on my PS3, and on the PC PMS can't detect the PS3 as a media renderer. After a few minutes it recognizes WMP, but not the PS3. I've tried every fix I can find in the FAQ with zero luck. Maybe someone here will know what is going on?

Code: Select all

INFO  2013-01-04 19:31:20.626 [main] Starting PS3 Media Server 1.72.0
INFO  2013-01-04 19:31:20.626 [main] by shagrath / 2008-2012
INFO  2013-01-04 19:31:20.642 [main] http://ps3mediaserver.org
INFO  2013-01-04 19:31:20.642 [main] https://github.com/ps3mediaserver/ps3mediaserver
INFO  2013-01-04 19:31:20.642 [main]
INFO  2013-01-04 19:31:20.642 [main] Build: d9fd0a44c (2012-11-18)
INFO  2013-01-04 19:31:20.642 [main] Java: 1.7.0_10-Oracle Corporation
INFO  2013-01-04 19:31:20.642 [main] OS: Windows 7 x86 6.1
INFO  2013-01-04 19:31:20.642 [main] Encoding: UTF-8
INFO  2013-01-04 19:31:20.642 [main] Memory: 742 MB
INFO  2013-01-04 19:31:20.642 [main]
INFO  2013-01-04 19:31:20.642 [main] Working directory: C:\Program Files (x86)\PS3 Media Server
INFO  2013-01-04 19:31:20.658 [main] Temp directory: C:\Users\Jay\AppData\Local\Temp\ps3mediaserver
INFO  2013-01-04 19:31:20.658 [main] Logging config file: C:\Program Files (x86)\PS3 Media Server\logback.xml
INFO  2013-01-04 19:31:20.658 [main] debug.log: C:\Program Files (x86)\PS3 Media Server\debug.log
INFO  2013-01-04 19:31:20.658 [main]
INFO  2013-01-04 19:31:20.658 [main] Profile directory: C:\ProgramData\PMS
INFO  2013-01-04 19:31:20.658 [main] Profile path: C:\ProgramData\PMS\PMS.conf
INFO  2013-01-04 19:31:20.658 [main] Profile permissions: rw
INFO  2013-01-04 19:31:20.658 [main] Profile name: Jay-PC
INFO  2013-01-04 19:31:20.658 [main]
INFO  2013-01-04 19:31:20.658 [main] Loading MediaInfo library
INFO  2013-01-04 19:31:20.782 [main] Loaded MediaInfoLib - v0.7.60
INFO  2013-01-04 19:31:20.798 [main] Loading renderer configurations from C:\Program Files (x86)\PS3 Media Server\renderers
INFO  2013-01-04 19:31:20.798 [main] Loading configuration file: AirPlayer.conf
INFO  2013-01-04 19:31:20.798 [main] Loading configuration file: Android.conf
INFO  2013-01-04 19:31:20.798 [main] Loading configuration file: Bravia4500.conf
INFO  2013-01-04 19:31:20.798 [main] Loading configuration file: Bravia5500.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: BraviaEX.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: DirecTVHR.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: DLinkDSM510.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: FreeboxHD.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: FreecomMusicPal.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: iPad-iPhone.conf
INFO  2013-01-04 19:31:20.814 [main] Loading configuration file: Kuro.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: LGST600.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: N900.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: OPPOBDP83.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: OPPOBDP93.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: Panasonic.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: Philips.conf
INFO  2013-01-04 19:31:20.829 [main] Loading configuration file: PhilipsPFL.conf
INFO  2013-01-04 19:31:20.845 [main] Loading configuration file: PopcornHour.conf
INFO  2013-01-04 19:31:20.845 [main] Loading configuration file: PS3.conf
INFO  2013-01-04 19:31:20.845 [main] Loading configuration file: Realtek.conf
INFO  2013-01-04 19:31:20.845 [main] Loading configuration file: Samsung-SMT-G7400.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: SamsungAllShare.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: SamsungWiseLink.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: Showtime3.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: SMP-N100.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: SonyBluray.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: Streamium.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: WDTVLive.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: WMP.conf
INFO  2013-01-04 19:31:20.860 [main] Loading configuration file: XBMC.conf
INFO  2013-01-04 19:31:20.876 [main] Loading configuration file: XBOX360.conf
INFO  2013-01-04 19:31:20.876 [main] Loading configuration file: YamahaRXA1010.conf
INFO  2013-01-04 19:31:20.876 [main] Loading configuration file: YamahaRXV671.conf
INFO  2013-01-04 19:31:20.876 [main] Checking MPlayer font cache. It can take a minute or so.
DEBUG 2013-01-04 19:31:20.876 [main] launching: win32/mplayer.exe
DEBUG 2013-01-04 19:31:21.036 [main] launching: win32/mplayer.exe
INFO  2013-01-04 19:31:21.177 [main] Done!
INFO  2013-01-04 19:31:21.177 [main] Found AviSynth plugins dir: C:\Program Files (x86)\AviSynth 2.5\plugins
INFO  2013-01-04 19:31:21.177 [main] VSFilter.dll is not in the AviSynth plugins directory. This can cause problems when trying to play subtitled videos with AviSynth
INFO  2013-01-04 19:31:21.177 [main] Found VideoLAN version 1.0.5 at: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2013-01-04 19:31:21.177 [main] Searching for plugins in C:\Program Files (x86)\PS3 Media Server\plugins
INFO  2013-01-04 19:31:21.177 [main] No plugins found
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: AviSynth/FFmpeg
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: FFmpeg Audio
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: MEncoder
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: AviSynth/MEncoder
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: FFmpeg
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: MPlayer Audio
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: FFmpeg Web Video
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: MEncoder Web
INFO  2013-01-04 19:31:21.193 [main] Registering transcoding engine: MPlayer Video Dump
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: MPlayer Web
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: tsMuxeR
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: Audio High Fidelity
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: VLC Audio Streaming
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2013-01-04 19:31:21.209 [main] Found VLC version 1.0.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: VLC Video Streaming
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: FFmpeg DVR-MS Remux
INFO  2013-01-04 19:31:21.209 [main] Registering transcoding engine: dcraw Thumbnailer
INFO  2013-01-04 19:31:21.287 [main] Using address /192.168.0.13 found on network interface: name:eth3 (Realtek PCIe GBE Family Controller)
INFO  2013-01-04 19:31:21.287 [main] Created socket: /192.168.0.13:5001
INFO  2013-01-04 19:31:21.427 [main] Checking shared folder: C:\Users\Jay\Videos
INFO  2013-01-04 19:31:21.427 [main] Checking shared folder: C:\Users\Jay\Pictures
DEBUG 2013-01-04 19:31:21.474 [main] Sending ALIVE...
INFO  2013-01-04 19:31:21.521 [main] Using the following UUID configured in PMS.conf: bd34c7ee-9190-4e9f-bf4d-dc61de908217
INFO  2013-01-04 19:31:26.317 [main] The server should now appear on your renderer
DEBUG 2013-01-04 19:31:36.332 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2013-01-04 19:31:59.767 [UPNP-AliveMessageSender] Sending ALIVE...
INFO  2013-01-04 19:34:16.303 [UPNPHelper] No IP filter specified, access granted to /192.168.0.13
INFO  2013-01-04 19:34:16.397 [pool-7-thread-1] Checking IP: 192.168.0.13 for WMP
INFO  2013-01-04 19:34:16.631 [pool-7-thread-1] Renderer WMP found on this address: 192.168.0.13
DEBUG 2013-01-04 19:34:16.646 [pool-7-thread-1] Starting ping -n 3 -l 64000 192.168.0.13
DEBUG 2013-01-04 19:34:18.674 [SpeedStats Failsafe] Stopping process: ping-0
DEBUG 2013-01-04 19:34:18.674 [pool-7-thread-1] Could not parse time from "64000 time<1"
DEBUG 2013-01-04 19:34:18.674 [pool-7-thread-1] Could not parse time from "64000 time<1"
DEBUG 2013-01-04 19:35:05.755 [UPNP-AliveMessageSender] Sending ALIVE...


[DrakeFS]

Ive seen this happen when I somehow have to instances of PMS running.

[Raptor399]

There are a lot of reports of the PS3 not showing up lately.
I have noticed the exact same thing happening on my development environment, so I added the following line to "logback.xml":

Code: Select all

<logger name="net.pms.network.UPNPHelper" level="ALL" />

What I noticed was that there was no network traffic from the PS3 *at all*.

I have other UPnP devices and they all seemed to be communicating with PMS just fine.
They also responded to the PMS broadcasts.

But not the PS3!
It never showed in the log. The PS3 did have a proper internet connection at the time and was signed in on PSN. I tried "Find media servers" on the PS3 and I also waited for PMS broadcasts, to no result.

The PMS <--> PS3 connection had worked fine earlier that day, and it worked fine later that day.

In short: I cannot explain why the PS3 did not communicate with PMS.
But I do know PMS was listening and sending broadcasts just fine; the PS3 just didn't send anything!

[Raptor399]

A little followup on this:

Looks like PMS isn't the only software package having this problem. It appears network routers or switches can filter out the PS3's SSDP search packets, so they never reach the computer where PMS runs. That explains the missing M-SEARCH messages in the trace log.

I never had these problems until I changed the router and started using my PS3 wireless, I may rewire it again and see if that helps.

Funny thing: often when I fire up the AirPlayer app on the iPad it does appear on PMS (via a similar wireless connection) and a second later the PS3 also appears...