Serviio

Posted: **Tue Sep 19, 2017 6:33 pm**

Hi All

Should I be worried about the following in the serviio.log:

Code:: 2017-09-19 18:22:34,282 INFO [UserDataUpdater] Updating user data 2017-09-19 18:22:54,882 WARN [UserDataUpdater] There was an error updating user data java.net.SocketTimeoutException: connect timed out at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(Unknown Source) at java.net.AbstractPlainSocketImpl.connectToAddress(Unknown Source) at java.net.AbstractPlainSocketImpl.connect(Unknown Source) at java.net.SocksSocketImpl.connect(Unknown Source) at java.net.Socket.connect(Unknown Source) at sun.net.NetworkClient.doConnect(Unknown Source) at sun.net.www.http.HttpClient.openServer(Unknown Source) at sun.net.www.http.HttpClient.openServer(Unknown Source) at sun.net.www.http.HttpClient.<init>(Unknown Source) at sun.net.www.http.HttpClient.New(Unknown Source) at sun.net.www.http.HttpClient.New(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.getNewHttpClient(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.plainConnect0(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.plainConnect(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.connect(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(Unknown Source) at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source) at java.net.HttpURLConnection.getResponseCode(Unknown Source) at org.serviio.util.HttpClient.retrieveStreamFromConnection(HttpClient.java:173) at org.serviio.util.HttpClient.getStreamFromURL(HttpClient.java:103) at org.serviio.util.HttpClient.retrieveTextFileFromURL(HttpClient.java:42) at org.serviio.upnp.service.contentdirectory.rest.access.TuqPortCheckerProvider.isPortOpen(TuqPortCheckerProvider.java:20) at org.serviio.upnp.service.contentdirectory.rest.access.PortMappingChecker.isPortOpen(PortMappingChecker.java:39) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.isSSLPortOpen(UserDataUpdater.java:178) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.doUpdateUserData(UserDataUpdater.java:101) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.access$200(UserDataUpdater.java:32) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater$UserDataUpdaterRunner.run(UserDataUpdater.java:193) at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.util.concurrent.FutureTask.runAndReset(Unknown Source) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source)

I haven't noticed it previously. Should I be worried?

Running serviio 1.9 on an ARM based nas box. Thanks

Posted: **Tue Sep 19, 2017 10:45 pm**

no that is fine

Posted: **Mon Sep 25, 2017 7:01 pm**

I have the same problem. This is not fine.
NAS still wakes the HDD out of sleep and that's a problem.

How can I remove this warning from the log?

Posted: **Tue Sep 26, 2017 9:23 am**

I will look into it for 1.9.1

Posted: **Tue Sep 26, 2017 3:07 pm**

Ok. Thanks

Posted: **Wed Sep 27, 2017 7:51 am**

Are you sure it's this warning that wakes the HDD?

Posted: **Wed Sep 27, 2017 8:11 pm**

Yes. Warning every hour, as well as NAS HDD wakes up. I also tested various times of HDD sleep.
Everything probably started after updating on JRE 8.144.
My NAS is QNAP TS-420 RAM only 512MB

Code:: 2017-09-27 19:19:06,096 INFO [UserDataUpdater] Updating user data 2017-09-27 19:19:26,867 WARN [UserDataUpdater] There was an error updating user data java.net.SocketTimeoutException: connect timed out at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ........ 2017-09-27 20:19:06,096 INFO [UserDataUpdater] Updating user data 2017-09-27 20:19:26,967 WARN [UserDataUpdater] There was an error updating user data java.net.SocketTimeoutException: connect timed out at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ......... 2017-09-27 21:19:06,096 INFO [UserDataUpdater] Updating user data 2017-09-27 21:19:26,847 WARN [UserDataUpdater] There was an error updating user data java.net.SocketTimeoutException: connect timed out at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)

Full last Log warning

Code:: 2017-09-27 22:19:06,096 INFO [UserDataUpdater] Updating user data 2017-09-27 22:19:26,857 WARN [UserDataUpdater] There was an error updating user data java.net.SocketTimeoutException: connect timed out at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) at java.net.Socket.connect(Socket.java:589) at sun.net.NetworkClient.doConnect(NetworkClient.java:175) at sun.net.www.http.HttpClient.openServer(HttpClient.java:463) at sun.net.www.http.HttpClient.openServer(HttpClient.java:558) at sun.net.www.http.HttpClient.<init>(HttpClient.java:242) at sun.net.www.http.HttpClient.New(HttpClient.java:339) at sun.net.www.http.HttpClient.New(HttpClient.java:357) at sun.net.www.protocol.http.HttpURLConnection.getNewHttpClient(HttpURLConnection.java:1202) at sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1138) at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1032) at sun.net.www.protocol.http.HttpURLConnection.connect(HttpURLConnection.java:966) at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1546) at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1474) at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480) at org.serviio.util.HttpClient.retrieveStreamFromConnection(HttpClient.java:173) at org.serviio.util.HttpClient.getStreamFromURL(HttpClient.java:103) at org.serviio.util.HttpClient.retrieveTextFileFromURL(HttpClient.java:42) at org.serviio.upnp.service.contentdirectory.rest.access.TuqPortCheckerProvider.isPortOpen(TuqPortCheckerProvider.java:20) at org.serviio.upnp.service.contentdirectory.rest.access.PortMappingChecker.isPortOpen(PortMappingChecker.java:39) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.isSSLPortOpen(UserDataUpdater.java:178) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.doUpdateUserData(UserDataUpdater.java:101) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater.access$200(UserDataUpdater.java:32) at org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater$UserDataUpdaterRunner.run(UserDataUpdater.java:193) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748)

Posted: **Thu Sep 28, 2017 1:00 pm**

So there are no other entries in the log between these that could also wake it up?

You could try to add this to the log4j.xml file

Code:: <category name="org.serviio.upnp.service.contentdirectory.rest.access.UserDataUpdater"> <priority value="ERROR"/> </category>

Posted: **Thu Sep 28, 2017 1:25 pm**

I watched over night +- 8h. NAS activity is none (NAS log samba, ftp, http) and HDD was awakened 6x.
Serviio log has no other records except warnings.

log4j edited and restarting serviio. I will watch and send the result.
Thank you

Posted: **Fri Sep 29, 2017 7:05 am**

Hi zip,
Last night all OK. NAS slept as a baby 8-)

Thank you for help

Posted: **Tue Oct 03, 2017 9:07 am**

good stuff

Serviio

WARN [UserDataUpdater] There was an error updating user data

WARN [UserDataUpdater] There was an error updating user data

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user

Re: WARN [UserDataUpdater] There was an error updating user