Server Cannot start inMem-objects on port 9001

[apollon77]

@david-g sieht man auch nix ... geht direkt quasi mit dem Reboot los

EDIT:
Und das hier sagt das auf jeden Fall was vorher nicht sauber war:

Sep  1 00:20:51 pi kernel: [    2.257844] EXT4-fs (sda2): INFO: recovery required on readonly filesystem
Sep  1 00:20:51 pi kernel: [    2.257887] EXT4-fs (sda2): write access will be enabled during recovery
Sep  1 00:20:51 pi kernel: [    2.489092] EXT4-fs (sda2): orphan cleanup on readonly fs
Sep  1 00:20:51 pi kernel: [    2.504177] EXT4-fs (sda2): 7 orphan inodes deleted
Sep  1 00:20:51 pi kernel: [    2.504220] EXT4-fs (sda2): recovery complete
Sep  1 00:20:51 pi kernel: [    2.511628] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.

Aber ja ... fals vorher das Filesystem auf Read only gegangen ist dann ist es ja klar das im log nix steht Also vllt auch ein Filesystem issue

[Thomas Braun]

@apollon77

Da fehlt auch ein ganzer Tag:

Aug 30 17:03:57 pi kernel: [   31.832347] cam-dummy-reg: disabling
Sep  1 00:20:51 pi kernel: [    0.000000] Booting Linux on physical CPU 0x0

[Edit:] Kann aber sein, das kern.log ist nicht sooooo geschwätzig. Das hält auch schon mal lange den Rand

[Rene 3]

@thomas-braun 2802 info run @abandonware/bluetooth-hci-socket@0.5.3-8 install node_modules/@abandonware/bluetooth-hci-socket node-pre-gyp install --fallback-to-build
2803 info run @abandonware/noble@1.9.2-15 install node_modules/@abandonware/noble node-gyp rebuild
2804 info run @serialport/bindings-cpp@10.7.0 install node_modules/@serialport/bindings-cpp node-gyp-build
2805 info run diskusage@1.1.3 install node_modules/diskusage node-gyp rebuild
2806 info run @serialport/bindings-cpp@10.7.0 install { code: 0, signal: null }
2807 timing build:run:install:node_modules/@serialport/bindings-cpp Completed in 777ms
2808 info run iobroker.js-controller@4.0.23 install node_modules/iobroker.js-controller node iobroker.js setup first
2809 info run @abandonware/noble@1.9.2-15 install { code: 0, signal: null }
2810 timing build:run:install:node_modules/@abandonware/noble Completed in 5409ms
2811 info run iobroker.vis@1.4.15 install node_modules/iobroker.vis node main.js --install
2812 info run diskusage@1.1.3 install { code: 0, signal: null }
2813 timing build:run:install:node_modules/diskusage Completed in 9604ms
2814 info run unix-dgram@2.0.4 install node_modules/unix-dgram node-gyp rebuild
2815 info run @abandonware/bluetooth-hci-socket@0.5.3-8 install { code: 0, signal: null }
2816 timing build:run:install:node_modules/@abandonware/bluetooth-hci-socket Completed in 11107ms
2817 info run ursa-optional@0.9.10 install node_modules/ursa-optional node rebuild.js
2818 info run unix-dgram@2.0.4 install { code: 0, signal: null }
2819 timing build:run:install:node_modules/unix-dgram Completed in 7218ms
2820 info run usb@1.9.2 install node_modules/usb node-gyp-build
2821 info run iobroker.vis@1.4.15 install { code: 0, signal: null }
2822 timing build:run:install:node_modules/iobroker.vis Completed in 12268ms
2823 info run ursa-optional@0.9.10 install { code: 0, signal: null }
2824 timing build:run:install:node_modules/ursa-optional Completed in 7634ms
2825 info run iobroker.js-controller@4.0.23 install { code: 22, signal: null }
2826 info run usb@1.9.2 install { code: 1, signal: null }
2827 verbose reify failed optional dependency /opt/iobroker/node_modules/usb
2828 silly reify mark deleted [ '/opt/iobroker/node_modules/usb' ]
2829 verbose reify failed optional dependency /opt/iobroker/node_modules/usb/node_modules/node-addon-api
2830 silly reify mark deleted [ '/opt/iobroker/node_modules/usb/node_modules/node-addon-api' ]
2831 timing build:run:install:node_modules/usb Completed in 17022ms
2832 timing reify:rollback:createSparse Completed in 4803ms
2833 timing reify:rollback:retireShallow Completed in 0ms
2834 timing command:i Completed in 111659ms
2835 verbose stack Error: command failed
2835 verbose stack at ChildProcess.<anonymous> (/usr/lib/node_modules/npm/node_modules/@npmcli/promise-spawn/lib/index.js:63:27)
2835 verbose stack at ChildProcess.emit (events.js:400:28)
2835 verbose stack at maybeClose (internal/child_process.js:1088:16)
2835 verbose stack at Socket.<anonymous> (internal/child_process.js:446:11)
2835 verbose stack at Socket.emit (events.js:400:28)
2835 verbose stack at Pipe.<anonymous> (net.js:686:12)
2836 verbose pkgid iobroker.js-controller@4.0.23
2837 verbose cwd /opt/iobroker
2838 verbose Linux 5.15.61-v7l+
2839 verbose node v14.20.0
2840 verbose npm v8.18.0
2841 error code 22
2842 error path /opt/iobroker/node_modules/iobroker.js-controller
2843 error command failed
2844 error command sh -c -- node iobroker.js setup first
2845 error No connection to databases possible ...
2846 verbose exit 22
2847 timing npm Completed in 111982ms
2848 verbose unfinished npm timer reify 1661968356534
2849 verbose unfinished npm timer reify:build 1661968431876
2850 verbose unfinished npm timer build 1661968431885
2851 verbose unfinished npm timer build:deps 1661968431886
2852 verbose unfinished npm timer build:run:install 1661968433965
2853 verbose unfinished npm timer build:run:install:node_modules/iobroker.js-controller 1661968434911
2854 verbose code 22
2855 error A complete log of this run can be found in:
2855 error /home/iobroker/.npm/_logs/2022-08-31T17_52_36_224Z-debug-0.log
vielleicht hilft das ( der Pfad ) ?

