UPDATE 31.10.: Amazon Alexa - ioBroker Skill läuft aus ?

[sven12]

@apollon77
@Stuebi
Ich habe den shelly Adapter mal deinstalliert.
Eine erneute installation brachte folgenden Fehler zu Tage...

2019-10-05 13:20:51.118  - info: host.iobroker-host iobroker host.iobroker-host install adapter shelly
2019-10-05 13:20:51.133  - info: host.iobroker-host iobroker upload [2] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/words.js words.js application/javascript
2019-10-05 13:20:51.217  - info: host.iobroker-host iobroker upload [1] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/shelly.png shelly.png image/png
2019-10-05 13:20:51.272  - info: host.iobroker-host iobroker upload [0] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/index_m.html index_m.html text/html
2019-10-05 13:20:51.347  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly created/updated
2019-10-05 13:20:51.503  - info: host.iobroker-host iobroker host.iobroker-host create instance shelly
2019-10-05 13:20:51.508  - info: host.iobroker-host iobroker host.iobroker-host object shelly.0.info.connection created
2019-10-05 13:20:51.537  - info: host.iobroker-host iobroker host.iobroker-host object shelly.0.info created
2019-10-05 13:20:51.568  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.sigKill created
2019-10-05 13:20:51.602  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.eventLoopLag created
2019-10-05 13:20:51.633  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.outputCount created
2019-10-05 13:20:51.664  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.inputCount created
2019-10-05 13:20:51.695  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.uptime created
2019-10-05 13:20:51.725  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memRss created
2019-10-05 13:20:51.756  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memHeapTotal created
2019-10-05 13:20:51.805  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memHeapUsed created
2019-10-05 13:20:51.864  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.cputime created
2019-10-05 13:20:51.894  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.cpu created
2019-10-05 13:20:51.938  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.compactMode created
2019-10-05 13:20:51.968  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.connected created
2019-10-05 13:20:51.997  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.alive created
2019-10-05 13:20:52.039  - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0 created
2019-10-05 13:20:52.045  - error: host.iobroker-host iobroker (node:19932) UnhandledPromiseRejectionWarning: Error: Connection is closed.    at close (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:115:25)    at Socket.<anonymous> (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:82:20)    at Object.onceWrapper (events.js:315:30)    at emitOne (events.js:116:13)    at Socket.emit (events.js:211:7)    at TCP._handle.close [as _onclose] (net.js:561:12)(node:19932) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 1)(node:19932) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code.
2019-10-05 13:20:53.043  - info: host.iobroker-host iobroker exit 0

Hilft das weiter?

Uninstall

2019-10-05 13:24:46.024  - info: host.iobroker-host iobroker del shelly
2019-10-05 13:24:47.014  - info: host.iobroker-host iobroker Delete adapter "shelly"
2019-10-05 13:24:47.037  - info: host.iobroker-host iobroker host.iobroker-host Counted 1 instances of shelly
2019-10-05 13:24:47.042  - info: host.iobroker-host iobroker host.iobroker-host Counted 1 adapter for shelly
2019-10-05 13:24:47.060  - info: host.iobroker-host iobroker host.iobroker-host Counted 1 channels of shelly
2019-10-05 13:24:47.158  - info: host.iobroker-host iobroker host.iobroker-host Counted 14 states of shelly
2019-10-05 13:24:47.211  - info: host.iobroker-host iobroker host.iobroker-host Deleting 17 object(s).
2019-10-05 13:24:48.038  - info: host.iobroker-host object deleted system.adapter.shelly.0
2019-10-05 13:24:48.043  - info: host.iobroker-host iobroker npm uninstall iobroker.shelly --silent --save --prefix "/opt/iobroker" (System call)
2019-10-05 13:24:48.204  - error: host.iobroker-host Cannot write files: /opt/iobroker/iobroker-data/files/shelly.admin/_data.json: ENOENT: no such file or directory, open '/opt/iobroker/iobroker-data/files/shelly.admin/_data.json'
2019-10-05 13:25:00.031  - info: host.iobroker-host instance system.adapter.poolcontroller.0 started with pid 27732
2019-10-05 13:25:14.532  - info: host.iobroker-host iobroker exit 0

