FAQ  •  Register  •  Login

WARN [UserDataUpdater] There was an error updating user data

<<

norm

Serviio lover

Posts: 67

Joined: Tue Apr 09, 2013 3:18 pm

Post Tue Sep 19, 2017 6:33 pm

WARN [UserDataUpdater] There was an error updating user data

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
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Tue Sep 19, 2017 10:45 pm

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

no that is fine
<<

sutrus

Serviio newbie

Posts: 17

Joined: Wed May 31, 2017 7:25 pm

Post Mon Sep 25, 2017 7:01 pm

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

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?
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Tue Sep 26, 2017 9:23 am

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

I will look into it for 1.9.1
<<

sutrus

Serviio newbie

Posts: 17

Joined: Wed May 31, 2017 7:25 pm

Post Tue Sep 26, 2017 3:07 pm

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

Ok. Thanks
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Wed Sep 27, 2017 7:51 am

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

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

sutrus

Serviio newbie

Posts: 17

Joined: Wed May 31, 2017 7:25 pm

Post Wed Sep 27, 2017 8:11 pm

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

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)
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Thu Sep 28, 2017 1:00 pm

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

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>
<<

sutrus

Serviio newbie

Posts: 17

Joined: Wed May 31, 2017 7:25 pm

Post Thu Sep 28, 2017 1:25 pm

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

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
<<

sutrus

Serviio newbie

Posts: 17

Joined: Wed May 31, 2017 7:25 pm

Post Fri Sep 29, 2017 7:05 am

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

Hi zip,
Last night all OK. NAS slept as a baby 8-)
Thank you for help
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 17212

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Tue Oct 03, 2017 9:07 am

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

good stuff

Return to Serviio Support & Help

Who is online

Users browsing this forum: No registered users and 85 guests

Powered by phpBB © 2000, 2002, 2005, 2007 phpBB Group.
Designed by ST Software for PTF.