iobroker-community-adapters / ioBroker.shelly

Integrate your Shelly devices into ioBroker via MQTT or CoIoT
Other
167 stars 67 forks source link

[MQTT] Uncaught exception: This socket has been ended by the other party #800

Closed Amardillo closed 1 year ago

Amardillo commented 1 year ago

I'm sure that

Shelly device

Shelly RGBW Bulb

Protocol (CoAP / MQTT)

MQTT

The problem

This issue looks a like the unhandle promise issue a year ago. At least the behaviour is the same as it crashes the adapter and causes IOB to freak out.

Short: A Shelly RGBW lightbulb is missing a wi-fi connection and the Shelly adapter freaks out

Version of nodejs

14.21.1

Version of ioBroker js-controller

4.0.24

Version of Adapter

6.3.1

Operating system running ioBroker

Linux

Checklist of files to include below

Additional information & file uploads

2023-04-06 02:02:36.280 - info: shelly.1 (13764) [MQTT] Client Error: 192.168.177.38 (shellycolorbulb / shellycolorbulb-E8DB84A9DAB0 / SHCB-1#E8DB84A9DAB0#1) (Error: read ECONNRESET) -- 2023-04-06 02:02:38.387 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:03:11.248 - info: sonoff.0 (777) Client [SONOFF_OG_FLUR_LICHT] connection closed: closed 2023-04-06 02:03:11.660 - info: sonoff.0 (777) Client [SONOFF_OG_FLUR_LICHT] connected with secret 1680739391660_7106 2023-04-06 02:04:50.313 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:05:05.402 - info: javascript.0 (565) script.js.PROD.FB-Heizung-Steuerung: FBH NG HAUPT: AN 2023-04-06 02:06:15.654 - info: bmw.0 (891) Found 1 bmw vehicles 2023-04-06 02:06:48.023 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9C0EA" connected! 2023-04-06 02:06:53.888 - info: shelly.1 (13764) [MQTT] Client Error: 192.168.177.38 (shellycolorbulb / shellycolorbulb-E8DB84A9DAB0 / SHCB-1#E8DB84A9DAB0#1) (Error: read ECONNRESET) 2023-04-06 02:06:56.039 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:08:58.549 - info: shelly.1 (13764) [MQTT] Client Error: 192.168.177.38 (shellycolorbulb / shellycolorbulb-E8DB84A9DAB0 / SHCB-1#E8DB84A9DAB0#1) (Error: read ECONNRESET) 2023-04-06 02:09:00.539 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:11:15.665 - info: bmw.0 (891) Found 1 bmw vehicles 2023-04-06 02:11:38.346 - info: javascript.0 (565) script.js.PROD.FB-Heizung-Steuerung: FBH GARAGE: AUS 2023-04-06 02:12:22.796 - info: javascript.0 (565) script.js.PROD.FB-Heizung-Steuerung: FBH BEN : AUS 2023-04-06 02:12:36.743 - info: sonoff.0 (777) Client [SONOFF_OG_FLUR_LICHT] reconnected. Old secret 1680739391660_7106. New secret 1680739956739_7696 2023-04-06 02:13:09.619 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:13:12.577 - info: shelly.1 (13764) [MQTT] Device with client id "shellycolorbulb-E8DB84A9DAB0" connected! 2023-04-06 02:13:12.585 - info: shelly.1 (13764) [MQTT] Client Close: (shellycolorbulb / shellycolorbulb-E8DB84A9DAB0 / SHCB-1#E8DB84A9DAB0#1) (false) 2023-04-06 02:13:13.083 - error: shelly.1 (13764) uncaught exception: This socket has been ended by the other party 2023-04-06 02:13:13.084 - error: shelly.1 (13764) Error: This socket has been ended by the other party at Socket.writeAfterFIN [as write] (net.js:468:14) at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:291:10) at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) at writeOrBuffer (internal/streams/writable.js:358:12) at Writable.write (internal/streams/writable.js:303:10) at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.085 - error: shelly.1 (13764) Exception-Code: EPIPE: This socket has been ended by the other party 2023-04-06 02:13:13.105 - error: shelly.1 (13764) uncaught exception: This socket has been ended by the other party 2023-04-06 02:13:13.105 - error: shelly.1 (13764) Error: This socket has been ended by the other party at Socket.writeAfterFIN [as write] (net.js:468:14) at writeVarByteInt (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:795:17) at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:293:3) at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) at writeOrBuffer (internal/streams/writable.js:358:12) at Writable.write (internal/streams/writable.js:303:10) at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) 2023-04-06 02:13:13.105 - error: shelly.1 (13764) Exception-Code: EPIPE: This socket has been ended by the other party 2023-04-06 02:13:13.108 - error: shelly.1 (13764) uncaught exception: This socket has been ended by the other party 2023-04-06 02:13:13.108 - error: shelly.1 (13764) Error: This socket has been ended by the other party at Socket.writeAfterFIN [as write] (net.js:468:14) at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:294:10) at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) at writeOrBuffer (internal/streams/writable.js:358:12) at Writable.write (internal/streams/writable.js:303:10) at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.108 - error: shelly.1 (13764) Exception-Code: EPIPE: This socket has been ended by the other party 2023-04-06 02:13:13.110 - error: shelly.1 (13764) uncaught exception: This socket has been ended by the other party 2023-04-06 02:13:13.111 - error: shelly.1 (13764) Error: This socket has been ended by the other party at Socket.writeAfterFIN [as write] (net.js:468:14) at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:296:10) at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) at writeOrBuffer (internal/streams/writable.js:358:12) at Writable.write (internal/streams/writable.js:303:10) at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.111 - error: shelly.1 (13764) Exception-Code: EPIPE: This socket has been ended by the other party 2023-04-06 02:13:13.119 - info: shelly.1 (13764) terminating 2023-04-06 02:13:13.120 - warn: shelly.1 (13764) Terminated (UNCAUGHT_EXCEPTION): Without reason 2023-04-06 02:13:13.246 - error: host.ioBroker Caught by controller[1]: Error: This socket has been ended by the other party 2023-04-06 02:13:13.250 - error: host.ioBroker Caught by controller[1]: at Socket.writeAfterFIN [as write] (net.js:468:14) 2023-04-06 02:13:13.250 - error: host.ioBroker Caught by controller[1]: at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:291:10) 2023-04-06 02:13:13.251 - error: host.ioBroker Caught by controller[1]: at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) 2023-04-06 02:13:13.251 - error: host.ioBroker Caught by controller[1]: at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) 2023-04-06 02:13:13.251 - error: host.ioBroker Caught by controller[1]: at writeOrBuffer (internal/streams/writable.js:358:12) 2023-04-06 02:13:13.251 - error: host.ioBroker Caught by controller[1]: at Writable.write (internal/streams/writable.js:303:10) 2023-04-06 02:13:13.252 - error: host.ioBroker Caught by controller[1]: at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) 2023-04-06 02:13:13.252 - error: host.ioBroker Caught by controller[1]: at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) 2023-04-06 02:13:13.252 - error: host.ioBroker Caught by controller[1]: at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) 2023-04-06 02:13:13.252 - error: host.ioBroker Caught by controller[1]: at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.253 - error: host.ioBroker Caught by controller[2]: Error: This socket has been ended by the other party 2023-04-06 02:13:13.253 - error: host.ioBroker Caught by controller[2]: at Socket.writeAfterFIN [as write] (net.js:468:14) 2023-04-06 02:13:13.253 - error: host.ioBroker Caught by controller[2]: at writeVarByteInt (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:795:17) 2023-04-06 02:13:13.253 - error: host.ioBroker Caught by controller[2]: at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:293:3) 2023-04-06 02:13:13.253 - error: host.ioBroker Caught by controller[2]: at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) 2023-04-06 02:13:13.254 - error: host.ioBroker Caught by controller[2]: at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) 2023-04-06 02:13:13.254 - error: host.ioBroker Caught by controller[2]: at writeOrBuffer (internal/streams/writable.js:358:12) 2023-04-06 02:13:13.254 - error: host.ioBroker Caught by controller[2]: at Writable.write (internal/streams/writable.js:303:10) 2023-04-06 02:13:13.254 - error: host.ioBroker Caught by controller[2]: at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) 2023-04-06 02:13:13.254 - error: host.ioBroker Caught by controller[2]: at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) 2023-04-06 02:13:13.255 - error: host.ioBroker Caught by controller[2]: at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) 2023-04-06 02:13:13.255 - error: host.ioBroker Caught by controller[3]: Error: This socket has been ended by the other party 2023-04-06 02:13:13.255 - error: host.ioBroker Caught by controller[3]: at Socket.writeAfterFIN [as write] (net.js:468:14) 2023-04-06 02:13:13.255 - error: host.ioBroker Caught by controller[3]: at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:294:10) 2023-04-06 02:13:13.255 - error: host.ioBroker Caught by controller[3]: at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at writeOrBuffer (internal/streams/writable.js:358:12) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at Writable.write (internal/streams/writable.js:303:10) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) 2023-04-06 02:13:13.256 - error: host.ioBroker Caught by controller[3]: at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: Error: This socket has been ended by the other party 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at Socket.writeAfterFIN [as write] (net.js:468:14) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at connack (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:296:10) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at generate (/opt/iobroker/node_modules/mqtt-packet/writeToStream.js:32:14) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at Writable.write [as _write] (/opt/iobroker/node_modules/mqtt-connection/lib/writeToStream.js:13:9) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at writeOrBuffer (internal/streams/writable.js:358:12) 2023-04-06 02:13:13.257 - error: host.ioBroker Caught by controller[4]: at Writable.write (internal/streams/writable.js:303:10) 2023-04-06 02:13:13.258 - error: host.ioBroker Caught by controller[4]: at Connection.Duplexify._write (/opt/iobroker/node_modules/duplexify/index.js:208:22) 2023-04-06 02:13:13.258 - error: host.ioBroker Caught by controller[4]: at doWrite (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:428:64) 2023-04-06 02:13:13.258 - error: host.ioBroker Caught by controller[4]: at writeOrBuffer (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:417:5) 2023-04-06 02:13:13.258 - error: host.ioBroker Caught by controller[4]: at Connection.Writable.write (/opt/iobroker/node_modules/readable-stream/lib/_stream_writable.js:334:11) 2023-04-06 02:13:13.259 - error: host.ioBroker instance system.adapter.shelly.1 terminated with code 1 (JS_CONTROLLER_STOPPED)
klein0r commented 1 year ago

6.3.1

Please test with the latest beta.

Amardillo commented 1 year ago

Heya, works like a charm with the current built of 6.4.0. No errors from the adapter up to now. Thank you for your work and engagement! WIll update if things change....

Cheers