search

openhab / openhab-addons

Add-ons for openHAB
https://www.openhab.org/
Eclipse Public License 2.0
1.86k stars 3.58k forks source link

[amazonechocontrol] Unable to find new Switches via Alexa skill when binding is activated #4409

Closed UdoWeberJR closed 5 years ago

UdoWeberJR commented 5 years ago

Hello,

I have a problem with the Amazon Echo Control Binding and the Amazon Alexa Skill.

If I NOT install the Amazon Echo Control Binding I can tell Alexa via Voice Command to finde new devices and e.g. new items with the Tag ["Lighting"] are found w/o a problem.

But as soon as I install Amazon Echo Control Binding, no new devices are found. And during the search for new devices, the log files shows an exception (trace log below) shortly before Alex tells me that nothing new could be found.

Interesting is that existing switches are still working with Amazon Echo Control Binding installed.

So currently my annoying workaround is: Add new Alexa Switch, disable the Amazon Echo Control Binding, let Alexa search for new devices, install Amazon Echo Control Binding again.

I had this problem with OpenHab 2.3 also. Yesterday I did a complete fresh installed of OpenHAB 2.4 on a new SD Card and only copied /etc/openhab2, uuid and secret of myopenhab. But the problem still exists.

Let me know if you need anything else. Greets Udo

What I did so far:

Environment

openHAB 2.4.0-1 (Release Build) Release = Raspbian GNU/Linux 9 (stretch) Kernel = Linux 4.14.79-v7+ Platform = Raspberry Pi 2 Model B Rev 1.1 Binding 2.4.0 org.openhab.binding.amazonechocontrol

TRACE