[SBorg]

@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:

@SBorg Ok, Dashboard wie gesagt tut bei mir und anderen ... ich weiss nicht hilfreich für dich, aber ürde ich gerade nicht dem controller anlasten

Ist auch keinerlei Kritik und ich kann es auch nachvollziehen, gerade wenn man es selbst nicht provozieren kann. Ich weiß deinen Einsatz und Engagement auch zu würdigen :+1:
Ich weiß halt nicht wie viele Tester das Dashboard nutzen. Broadlink und DasWetter fielen ja auch zuerst nicht auf, außer bei mir ;) Irgendwie denke ich halt auch an das Release, gerade wenn es dann mehr User nutzen und es dann nicht geht...
Und nun natürlich noch das obligatorische a b e r...
Unter 1.5.14 und der Vor-Node-RED Version läuft das Dashboard. Nur mit der alten Red-Version kommt es ja zu Timing-Problemen mit dem JS 2.x. Da ich in der FireFox-Konsole Fehler mit socket.io (da gab es doch Änderungen?) habe beim aufrufen des Dashboards, tippe ich leider doch auf den JS-Controller?

[apollon77]

@sven12 beides ignore. Haben beide nichts zu sagen. Es halt alles geklappt.

[apollon77]

@SBorg dein Feedback und Tests sind auch super. Die Web Meldungen haben damit zu tun das der Browser Probleme hat mit dem Webserver den der node-red Prozess auf macht zu reden.
Das hat mit dem was der Controller da geändert hat nichts zu tun. Hast finden Browser Fehler bitte nochmal für mich? Mal danach gegoogelt?

[lobomau]

bei mir funktioniert der g-homa Adapter nicht mehr. Hat den jemand im Einsatz und hat Probleme seit js-controller 2.x?
Wenn ich anschalten will schaltet er gleich wieder aus. Dabei zappelt der VIS-Schalter (fancyswitch - Giva Labs iButton) paar mal hin- und her. Schaltbefehl über telegram geht auch nicht mehr und füht zum selben Problem. Ich habe auch dabei alle javascript Adapter ausgeschaltet um hier Fehler auszuschließen.
Log sagt:

