My Openhab - Jetty Request Failed: null

[philKrylc (Phil)]

Hi,

after an update of OH2-online I lost all my DB devices (again) and had to reinstall and re-configure everything.
Now, when I use the OH iOS App (only via My Openhab) I am seeing the following error in the logs, everytime I refresh the app or switch frames:

15:26:57.522 [WARN ] [o.myopenhab.internal.MyOpenHABClient] - Jetty request 49828 failed: null
15:26:59.176 [WARN ] [o.myopenhab.internal.MyOpenHABClient] - Jetty request 49841 failed: null
15:26:59.807 [WARN ] [o.myopenhab.internal.MyOpenHABClient] - Jetty request 49848 failed: null
15:27:01.221 [WARN ] [o.myopenhab.internal.MyOpenHABClient] - Jetty request 49861 failed: null

I don’t know where the error comes from.
Any idea how to debug this? Seems like everything works fine, but I would like to identify the problem.

Thanks a lot in advance!

[jaydee73 (Stefan)]

I can confirm this. In remote mode of the iOS app I also do get this messages in my log. As I switched over to OH2 just recently, I don’t know if this is a new error since one of the latest snapshots.

I’ve created an issue for this:

Issue: Jetty request failed: null in remote mode of the app

[sihui]

myopenHAB replaces my.openHAB!

Please provide details on the OH version that you are using.

Seems to be a more general problem: I have those WARN messages when remotely connecting via Android App:

2017-01-06 11:46:02.664 [WARN ] [io.openhabcloud.internal.CloudClient] - Jetty request 89017 failed: null
2017-01-06 11:46:08.836 [WARN ] [io.openhabcloud.internal.CloudClient] - Jetty request 89025 failed: null
2017-01-06 11:46:11.089 [WARN ] [io.openhabcloud.internal.CloudClient] - Jetty request 89021 failed: null
2017-01-06 11:46:11.520 [WARN ] [io.openhabcloud.internal.CloudClient] - Jetty request 89035 failed: null

I have seen those messages since the first day of changing from my.openhab to openhab cloud connector, currently on build #684

[Nguy_n_Phuc_Anh_D_ng (Nguyễn Phúc Anh Đồng)]

I have the same problem when trying to use voice control from android app

[Lolodomo]

Same for me using HABdroid.

[demlstda (Stefan D.)]

This is still an “issue”. Really just ignore these messages? Nobody feels “responsible”?

PS:
Using iOS when getting these messages. But they also pop up when using webinterface (BasicUI)

[sihui]

@demlstda

Nobody feels “responsible”?

Sure: follow the issue:

https://github.com/openhab/openhab2-addons/issues/1782

[demlstda (Stefan D.)]

thanks a lot

[sloth0815 (Jonas Böhringer)]

I have the same issue (I think):

lassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        ... 31 more
Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_3370,3371,12659234) has been shut down
        at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640) ~[?:?]
        at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103) ~[?:?]
        at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173) ~[?:?]
        at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526) ~[?:?]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        ... 31 more
20:55:39.063 [WARN ] [core.internal.events.OSGiEventManager] - Dispatching event to subscriber 'org.eclipse.smarthome.io.monitor.internal.EventLogger@1f33383' takes more than 5000ms.
20:55:34.886 [WARN ] [.eclipse.jetty.servlet.ServletHandler] -
javax.servlet.ServletException: A MultiException has 1 exceptions.  They are:
1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_3370,3371,12659234) has been shut down

        at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489) [178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) [178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) [178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) [178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) [178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) [15:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253]
        at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:848) [88:org.eclipse.jetty.servlet:9.3.22.v20171030]
        at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:584) [88:org.eclipse.jetty.servlet:9.3.22.v20171030]
        at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) [194:org.ops4j.pax.web.pax-web-jetty:6.0.7]
        at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) [85:org.eclipse.jetty.security:9.3.22.v20171030]
        at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:284) [194:org.ops4j.pax.web.pax-web-jetty:6.0.7]
        at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [88:org.eclipse.jetty.servlet:9.3.22.v20171030]
        at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) [194:org.ops4j.pax.web.pax-web-jetty:6.0.7]
        at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.Server.handle(Server.java:534) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:333) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [87:org.eclipse.jetty.server:9.3.22.v20171030]
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [79:org.eclipse.jetty.io:9.3.22.v20171030]
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [79:org.eclipse.jetty.io:9.3.22.v20171030]
        at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [79:org.eclipse.jetty.io:9.3.22.v20171030]
        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [90:org.eclipse.jetty.util:9.3.22.v20171030]
        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [90:org.eclipse.jetty.util:9.3.22.v20171030]
        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [90:org.eclipse.jetty.util:9.3.22.v20171030]
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [90:org.eclipse.jetty.util:9.3.22.v20171030]
        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [90:org.eclipse.jetty.util:9.3.22.v20171030]
        at java.lang.Thread.run(Thread.java:745) [?:?]