[Thomas Braun]

@rene-3

Bitte CodeTags verwenden. Danke.
Und wozu gehört die Ausgabe? Zusammenhang?

[Rene 3]

@thomas-braun also dachte eigentlich das immer noch gesucht wird wo man genau die Ursachen für den Crash findet ( für alle die, deren Raspi noch nicht wieder läuft )

Wie stell ich das mit den CodeTags an / finde ich da was dazu in der Doku ?
Sorry

[Glasfaser]

@rene-3 sagte in Server Cannot start inMem-objects on port 9001:

Wie stell ich das mit den CodeTags an / finde ich da was dazu in der Doku ?

https://forum.iobroker.net/topic/51555/hinweise-für-gute-forenbeiträge

[Rene 3]

@glasfaser Danke

[apollon77]

@rene-3 sagte in Server Cannot start inMem-objects on port 9001:

@thomas-braun also dachte eigentlich das immer noch gesucht wird wo man genau die Ursachen für den Crash findet ( für alle die, deren Raspi noch nicht wieder läuft )

Ja aber DU hast eine Ausgabe gepostet ohne die Infos wie diese zusatdnegekommen ist. Welchen befehl hast Du ausgeführt das die so kam?

[Rene 3]

@apollon77 also ich suche hier eigentlich sämtliche Log Files auf meinem Raspi ab und werde einfach nicht schlau weshalb der iobroker plötzlich nicht mehr laufen will - der Raspi geht - also ich kann hier Netzteil / USV etc. ausschließen

[Thomas Braun]

@rene-3 sagte in Server Cannot start inMem-objects on port 9001:

node v14.20.0

Könntest du schon mal auf die derzeitig empfohlene Version nodejs 16 bringen.

[Rene 3]

@thomas-braun es geht nicht nodejs zu aktualisieren

cd /opt/iobroker
iobroker list instances 

gibt aus:

Server cannot start inMem-Objects on Port 9001: Failed to lock DB " opt/iobroker/iobroker-data/objects.jsonl"!

da sollte ja eine andere Ausgabe kommen

[apollon77]

@rene-3 Na dann beantworte doch mal die Fragen die ich oben gestellt habe und lass es uns strukturiert angehen.

