"Socket.IO error: xhr poll error" in log

Hello all,

for a while now these log entries occur in my log every day.
Can anyone tell me what they mean? (I xxx-ed my UUID)
What’s weird about them is the time they always show up…

Thanks for your help!
stefan

2015-08-17 06:00:01.522 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr poll error
2015-08-17 06:00:01.528 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://loc$
2015-08-17 06:00:14.389 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhos$
2015-08-17 18:00:02.320 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr poll error
2015-08-17 18:00:02.324 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://loc$
2015-08-17 18:00:17.822 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhos$

my.openHAB disconnects sockets from time to time to clean up, so there is nothing wrong about those messages as soon as openHAB reconnect back to my.openHAB.

Thank you!
Good to know :wink:

@belovictor I think that those messages must be info in log not error!!!
Please change it :grinning: not only me is confused…

Since last days of july OH frequently stop working.
UI work regulary but events stops!

Today at 16:22 PM on my openhab.log:
26/08/2015 16: 24: 59,683 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: XHR post error
26/08/2015 16: 24: 59,687 [INFO] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = omissis base URL = http: // localhost: 8080)
26/08/2015 16: 25: 00,009 [INFO] [hab.model.script.PresenceCheck] - No phone Within Reach, checking for flapping
26/08/2015 16: 25: 18,066 [INFO] [bsintypicals.RefreshHEALTY] - sendHEALTY_REQUESTframe
26/08/2015 16: 25: 18,151 [INFO] [.bsinudp.UDPSoulissDecoder] - function_health_resp
etc …
etc …

And the events LOG stops at 16:24:33

I run 1.7 OH with addon:
milight, networkhealt, souliss, myopenhab, Cosme, rrdj

Also from last days of july UI access is frequently slow and also Android notification are very slow.

I also run in debug mode but I can not see errors.

I use CosmBinding since 20 july.
Can be that upload every second (energy) bring on overload or delay and then OH stop?

I changed and now Cosm upload everyMinutes. I going to test.
[OT] There isn’t a persistence strategies to upload every 5 seconds?

Tonino

@belovictor
iOS 9.1 breaking openhab?

those disconnects now appear every few seconds as soon as i connect to openhab vio ios app.
when i close the app, the errors stop.

openhab is sluggish and not usable through the app.

here are the errors and warnings:

opened ios app

2015-09-26 23:12:11.788 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:12:11.792 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:12:13.646 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:12:28.620 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:12:28.624 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:12:30.247 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:12:45.387 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:12:45.393 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:12:50.852 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:13:02.238 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:13:02.242 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:13:07.699 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:14:28.608 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:14:28.612 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:14:34.101 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)

closed ios app

opened the app again

2015-09-26 23:17:22.923 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:17:22.927 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:28.407 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:32.252 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:17:32.256 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:33.862 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:37.718 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:17:37.722 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:43.311 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:54.134 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-09-26 23:17:54.138 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:17:56.077 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = XXX, base URL = http://localhost:8080)
2015-09-26 23:18:06.736 [WARN ] [ipse.jetty.client.HttpExchange] - EXPIRED MyOHExchange@888325=GET//localhost:8080/rest/sitemaps/O/O?#WAITING(29861ms)->EXPIRED(0ms)sent=29861ms

closed the app again

my system is pretty messed up today even though i didn’t change anything. it was running fine yesterday…

thanks for your help!

edit: just tried the ios app on iOS7 iphone 4s and ther errors appear too. so it’s not related to iOS9 i guess…

edit2: i found out those errors only appear when using the app and connecting to openhab from outside the network e.g. via 3G mobile network.

I guess troubles are happening when you start connecting remotely through my.openHAB…
Can you please describe your installation in detail - machine, OS, Java version, openHAB version?

@belovictor

hey,

the problems disappeared last week when you fixed the “larger sitemaps won’t show”-problem --> My.openhab.org not working for larger Sitemap Subsections since yesterday

im running OH 1.7.1 on a raspberry pi 2 with wheezy. how do i check for the version of wheezy and java? :wink:

cheers,
stefan

uname -a
java -version

thx @watou!

ok, so it’s:
Linux raspberrypi 4.1.7-v7+ #817
and Java™ SE Runtime Environment (build 1.8.0-b132)

Since about one week I get the same errors.

2015-10-27 16:04:29.917 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 16:04:29.918 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 16:04:38.597 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 16:17:46.984 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 16:17:57.145 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 16:59:58.512 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr poll error
2015-10-27 16:59:58.534 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 17:00:07.877 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 17:27:11.422 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 17:27:11.423 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 17:27:17.510 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 17:27:49.346 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 17:27:49.347 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 17:27:54.817 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 18:15:06.693 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 18:15:06.695 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 18:15:13.115 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:15:57.578 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 19:15:57.580 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:16:03.275 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:16:36.447 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 19:16:36.497 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:16:38.108 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:41:14.948 [ERROR] [.myopenhab.internal.MyOHClient] - Socket.IO error: com.github.nkzawa.engineio.client.EngineIOException: xhr post error
2015-10-27 19:41:14.971 [INFO ] [.myopenhab.internal.MyOHClient] - Disconnected from my.openHAB service (UUID = xxx, base URL = http://localhost:8082)
2015-10-27 19:41:48.890 [INFO ] [.myopenhab.internal.MyOHClient] - Connected to my.openHAB service (UUID = xxx, base URL = http://localhost:8082)

Actually, the logs are not the problem for me.
The problem is that HABdroid creates notifications about “openhab offline”.

My first reaction was: “OMG, my smart home does not work anymore!”
When I got the “online” notification a few minutes later and the offline/online massages repeated a few times over the day, they started to annoy me. :frowning:

It may have started when I updated to openHAB v1.7.1.

I cannot exclude a local problem with my server.
But maybe other people see the same behavior.

I used to have these kind of messages consistently every 6 hours, but as @belovictor has explained in other threads that is part of the internal housekeeping of my.openhab and nothing to worry about.

A few days ago, however, I started to get notifications about my.openhab going offline and then online again a few minutes later at all times of day. Sometimes it happens in bursts of many oflline-online-offline-… cycles, and some times there are hours of “silence and happiness” before it happens again.

yesterday and today I got about 15-20 “openhab offline” and “openhab online” messages.

same problem…

+1
same problem

In my case I sometimes get the offline-message, OH is still online and hours later I get notified that OH is online again.

Really confusing…

fyi: I don’t get there messages anymore.
Just the normal two every 12 hours.
But HABdroid does not annoy me anymore with offline messages.

Maybe it has something to do with my fresh install on a raspberry pi…