g-homa.0	2019-10-05 14:52:23.574	debug	(3918) system.adapter.admin.1: logging true
g-homa.0	2019-10-05 14:51:29.908	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:29.908	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:29.907	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:29.907	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:29.810	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:51:29.810	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:51:29.810	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:51:29.810	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:51:29.809	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:51:29.806	debug	type: normal
g-homa.0	2019-10-05 14:51:29.806	debug	switched from: remote
g-homa.0	2019-10-05 14:51:29.806	debug	state: off
g-homa.0	2019-10-05 14:51:29.806	debug	(3918) Got updated info for Plug 4ce7ac:
g-homa.0	2019-10-05 14:51:28.616	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.615	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.615	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.614	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.553	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:51:28.553	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:51:28.552	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:51:28.552	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:51:28.552	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:51:28.549	debug	type: normal
g-homa.0	2019-10-05 14:51:28.549	debug	switched from: remote
g-homa.0	2019-10-05 14:51:28.549	debug	state: off
g-homa.0	2019-10-05 14:51:28.549	debug	(3918) Got updated info for Plug 4ce7ac:
g-homa.0	2019-10-05 14:51:28.500	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.500	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.499	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.499	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:28.405	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:51:28.404	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:51:28.404	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:51:28.404	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:51:28.403	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:51:28.400	debug	type: normal
g-homa.0	2019-10-05 14:51:28.400	debug	switched from: remote
g-homa.0	2019-10-05 14:51:28.400	debug	state: on
g-homa.0	2019-10-05 14:51:28.400	debug	(3918) Got updated info for Plug 4ce7ac:
g-homa.0	2019-10-05 14:51:27.392	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:27.392	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:27.392	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:27.391	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:51:27.335	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:51:27.335	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:51:27.335	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:51:27.335	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:51:27.334	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:51:27.332	debug	type: normal
g-homa.0	2019-10-05 14:51:27.332	debug	switched from: remote
g-homa.0	2019-10-05 14:51:27.332	debug	state: on
g-homa.0	2019-10-05 14:51:27.332	debug	(3918) Got updated info for Plug 4ce7ac:
g-homa.0	2019-10-05 14:51:13.232	debug	(3918) system.adapter.admin.1: logging false
g-homa.0	2019-10-05 14:49:15.644	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:15.644	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:15.643	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:15.642	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:15.519	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:49:15.519	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:49:15.519	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:49:15.518	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:49:15.518	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:49:15.516	debug	type: normal
g-homa.0	2019-10-05 14:49:15.516	debug	switched from: remote
g-homa.0	2019-10-05 14:49:15.516	debug	state: off
g-homa.0	2019-10-05 14:49:15.516	debug	(3918) Got updated info for Plug 4ce7ac:
g-homa.0	2019-10-05 14:49:14.392	debug	(3918) powerFactor in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:14.392	debug	(3918) power in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:14.392	debug	(3918) current in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:14.391	debug	(3918) voltage in plug.energyMeasurement => false
g-homa.0	2019-10-05 14:49:14.294	debug	(3918) voltage != null: false
g-homa.0	2019-10-05 14:49:14.293	debug	(3918) power != null: false
g-homa.0	2019-10-05 14:49:14.293	debug	(3918) powerFactor != null: false
g-homa.0	2019-10-05 14:49:14.292	debug	(3918) current != null: false
g-homa.0	2019-10-05 14:49:14.292	debug	(3918) extendPlug: type = normal, energyMeasurement != null: true
g-homa.0	2019-10-05 14:49:14.289	debug	type: normal
g-homa.0	2019-10-05 14:49:14.289	debug	switched from: remote
g-homa.0	2019-10-05 14:49:14.289	debug	state: off
g-homa.0	2019-10-05 14:49:14.289	debug	(3918) Got updated info for Plug 4ce7ac:

[apollon77]

@lobomau Dann leg doch mal bei ghoma ein Issue an ...

[apollon77]

@lobomau Alternativ leg doch mal ein Subscribe im Javascript adapter auf den relevanten State und logge alle Änderungen mit state.val, state.ack und state.from Vllt wird man daraus schlauer

[SBorg]

@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:

@SBorg ...Das hat mit dem was der Controller da geändert hat nichts zu tun. Hast finden Browser Fehler bitte nochmal für mich? Mal danach gegoogelt?

Da bist du der Fachmann :)
Google hat zwar einiges zu Tage gefördert, aber wie üblich, wenn es interessant wird verläuft es im Sand...
Der socket.io kommt dann im paar Sekundentakt, wobei ich nicht weiß, ob die beiden ersten schon immer da waren:

Bringt es vielleicht etwas meine Flows zu sichern und Node-RED mal kpl. zu de-/neuinstallieren? Ev. hat es bei dem testen einfach nur bei mir was zerschossen...

[darkiop]

@apollon77 Mein iobroker-hwr läuft unter init.d und der iobroker-master im Container.

Blöderweise schreibt das Diet Pi auch kein syslog in der Standardconfig, d.h. ich habe da aktuell auch keines.

Ich mache jetzt folgendes:

Ich nehm ne neue SD Karte und setze den HWR mit Rasbian neu auf.

Des weiteren werd ich noch einen zweiten Docker Container mit iobroker als Salve für die Tests starten.

[sven12]

