> I wouldn't take the docker route, yet. What Nas do you have?
> I'm willing to build a cleaned up version of the package.
@pinkdot: Thank you for offering your help. I have a DS416play.
Yesterday I did some more testing about the issue.
I installed an older LMS 7.9.0 - 1453293926 package on the Synology to
see if the issue was introduced with the latest build.
I also installed the latest nightly 7.9.1 - 1512734075 on my MACmini.
After that things did not change. UPnP Mediaserver on MACmini still
always available and on the Synology dissappearing after 30min.
I also found out that not only restarting LMS brings the Mediaserver
back but also unplugging the Ethernet cable on my AV Receiver for a few
seconds seems to trigger an update
of the list of available Media servers.
I don't know enough about UPnP protocol to know if this is related, but
I found the following in the log files after plugging in the Ethernet
cable again:
Code:
--------------------
17-12-11 17:15:46.8001 Slim::Plugin::UPnP::Discovery::_read (194) M-SEARCH
from 192.168.11.131:38583 for upnp:rootdevice (mx: 3)
[17-12-11 17:15:47.2153] Slim::Plugin::UPnP::Discovery::__ANON__ (497)
Replying to 192.168.11.131:38583: "HTTP/1.1 200 OK\r\nCache-Control:
max-age=1800\r\nDate: Mon, 11 Dec 2017 16:15:46 GMT\r\nExt: \r\nLocation:
http://192.168.11.141:9002/plugins/UPnP/MediaRenderer.xml?player=00%3A04%3A20%3A26%3A15%3Aaa\r\nServer:
Linux/x86_64-linux UPnP/1.0 DLNADOC/1.50
LogitechMediaServer/7.9.0/1453293926\r\nST: upnp:rootdevice\r\nUSN:
uuid:ED65BBE1-1982-C86F-89EB-450D777CDA45::upnp:rootdevice\r\n\r\n"
[17-12-11 17:15:47.2274] Slim::Plugin::UPnP::MediaRenderer::description (214)
MediaRenderer.xml for 00:04:20:26:15:aa requested by dLeyna/0.5.0 GUPnP/0.20.13
DLNADOC/1.50
[17-12-11 17:15:47.3015] Slim::Plugin::UPnP::Discovery::_read (194) M-SEARCH
from 192.168.11.131:38583 for upnp:rootdevice (mx: 3)
[17-12-11 17:15:47.5009] Slim::Plugin::UPnP::Discovery::__ANON__ (497)
Replying to 192.168.11.131:38583: "HTTP/1.1 200 OK\r\nCache-Control:
max-age=1800\r\nDate: Mon, 11 Dec 2017 16:15:47 GMT\r\nExt: \r\nLocation:
http://192.168.11.141:9002/plugins/UPnP/MediaRenderer.xml?player=00%3A04%3A20%3A28%3A4e%3A37\r\nServer:
Linux/x86_64-linux UPnP/1.0 DLNADOC/1.50
LogitechMediaServer/7.9.0/1453293926\r\nST: upnp:rootdevice\r\nUSN:
uuid:997EC018-A870-E981-ABCF-A418EFB85C4C::upnp:rootdevice\r\n\r\n"
[17-12-11 17:15:47.5140] Slim::Plugin::UPnP::MediaRenderer::description (214)
MediaRenderer.xml for 00:04:20:28:4e:37 requested by dLeyna/0.5.0 GUPnP/0.20.13
DLNADOC/1.50
[17-12-11 17:15:47.8017] Slim::Plugin::UPnP::Discovery::_read (194) M-SEARCH
from 192.168.11.131:38583 for upnp:rootdevice (mx: 3)
[17-12-11 17:15:48.3055] Slim::Plugin::UPnP::Discovery::__ANON__ (497)
Replying to 192.168.11.131:38583: "HTTP/1.1 200 OK\r\nCache-Control:
max-age=1800\r\nDate: Mon, 11 Dec 2017 16:15:47 GMT\r\nExt: \r\nLocation:
http://192.168.11.141:9002/plugins/UPnP/MediaServer.xml\r\nServer:
Linux/x86_64-linux UPnP/1.0 DLNADOC/1.50
LogitechMediaServer/7.9.0/1453293926\r\nST: upnp:rootdevice\r\nUSN:
uuid:31587DD1-0AAD-4594-9B21-A074D0318BC4::upnp:rootdevice\r\n\r\n"
[17-12-11 17:15:48.3408] Slim::Plugin::UPnP::MediaServer::description (99)
MediaServer.xml requested by dLeyna/0.5.0 GUPnP/0.20.13 DLNADOC/1.50
[17-12-11 17:15:48.3528] Slim::Plugin::UPnP::Discovery::__ANON__ (497)
Replying to 192.168.11.131:38583: "HTTP/1.1 200 OK\r\nCache-Control:
max-age=1800\r\nDate: Mon, 11 Dec 2017 16:15:46 GMT\r\nExt: \r\nLocation:
http://192.168.11.141:9002/plugins/UPnP/MediaServer.xml\r\nServer:
Linux/x86_64-linux UPnP/1.0 DLNADOC/1.50
LogitechMediaServer/7.9.0/1453293926\r\nST: upnp:rootdevice\r\nUSN:
uuid:31587DD1-0AAD-4594-9B21-A074D0318BC4::upnp:rootdevice\r\n\r\n"
[17-12-11 17:15:48.3825] Slim::Plugin::UPnP::SOAPServer::processControl (136)
Invoking
Slim::Plugin::UPnP::MediaServer::ContentDirectory->GetSearchCapabilities( undef
)
[17-12-11 17:15:48.5128] Slim::Plugin::UPnP::SOAPServer::processControl (136)
Invoking
Slim::Plugin::UPnP::MediaServer::ContentDirectory->GetSortCapabilities( undef )
[17-12-11 17:15:48.5397] Slim::Plugin::UPnP::SOAPServer::processControl (99)
SOAPServer: Slim::Plugin::UPnP::MediaServer::ContentDirectory does not
implement GetSortExtensionCapabilities
[17-12-11 17:15:48.5438] Slim::Plugin::UPnP::SOAPServer::fault (227) UPnP
fault: 401 / Invalid Action
[17-12-11 17:15:48.5442] Slim::Plugin::UPnP::SOAPServer::fault (228) Result:
<?xml version="1.0" encoding="UTF-8"?><s:Envelope
xmlns:s="http://schemas.xmlsoap.org/soap/envelope/";
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance";
xmlns:xsd="http://www.w3.org/2001/XMLSchema";
s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/";
xmlns:soapenc="http://schemas.xmlsoap.org/soap/encoding/";><s:Body><s:Fault><faultcode>s:Client</faultcode><faultstring>UPnPError</faultstring><detail><UPnPError><errorCode
xsi:type="xsd:int">401</errorCode><errorDescription
xsi:type="xsd:string">Invalid
Action</errorDescription></UPnPError></detail></s:Fault></s:Body></s:Envelope>
[17-12-11 17:15:48.5563] Slim::Plugin::UPnP::SOAPServer::processControl (99)
SOAPServer: Slim::Plugin::UPnP::MediaServer::ContentDirectory does not
implement GetFeatureList
[17-12-11 17:15:48.5605] Slim::Plugin::UPnP::SOAPServer::fault (227) UPnP
fault: 401 / Invalid Action
[17-12-11 17:15:48.5608] Slim::Plugin::UPnP::SOAPServer::fault (228) Result:
<?xml version="1.0" encoding="UTF-8"?><s:Envelope
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance";
xmlns:xsd="http://www.w3.org/2001/XMLSchema";
s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/";
xmlns:s="http://schemas.xmlsoap.org/soap/envelope/";
xmlns:soapenc="http://schemas.xmlsoap.org/soap/encoding/";><s:Body><s:Fault><faultcode>s:Client</faultcode><faultstring>UPnPError</faultstring><detail><UPnPError><errorCode
xsi:type="xsd:int">401</errorCode><errorDescription
xsi:type="xsd:string">Invalid
Action</errorDescription></UPnPError></detail></s:Fault></s:Body></s:Envelope>
[17-12-11 17:15:48.5706] Slim::Plugin::UPnP::Events::request (92) SUBSCRIBE
/plugins/UPnP/MediaServer/ContentDirectory/eventsub
[17-12-11 17:15:48.5713] Slim::Plugin::UPnP::Events::subscribe (250)
Subscribe: 3D5E38FD-A8F5-4A13-B55E-58FDFE412491
(Slim::Plugin::UPnP::MediaServer::ContentDirectory) (1800 sec) ->
http://192.168.11.131:41218/ServiceProxy11
[17-12-11 17:15:48.5717] Slim::Plugin::UPnP::Events::sendNotify (383)
Delaying notify for 3D5E38FD-A8F5-4A13-B55E-58FDFE412491, not yet active
[17-12-11 17:15:48.5724] Slim::Plugin::UPnP::Events::sendResponse (149) Sub
3D5E38FD-A8F5-4A13-B55E-58FDFE412491 is now active
[17-12-11 17:15:48.7723] Slim::Plugin::UPnP::Events::sendNotify (410)
Notifying to 192.168.11.131:41218 for 0 /
Slim::Plugin::UPnP::MediaServer::ContentDirectory
[17-12-11 17:15:48.7727] Slim::Plugin::UPnP::Events::sendNotify (411) NOTIFY
/ServiceProxy11 HTTP/1.1
Host: 192.168.11.131:41218
Content-Type: text/xml; charset="utf-8"
Content-Length: 167
NT: upnp:event
NTS: upnp:propchange
SID: uuid:3D5E38FD-A8F5-4A13-B55E-58FDFE412491
SEQ: 0
<?xml version="1.0"?>
<e:propertyset xmlns:e="urn:schemas-upnp-org:event-1-0">
<e:property><SystemUpdateID>1512983526</SystemUpdateID></e:property>
</e:propertyset>
--------------------
This looks the same on both devices.
Exactly 30min later on the Synology I get the following messages after
that the Mediaserver disappears from the list.
Code:
--------------------
[17-12-11 17:43:59.7914] Slim::Plugin::UPnP::Events::request (92) SUBSCRIBE
/plugins/UPnP/MediaServer/ContentDirectory/eventsub
[17-12-11 17:43:59.7919] Slim::Plugin::UPnP::Events::subscribe (190) Renewed:
3D5E38FD-A8F5-4A13-B55E-58FDFE412491 (1800 sec)
[17-12-11 17:43:59.7926] Slim::Plugin::UPnP::Events::sendResponse (149) Sub
3D5E38FD-A8F5-4A13-B55E-58FDFE412491 is now active
[17-12-11 17:45:50.7950] Slim::Plugin::UPnP::Events::request (92) UNSUBSCRIBE
/plugins/UPnP/MediaServer/ContentDirectory/eventsub
[17-12-11 17:45:50.7955] Slim::Plugin::UPnP::Events::unsubscribe (302)
Unsubscribe: 3D5E38FD-A8F5-4A13-B55E-58FDFE412491
(Slim::Plugin::UPnP::MediaServer::ContentDirectory)
--------------------
On the MACmini however I don't see the unsubscribe only the Renewed
messages:
Code:
--------------------
[17-12-11 17:45:14.8075] Slim::Plugin::UPnP::Events::request (92) SUBSCRIBE
/plugins/UPnP/MediaServer/ContentDirectory/eventsub
[17-12-11 17:45:14.8079] Slim::Plugin::UPnP::Events::subscribe (190) Renewed:
E06B99D3-0CDC-43D8-A424-461E077BADB0 (1800 sec)
[17-12-11 17:45:14.8083] Slim::Plugin::UPnP::Events::sendResponse (149) Sub
E06B99D3-0CDC-43D8-A424-461E077BADB0 is now active
--------------------
This raises a few questions for me. It seems there is some kind of
timeout running out. But why only on the NAS? Is the client actively
unsubscribing from the NAS MediaServer? If so, why does he not also
unsubscribe from the MACmini Mediaserver?
------------------------------------------------------------------------
doncmdr's Profile: http://forums.slimdevices.com/member.php?userid=1011
View this thread: http://forums.slimdevices.com/showthread.php?t=108364
_______________________________________________
beta mailing list
[email protected]
http://lists.slimdevices.com/mailman/listinfo/beta