2018-12-19 13:23:44.521 [DEBUG] [trol.internal.handler.AccountHandler] - refresh data amazonechocontrol:account:account1 finished
2018-12-19 13:23:44.526 [DEBUG] [trol.internal.handler.AccountHandler] - refreshing data amazonechocontrol:account:account1
2018-12-19 13:23:44.529 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/devices-v2/device?cached=false
2018-12-19 13:23:46.316 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/devices-v2/device?cached=false succeeded
2018-12-19 13:23:46.342 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/wake-word?cached=true
2018-12-19 13:23:46.675 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/wake-word?cached=true succeeded
2018-12-19 13:23:46.744 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/device-notification-state
2018-12-19 13:23:47.584 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/device-notification-state succeeded
2018-12-19 13:23:47.599 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/ascending-alarm
2018-12-19 13:23:49.216 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/ascending-alarm succeeded
2018-12-19 13:23:49.224 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/bluetooth?cached=true
2018-12-19 13:23:50.284 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/bluetooth?cached=true succeeded
2018-12-19 13:23:50.310 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&screenWidth=1440
2018-12-19 13:23:50.493 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&screenWidth=1440 succeeded
2018-12-19 13:23:50.564 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&screenWidth=1440
2018-12-19 13:23:50.836 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&screenWidth=1440 succeeded
2018-12-19 13:23:50.898 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/np/player?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&screenWidth=1440
2018-12-19 13:23:51.100 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/np/player?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&screenWidth=1440 succeeded
2018-12-19 13:23:51.179 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&screenWidth=1440
2018-12-19 13:23:51.372 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/np/player?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&screenWidth=1440 succeeded
2018-12-19 13:23:51.504 [DEBUG] [trol.internal.handler.AccountHandler] - refresh data amazonechocontrol:account:account1 finished
2018-12-19 13:24:16.511 [DEBUG] [control.internal.WebSocketConnection] - Message received: {"payload":"{\"destinationUserId\":\"A1GD69JGTGFWMP\",\"key\":{\"entryId\":\"1545222255724#A3S5BH2HU6VAYF#G090LF1181470SGF\",\"registeredUserId\":\"A1GD69JGTGFWMP\"},\"timestamp\":1545222256393}","command":"PUSH_ACTIVITY"}
2018-12-19 13:24:16.544 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/activities?startTime=1545222256393&size=10&offset=1
2018-12-19 13:24:16.917 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/activities?startTime=1545222256393&size=10&offset=1 succeeded
2018-12-19 13:24:16.957 [DEBUG] [trol.internal.handler.AccountHandler] - checkData amazonechocontrol:account:account1 finished
2018-12-19 13:24:16.963 [DEBUG] [trol.internal.handler.AccountHandler] - check login amazonechocontrol:account:account1
2018-12-19 13:24:21.887 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&softwareVersion=628534620
2018-12-19 13:24:22.168 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&softwareVersion=628534620 succeeded
2018-12-19 13:24:22.193 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&softwareVersion=628534620
2018-12-19 13:24:22.367 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&softwareVersion=628534620 succeeded
2018-12-19 13:24:22.539 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:22.724 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:22.756 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:22.952 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=90F00818703708BU&deviceType=AB72C64C86AW2&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:23.092 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:23.413 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:23.430 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:23.735 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:23.893 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220
2018-12-19 13:24:24.086 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220 succeeded
2018-12-19 13:24:24.113 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220
2018-12-19 13:24:24.296 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220 succeeded
2018-12-19 13:24:24.464 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:24.973 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:25.029 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:25.342 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:25.427 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:25.622 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:25.631 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:25.820 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:26.204 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:26.537 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:26.545 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:26.860 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:27.457 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:27.952 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:27.962 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music
2018-12-19 13:24:28.289 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/behaviors/entities?skillId=amzn1.ask.1p.music succeeded
2018-12-19 13:24:28.339 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:28.617 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:28.627 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:28.832 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G090LF1181470SEF&deviceType=A3S5BH2HU6VAYF&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:28.861 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&softwareVersion=628538020
2018-12-19 13:24:29.029 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&softwareVersion=628538020 succeeded
2018-12-19 13:24:29.049 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&softwareVersion=628538020
2018-12-19 13:24:29.315 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&softwareVersion=628538020 succeeded
2018-12-19 13:24:29.353 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220
2018-12-19 13:24:29.550 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220 succeeded
2018-12-19 13:24:29.566 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220
2018-12-19 13:24:30.071 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/notification/sounds?deviceSerialNumber=G090LF1181470SGF&deviceType=A3S5BH2HU6VAYF&softwareVersion=628538220 succeeded
2018-12-19 13:24:30.134 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:30.327 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:30.343 [DEBUG] [mazonechocontrol.internal.Connection] - Make request to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&mediaOwnerCustomerId=A1GD69JGTGFWMP
2018-12-19 13:24:30.552 [DEBUG] [mazonechocontrol.internal.Connection] - Call to https://alexa.amazon.de/api/cloudplayer/playlists?deviceSerialNumber=G000MW0773370BGB&deviceType=A1NL4BVLQ4L3N3&mediaOwnerCustomerId=A1GD69JGTGFWMP succeeded
2018-12-19 13:24:30.824 [ERROR] [ersey.server.ServerRuntime$Responder] - An I/O error has occurred while writing a response message entity to the container output stream.
org.glassfish.jersey.server.internal.process.MappableException: org.eclipse.jetty.io.EofException
    at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:92) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162) ~[171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.message.internal.MessageBodyFactory.writeTo(MessageBodyFactory.java:1130) ~[171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.server.ServerRuntime$Responder.writeResponse(ServerRuntime.java:711) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.server.ServerRuntime$Responder.processResponse(ServerRuntime.java:444) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.server.ServerRuntime$Responder.process(ServerRuntime.java:434) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.server.ServerRuntime$2.run(ServerRuntime.java:329) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.internal.Errors$1.call(Errors.java:271) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.internal.Errors$1.call(Errors.java:267) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.internal.Errors.process(Errors.java:315) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.internal.Errors.process(Errors.java:297) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.internal.Errors.process(Errors.java:267) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:317) [171:org.glassfish.jersey.core.jersey-common:2.22.2]
    at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) [172:org.glassfish.jersey.core.jersey-server:2.22.2]
    at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) [169:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
    at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) [169:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
    at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) [169:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
    at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) [169:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
    at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) [169:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
    at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) [20:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253]
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:865) [85:org.eclipse.jetty.servlet:9.4.11.v20180605]
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:535) [85:org.eclipse.jetty.servlet:9.4.11.v20180605]
    at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) [186:org.ops4j.pax.web.pax-web-jetty:7.2.3]
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:146) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) [82:org.eclipse.jetty.security:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:257) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:293) [186:org.ops4j.pax.web.pax-web-jetty:7.2.3]
    at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473) [85:org.eclipse.jetty.servlet:9.4.11.v20180605]
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) [186:org.ops4j.pax.web.pax-web-jetty:7.2.3]
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.Server.handle(Server.java:531) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260) [84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281) [75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) [75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) [75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762) [87:org.eclipse.jetty.util:9.4.11.v20180605]
    at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680) [87:org.eclipse.jetty.util:9.4.11.v20180605]
    at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: org.eclipse.jetty.io.EofException
    at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:286) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:429) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:323) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:380) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpConnection$SendCallback.process(HttpConnection.java:804) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[87:org.eclipse.jetty.util:9.4.11.v20180605]
    at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:224) ~[87:org.eclipse.jetty.util:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpConnection.send(HttpConnection.java:538) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpChannel.sendResponse(HttpChannel.java:795) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpChannel.write(HttpChannel.java:846) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:240) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:216) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:515) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.write(ResponseWriter.java:325) ~[?:?]
    at org.glassfish.jersey.message.internal.CommittingOutputStream.write(CommittingOutputStream.java:229) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$UnCloseableOutputStream.write(WriterInterceptorExecutor.java:299) ~[?:?]
    at org.glassfish.jersey.message.internal.ReaderWriter.writeTo(ReaderWriter.java:116) ~[?:?]
    at org.glassfish.jersey.message.internal.AbstractMessageReaderWriterProvider.writeTo(AbstractMessageReaderWriterProvider.java:79) ~[?:?]
    at org.glassfish.jersey.message.internal.InputStreamProvider.writeTo(InputStreamProvider.java:105) ~[?:?]
    at org.glassfish.jersey.message.internal.InputStreamProvider.writeTo(InputStreamProvider.java:60) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.invokeWriteTo(WriterInterceptorExecutor.java:265) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.aroundWriteTo(WriterInterceptorExecutor.java:250) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162) ~[?:?]
    at org.glassfish.jersey.server.internal.JsonWithPaddingInterceptor.aroundWriteTo(JsonWithPaddingInterceptor.java:106) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162) ~[?:?]
    at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:86) ~[?:?]
    ... 48 more