@apollon77
Sorry für die Umstände... Shelly auf 3.1.1 hoch gezogen, keine Änderung.
Reboot ,
Jetzt läuft der Shelly Adapter ohne Probleme..

Also wie immer Reboot tut gut...

[apollon77]

@SBorg sagte in [Aufruf] js-controller 2.0 Beta Test:

Bringt es vielleicht etwas meine Flows zu sichern und Node-RED mal kpl. zu de-/neuinstallieren? Ev. hat es bei dem testen einfach nur bei mir was zerschossen...

versuch das mal.

Die Meldung zeigt das er versucht zum Port 1880 von node-red zu verbunden und der Server das ablehnt.

[apollon77]

@darkiop Ok, Ansonsten: Wenn init.d dann schau mal ob in /opt/iobroker/node_modules/iobroker.js-controller/lib ein iobroker.pid File liegt wenn der sauber gestartet wurde und läuft. Wenn ja sollte das restart eigentlich tun. Wenn nein ist da was komisch

[darkiop]

@apollon77

Also, hier mal ein kleiner Zwischenstand:

Ich habe den iobroker-hwr neu aufgesetzt - mit dem aktuellen Rasbian lite + Node 10 + iobroker 2.0.22.

Und, du wirst es nicht glauben, das IPv4/Reconnect Thema scheint hier erledigt zu sein ... also liegt die Vermutung nahe das es an Diet Pi lag ... Habe nun mehrmals schon den Master abgewürgt, und jedes mal nachdem er wieder hochgefahren war, war auch der Slave wieder verbunden.

Der automatische Restart unter systemd auf dem RPI funktioniert ebenfalls.

Werd das jetzt mal so über Nacht laufen lassen und Morgen dann nochmal den Skript Export testen (aktuell kommt da immer noch der Hinweis auch auf die fehlende Package.zip).

[Stabilostick]

@darkiop Glückwunsch!

[darkiop]

@Stabilostick Ich frage mich aber gerade was hier seitens Diet Pi eingespart wurde damit es zu diesem Verhalten gekommen ist. Immerhin bleibt die Erfahrung :)

[apollon77]

@darkiop Cooooool, wieder ein Thema was sich "von selbst erledigt" ;-)
Ok, das was ich gefixt habe waren ungültige Downloads (also ZIP Files die keine waren).
Das es gar nicht ging hatte ich nicht

[Stabilostick]

@darkiop
OT: Du warst der Auslöser :grinning: -> https://forum.iobroker.net/post/307432

[darkiop]

@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:

Cooooool, wieder ein Thema was sich "von selbst erledigt"

Ja, wobei hier immerhin die Erkenntnis mit IPv6 herauskam ... :)

Ok, das was ich gefixt habe waren ungültige Downloads (also ZIP Files die keine waren).
Das es gar nicht ging hatte ich nicht

Das schau ich mir heut nochmal mit 1.5 - dazu bin ich gestern leider nicht mehr gekommen.

Blöderweise sind mir heute Nacht auch sämtliche ioboker Container stecken geblieben (um 23 Uhr liefen sie noch :)) - d.h. meine Beobachtung über Nacht muss ich auf Morgen schieben.

[darkiop]

@darkiop sagte in [Aufruf] js-controller 2.0 Beta Test:

Das schau ich mir heut nochmal mit 1.5 - dazu bin ich gestern leider nicht mehr gekommen.

Unter 1.5 passiert einfach mal gar nichts .... keine Meldung über eine fehlende Package.zip, keine Logs ... :)

Also ich würde mal behaupten der Fehler liegt hier nicht bei der 2.0.x

[AlCalzone]

@lobomau sagte in [Aufruf] js-controller 2.0 Beta Test:

Hat den jemand im Einsatz und hat Probleme seit js-controller 2.x?

Habs gerade nochmal bei mir probiert. Keine Probleme. Wüsste auch nicht, was Controller 2.0 damit zu tun haben könnte.