jetzt mal zuerst mal "iob stop" und prüfe das nichts mehr läuft.

Wenn Du jetzt "iob status" ausführst was kommt? geht das oder kommt ein Fehler?
EDIT: Ok das hast Du gerade gezeigt, also weiter mit dem nächsten
EDIT2: Oder vllt doch nochmal alles von vorn und vorher iobroker stoppen!!

Wenn Fehler dann bitte mal den Inhalt von /opt/iobroker/iobroker-data zeigen (Ausgabe von ssh mti einem "ls -la /opt/iobroker/iobroker-data". Und dazu ein "date".

@Thomas-Braun Lass es uns bitte erstmal zum laufen bekommen und nicht mit node.js spass anfangen.

[Rene 3]

@apollon77 und @Thomas-Braun
also nach iob stop
und iobroker status
erhalte ich als Ausgabe:

No connection to database possible ...

[apollon77]

@rene-3 Jetzt arbeite bitte meinen letzten Post bis zum Ende durch

[Rene 3]

@apollon77 ```

pi@ReneRaspel:~ $ iob stop
pi@ReneRaspel:~ $ iobroker status
No connection to databases possible ...
pi@ReneRaspel:~ $ ls -la /opt/iobroker/iobroker-data
insgesamt 1105944
drwxrwxr-x+  8 iobroker iobroker       4096  2. Sep 22:49 .
drwxrwxr-x+  6 iobroker iobroker       4096  1. Sep 11:58 ..
drwxrwxr-x+  2 iobroker iobroker       4096 21. Aug 02:40 backitup
drwxrwxr-x+  2 iobroker iobroker      12288 29. Aug 06:40 backup-objects
drwxrwxr-x+ 26 iobroker iobroker       4096 27. Jun 19:27 files
drwxrwxr-x+ 14 iobroker iobroker       4096 29. Aug 08:24 history
drwxrwxr-x+  2 iobroker iobroker       4096 10. Mär 20:00 homekit-controller.0
-rw-rwxr--+  1 iobroker iobroker       5087  9. Feb 2022  iobroker.json
-rw-rwxr--+  1 iobroker iobroker          3 29. Aug 08:24 notifications.json
-rw-rwxr--+  1 iobroker iobroker    6008528  9. Feb 2022  objects.json.bak.migrated
-rw-rwxr--+  1 iobroker iobroker 1118225842 29. Aug 08:24 objects.jsonl
-rw-rwxr--+  1 iobroker iobroker    6008525  9. Feb 2022  objects.json.migrated
-rw-rwxr--+  1 iobroker iobroker      92518  9. Feb 2022  states.json.bak.migrated
-rw-rwxr--+  1 iobroker iobroker    1993265 29. Aug 08:24 states.jsonl
-rw-rwxr--+  1 iobroker iobroker      92661  9. Feb 2022  states.json.migrated
drwxrwxr-x+  2 iobroker iobroker       4096 11. Mär 17:06 yahka.0.hapdata
pi@ReneRaspel:~ $ 

Date ist 02.09.2022

[apollon77]

@rene-3 Wow 1,1GB objects.json ... welcher js-controller ist das denn?

Ok, hier sind wir bei timeout seeehr hoch setzen das der erste start das aufräumen kann.

Bitte poste mal den Inhalt von /opt/iobroker/iobroker-data/iobroker.json

[Rene 3]

@apollon77 Zugriff nicht möglich / Datei oder Verzeichnis nicht gefunden

mit

ls -la

und

ls -lh

probiert oder nur mit

ls

komme ich einfach nicht zum Inhalt - und fliege da wieder raus

[Rene 3]

@apollon77 sorry - quatsch muss mit " cd " dahin - dauert noch !

[Rene 3]

@apollon77 also ich bin jetzt zwar im richtigen Pfad aber hab keinen Plan wie ich die iobroker.json öffne oder mir den Inhalt irgendwie sichtbar machen kann

[Rene 3]

@apollon77 ich mache für heute Schluss. Guts Nächtle.

Habe noch mal die gleichen Dateien von @radicalreel herangezogen - es scheint was mit dem Datumsformat teilweise bei mir nicht mehr zu stimmen.
Mal werden diese mit TT MM JJJJ und mal mit TT MM Time angezeigt.
Ob es von diesem ewt. kommt ?