Caused by: java.io.IOException: Broken pipe
    at sun.nio.ch.FileDispatcherImpl.writev0(Native Method) ~[?:?]
    at sun.nio.ch.SocketDispatcher.writev(SocketDispatcher.java:51) ~[?:?]
    at sun.nio.ch.IOUtil.write(IOUtil.java:148) ~[?:?]
    at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:504) ~[?:?]
    at org.eclipse.jetty.io.ChannelEndPoint.flush(ChannelEndPoint.java:266) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:429) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:323) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:380) ~[75:org.eclipse.jetty.io:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpConnection$SendCallback.process(HttpConnection.java:804) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241) ~[87:org.eclipse.jetty.util:9.4.11.v20180605]
    at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:224) ~[87:org.eclipse.jetty.util:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpConnection.send(HttpConnection.java:538) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpChannel.sendResponse(HttpChannel.java:795) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpChannel.write(HttpChannel.java:846) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:240) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:216) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:515) ~[84:org.eclipse.jetty.server:9.4.11.v20180605]
    at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.write(ResponseWriter.java:325) ~[?:?]
    at org.glassfish.jersey.message.internal.CommittingOutputStream.write(CommittingOutputStream.java:229) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$UnCloseableOutputStream.write(WriterInterceptorExecutor.java:299) ~[?:?]
    at org.glassfish.jersey.message.internal.ReaderWriter.writeTo(ReaderWriter.java:116) ~[?:?]
    at org.glassfish.jersey.message.internal.AbstractMessageReaderWriterProvider.writeTo(AbstractMessageReaderWriterProvider.java:79) ~[?:?]
    at org.glassfish.jersey.message.internal.InputStreamProvider.writeTo(InputStreamProvider.java:105) ~[?:?]
    at org.glassfish.jersey.message.internal.InputStreamProvider.writeTo(InputStreamProvider.java:60) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.invokeWriteTo(WriterInterceptorExecutor.java:265) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.aroundWriteTo(WriterInterceptorExecutor.java:250) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162) ~[?:?]
    at org.glassfish.jersey.server.internal.JsonWithPaddingInterceptor.aroundWriteTo(JsonWithPaddingInterceptor.java:106) ~[?:?]
    at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162) ~[?:?]
    at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:86) ~[?:?]
    ... 48 more
2018-12-19 13:25:16.965 [DEBUG] [trol.internal.handler.AccountHandler] - checkData amazonechocontrol:account:account1 finished
2018-12-19 13:25:16.967 [DEBUG] [trol.internal.handler.AccountHandler] - check login amazonechocontrol:account:account1
UdoWeberJR commented 5 years ago

Same issue on an raspi 3B.

Environment

Binding 2.4.0 org.openhab.binding.amazonechocontrol Raspbian GNU/Linux 9 (stretch) Kernel = Linux 4.14.79-v7+ Platform = Raspberry Pi 3 Model B Rev 1.2 OpenHAB = openhab 2.4.0-1 (Release Build)

mgeramb commented 5 years ago

@UdoWeberJR: I have tried now to reproduce the issue, but unfortunately it was not possible in my installation. Discovering of new items works fine. But maybe it is fixed with my latest beta version https://www.dropbox.com/s/jws7edhwx9042j2/org.openhab.binding.amazonechocontrol_2.5.0.Beta_01.jar?dl=0 Would be nice, if you could check it again.

UdoWeberJR commented 5 years ago

Hi @mgeramb ,

thanks for your reply.

I tested it with the OLD 2.4 binding to confirm the problem still exists and was not temporarily from Amazon or something. And it does on both installations.

Then I installed the NEW beta from the link above and on both installations the problem is gone! So what ever you changed, fixed the problem. ;)

Thanks for your effort. :) I will close the ticket!

Happy new year, Udo