Caused by: org.glassfish.hk2.api.MultiException: A MultiException has 1 exceptions.  They are:
1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_3370,3371,12659234) has been shut down

        at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106) ~[?:?]
        at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173) ~[?:?]
        at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526) ~[?:?]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        ... 31 more
Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_3370,3371,12659234) has been shut down
        at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622) ~[?:?]
        at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640) ~[?:?]
        at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103) ~[?:?]
        at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173) ~[?:?]
        at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526) ~[?:?]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319) ~[180:org.glassfish.jersey.core.jersey-common:2.22.2]
        at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) ~[181:org.glassfish.jersey.core.jersey-server:2.22.2]
        at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) ~[178:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
        ... 31 more

Is there a solution? It seems this issue causes the iOS app to lose connection and I have the feeling that my rules sometimes don’t execute properly/get skipped. Is that possible?

[Tolotos]

No news/solutions on github.
Have anybody here a solution?

[sihui]

@Tolotos

Have anybody here a solution?

At least on Android that warning does not impact functionalty, so I guess it is on low priority.

[Tony_W (Tony Wouters (Penguin))]

Had the same issue when using astro and using the local part in the thing definition.
Changed local to the true location and issue was gone.

I think you need to make sure local and remote the values can be retrieved.

[nakh_Home]

I think you need to make sure local and remote the values can be retrieved.

Please Tony what do you mean “Changed local to the true location”?

Below my current astro.things

astro:sun:home          [ geolocation="42.1859887,44.87786559999995", interval=300 ]
astro:moon:home         [ geolocation="42.1859887,44.87786559999995", interval=300 ]

i have removed the text file definition. No change (

[nakh_Home]

This issue is driving me crazy and i am not sure that the severity is understood.
so, i will summarize. @Kai, once again the reliability of the android application and iOs is affected

When using the android application with a connection to myopenhab, some warnings are logged and the android application UI is not refreshed.

[WARN ] [io.openhabcloud.internal.CloudClient] - Jetty request 1379803 failed: null
[WARN ] [io.openhabcloud.internal.CloudClient] - Response Failure: null

Movie issue

Github issue

How can i debug a such issue?

it’s not possible to increase the log level for io.openhabcloud.internal.CloudClient, it’s not a binding

This issue was raised in several threads and it affects the android and iOS users:

IOS App issues - no connectivity, stability issues

Hi, yeah - I’ve seen this happening. I’ve also been using the safari workarround, but found it cumbersome, as I couldn’t access easily remotely via the OpenHab Cloud Service. It’s a pitty that the iOS development doesn’t progress as much as the android version does, since the userbase of this phone is considerably high. Kurt

"Jetty request 5905542 failed: null" causes OH2 to freeze. Getting to be a real problem

I think that the problem is local (see my “improved” assumption ) From the warning message, I understand that: io.openhabcloud.internal.CloudClient sends requests to Jetty and gets null responses Maybe you can put the io.openhabcloud addon in TRACE log level to see what the heck is the io.openhabcloud.internal.CloudClient asking from Jetty during the failure?

I want to underline that in my current case, the sendnotifications do not work also

sendNotification does not seem to work

As already posted here: Although some users reported that sendNotification still works, i cannot get notifications from a rule. But i can get notifications that i send from the textbox on myopenhab.org. What i tried is sendNotification(“my@email.address”, “Test”) like on the intro page sendBroadcastNotification(“Test”) also does not work the cloud service source code says something about “String userId” as input so i tried various IDs i found on the webpage (device ids, ids that are within t…

i have tried also the items below with no success:

• Uninstall and Reinstall Openhabcloud Connector

• Clear the cache

Clear the Cache

Often when one encounters a problem with OH, particularly after an update, OH will refuse to run or certain parts of OH stop working. Some reported errors include: 500 or 404 errors when accessing the UIs lots of exceptions from Jetty or other core components in openhab.log OH refuses to start at all The first step in debugging the problem is to clear the tmp and cache. Installed OH If you are running an installed OH (openHABian, installed using apt or yum): openhab-cli stop openhab-cl…

• Updating the threads settings

Fix for Jetty error when running on host with many cores

If you’re running openHAB on a host computer with many cores, you may see an error in your log file that looks like this. 16:25:43.381 [ERROR] [et.http.internal.WebClientFactoryImpl] - Could not start Jetty http client java.lang.IllegalStateException: Insufficient configured threads: required=13 < max=10 for QueuedThreadPool[common]@75f3f957{STARTED,5<=5<=10,i=5,q=0}[ReservedThreadExecutor@16f08868{s=0/1,p=0}] at org.eclipse.jetty.util.thread.ThreadPoolBudget.check(ThreadPoolBudget.java…

• Remove astro things text definition
  My Openhab - Jetty Request Failed: null - #13 by nakh_Home

• Delete addons.cfg and addons.config

[SOLVED] After upgrade to 2.4 stable I'm flooded with java.lang.IllegalStateException

Usually that exception is a side effect of the load. The increased load could be due to openHAB trying to apply addon changes every minute. Can you post the contents of the following files? /etc/openhab2/services/addons.cfg /var/lib/openhab2/config/org/openhab/addons.config It may help to delete /var/lib/openhab2/config/org/openhab/addons.config so it is regenerated with correct content (see [SOLVED] OH 2.3 missing ComfoAir Binding in PaperUI).

Some Details about my configuration:

Release = Raspbian GNU/Linux 9 (stretch)
Kernel = Linux 4.14.79-v7+
Platform = Raspberry **Pi 3 Model B Plus** Rev 1.3
CPU Usage = 2.78% avg over 4 cpu(s) (4 core(s) x 1 socket(s))
CPU Load = 1m: 0.40, 5m: 0.37, 15m: 0.38
Memory = Free: 0.08GB (9%), Used: 0.86GB (91%), Total: 0.95GB
Swap = Free: 0.02GB (29%), Used: 0.06GB (71%), Total: 0.09GB
Root = Free: 9.36GB (67%), Used: 4.54GB (33%), Total: 14.53GB
Updates = 14 apt updates available.
Sessions = 2 sessions
Processes = 141 running processes of 32768 maximum processes
openHAB 2.5.0~S1502-1 (Build #1502)

My Openhab story:

My Story : Registered the 12/07/17:)

Hi @nakh_Home, I love your excelent write up of your configuration. But i have a question about the use of the Z-Wave Neo Coolcam Door/Window Sensors. I have a number of these devices in my config, but i am having problems getting them configured right in openHAB. I see the door sensors status in my sitemap (Binary Sensor). But i do not know how to get the other info from the sensors in my sitemap. You mentioned that the Temperature and Luminance are not working, but i see the Alarm (burlar)…

[chimera]

Almost 5 years later and this is still an issue. Not a show stopper, but it screws over my OH logs and makes things harder to read. On latest OH2.5,… and yes I know, I’ve yet to upgrade to OH3 - my configuration is very large so am waiting a little longer for stability / compatibility first.