FHEM Forum

FHEM => Anfängerfragen => Thema gestartet von: KFK-mpg am 26 September 2015, 15:33:41

Titel: Permission Denied COC disconnected
Beitrag von: KFK-mpg am 26 September 2015, 15:33:41
Hi,

ich bin heute auf einen Raspberry Pi 2 mit Fhem gewechselt. Zudem habe ich nocht auf Rasbian Jessie aktualisiert. Seit dem funktionieren die HomeMatic Aktoren nicht mehr. FHEM sagt, das der COC disconnected wäre bzw. im Log steht folgendes:


2015.09.26 15:26:30 3: Opening COC device /dev/ttyAMA0
2015.09.26 15:26:31 3: Can't open /dev/ttyAMA0: Permission denied


FHEM: 5.6 (auch mit Update schon aktualisiert)
Rasbian Jessie
COC auch versucht zu Flashen bzw. er Blinkt wie immer :)

FHEM habe ich auch schon als sudoers hinzugefügt.
Habt Ihr vll noch eine Idee oder kennt das Problem und habt es gelöst?

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 26 September 2015, 20:28:13
Hallo,

dann prüfe doch das, was die Fehlermeldung sagt. Welche Berechtigungen hat den "/dev/ttyAMA0" ?
Einfach in das Verzeichnis dev wechseln (cd /dev) und "ls -la ttyAMA0" eingeben. Dann bekommst Du den Benutzer und die Gruppe sowie die Berechtigungen angezeigt. Eventuell muss der User fhem einer Speziellen Gruppe zugeordent werden, damit er das Gerät ansprechen kann. Sudo hat da nichts mit zu tun.

Gruß Christoph
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 26 September 2015, 21:06:55
Hi,

schon fleißig dabei :)

ls -la ergab folgendes:

crw--w---- 1 root tty 204, 64 Sep 26 20:58 /dev/ttyAMA0

Entsprechend habe ich pi + fhem der Grupper tty und root zugeordnet. Jedoch wird der COC immer noch als disconnected ausgezeichnet.

/etc/group:

root:x:0:fhem,pi
...
tty:x:5:pi,fhem
...
dialout:x:20:pi,fhem


Hast du vll noch eine Idee?

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 26 September 2015, 21:28:45
Hallo,

ist der COC den überhaupt /dev/ttyAMA0 ? Also ich würde den COC rausziehen. Dann mal "dmesg" aufrufen. Anschließen wieder einstecken und mit "dmesg" aufrufen. Da müsste dann stehen ob und als was der COC erkannt wurde. Alternativ mal mit "lsusb" schauen, was für USB Geräte erkannt wurden.
Ich habe keine COC - das ist reines Linux Grundwissen, aber vielleicht kannst Du damit sehen, was schief läuft.

Gruß Christoph
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 26 September 2015, 23:53:58
Bin jetzt nochmal auf den alten Raspberry Pi gewechselt und habe entsprechend den COC (radio only) umgesteckt.
Version: 1.61

Hier wird der Coc wieder erkannt und initialisiert. Jedoch schaltet er mal wieder gar nicht und scheint auch nichts zu bekommen (ACK_Missing). Auch ein neu anlernen von Aktoren funktioniert nicht.

Habt ihr vll eine rettende Idee?
Was ich auch komisch finde: der COC blinkt völlig normal. Versuche ich jedoch zum Beispiel Licht anzuschalten, hört er kurzzeitig auf zu blinken, blinkt ein kurzes mal schwach auf und danach blinkt er normal weiter. Ist das normal?

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 27 September 2015, 14:58:41
Sooo,

ich habe nochmal den RPI2 mit allem FHEM 5.6 und Debian neu installiert. Aktuell wird der COC initialisiert und scheint soweit zu funktionieren. Jedoch beim Versuch, Aktoren anzulernen, passiert leider nichts.

Folgende Konfiguration liegt vor:

define CUL_0 CUL /dev/ttyAMA0@38400 1234
attr CUL_0 hmId 123ABC
attr CUL_0 rfmode HomeMatic


Logfile im Verbose 5:


2015.09.27 14:53:03 4: Connection accepted from FHEMWEB:127.0.0.1:48266
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48266 GET /fhem&detail=CUL_0&dev.setCUL_0=CUL_0&cmd.setCUL_0=set&arg.setCUL_0=hmPairForSec&val.setCUL_0=600
2015.09.27 14:53:03 5: Cmd: >set CUL_0 hmPairForSec 600<
2015.09.27 14:53:03 5: Triggering CUL_0 (1 changes)
2015.09.27 14:53:03 5: Notify loop for CUL_0 hmPairForSec 600
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48266 GET /fhem?detail=CUL_0
2015.09.27 14:53:03 4: 2440:FHEMWEB:127.0.0.1:48266: /fhem?detail=CUL_0 / RL:2773 / text/html; charset=UTF-8 / Content-Encoding: gzip
/
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48263 GET /fhem/pgm2/jquery-ui.min.js
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48258 GET /fhem/pgm2/fhemweb_knob.js
2015.09.27 14:53:03 4: Connection closed for FHEMWEB:127.0.0.1:48258: EOF
2015.09.27 14:53:03 4: Connection accepted from FHEMWEB:127.0.0.1:48267
2015.09.27 14:53:03 4: Connection accepted from FHEMWEB:127.0.0.1:48268
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48267 GET /fhem/pgm2/fhemweb_sortable.js
2015.09.27 14:53:03 4: HTTP FHEMWEB:127.0.0.1:48268 GET /fhem/pgm2/fhemweb_readingsGroup.js
2015.09.27 14:53:03 4: Connection closed for FHEMWEB:127.0.0.1:48268: EOF
2015.09.27 14:53:03 4: Connection closed for FHEMWEB:127.0.0.1:48267: EOF
2015.09.27 14:53:03 4: Connection closed for FHEMWEB:127.0.0.1:48263: EOF
2015.09.27 14:53:04 4: HTTP FHEMWEB:127.0.0.1:48266 GET /fhem?cmd={ReadingsVal(%22CUL_0%22,%22bWidth%22,%22%22)}&XHR=1
2015.09.27 14:53:04 5: Cmd: >{ReadingsVal("CUL_0","bWidth","")}<
2015.09.27 14:53:04 4: 2440:FHEMWEB:127.0.0.1:48266: /fhem?cmd={ReadingsVal(%22CUL_0%22,%22bWidth%22,%22%22)}&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.09.27 14:53:04 4: Connection accepted from FHEMWEB:127.0.0.1:48269
2015.09.27 14:53:04 4: Connection accepted from FHEMWEB:127.0.0.1:48270
2015.09.27 14:53:04 4: HTTP FHEMWEB:127.0.0.1:48269 GET /fhem?cmd={AttrVal(%22CUL_0%22,%22room%22,%22%22)}&XHR=1
2015.09.27 14:53:04 5: Cmd: >{AttrVal("CUL_0","room","")}<
2015.09.27 14:53:04 4: 2440:FHEMWEB:127.0.0.1:48269: /fhem?cmd={AttrVal(%22CUL_0%22,%22room%22,%22%22)}&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2015.09.27 14:53:04 4: HTTP FHEMWEB:127.0.0.1:48270 GET /fhem/images/default/icoEverything.png
2015.09.27 14:53:04 4: Connection accepted from FHEMWEB:127.0.0.1:48271
2015.09.27 14:53:04 4: HTTP FHEMWEB:127.0.0.1:48271 GET /fhem?XHR=1&inform=type=status;filter=CUL_0;since=1443358382;fmt=JSON×tamp=1443358384190
2015.09.27 14:53:04 4: Connection closed for FHEMWEB:127.0.0.1:48270: EOF
2015.09.27 14:54:01 4: Connection closed for FHEMWEB:127.0.0.1:48271: EOF
2015.09.27 14:54:01 4: HTTP FHEMWEB:127.0.0.1:48269 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2015-09.log


Leider wird für mich nicht erkenntlich, wo das Problem liegt, warum die Aktoren nicht angelernt werden.

Habt Ihr Ideen?

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 27 September 2015, 17:27:29
Hallo,

also in dem Logfile kann ich nichts finden, was irgendwie darauf hindeutet, das der CUL gesendet oder etwas empfangen hat. Schau doch mal im WIKI unter Homematic, da gibt es eine Anleitung um den Funkverkehr mitzuchneiden http://www.fhemwiki.de/wiki/Homematic_Nachrichten_sniffen.
Dann kannst Du einfach am HM Gerät etwas ändern (Schalten oder anlernen drücken) und dann sollte etwas im Log ankommen. Wenn nicht, dann stimmt noch etwas Grundsätzliches nicht.

Gruß Christoph
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 29 September 2015, 22:14:04
Abend,

ich habe nochmal versucht den COC zu sniffen,
leider jedoch ohne erfolg. Es wird nicht in irgendeiner Art mit gelogen.


2015.09.29 21:59:48.212 4: Connection closed for FHEMWEB:192.168.178.21:55380: EOF
2015.09.29 21:59:48.515 4: Connection closed for FHEMWEB:192.168.178.21:55406: EOF
2015.09.29 21:59:48.517 4: Connection closed for FHEMWEB:192.168.178.21:55402: EOF
2015.09.29 21:59:48.518 4: Connection closed for FHEMWEB:192.168.178.21:55381: EOF
2015.09.29 21:59:48.519 4: Connection closed for FHEMWEB:192.168.178.21:55384: EOF
2015.09.29 22:09:54.041 4: Connection closed for FHEMWEB:192.168.178.21:55379: EOF
2015.09.29 22:09:54.046 4: Connection accepted from FHEMWEB:192.168.178.21:55704
2015.09.29 22:09:54.048 4: HTTP FHEMWEB:192.168.178.21:55704 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2015-09.log


Jetzt weiß ich erstmal Grundsätzlich nicht weiter :(

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 30 September 2015, 07:18:33
Hallo,

bist Du Dir mit dem TTY Port sicher. Mache doch mal folgendes. Raspi starten, als pi oder fhem einloggen, den Befehl "dmesg" (natütlich ohne ") eingeben. Dann kannst Du die Systemmeldungen lesen. Jetzt erst den CUL einstecken und moch einmal mit "dmesg" nachsehen, was das System zu dem Stick sagt. Das Ergebnis mal hier posten (nur die letzten relevanten Zeilen) - daran kann man dann erst einmal grundsätzlich sehen ob und als was der Stick erkannt wird.

Gruß Christoph
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 05 Oktober 2015, 06:48:41
Hi,

also ich hab nochmal geschaut, kann jedoch keinen Unteschied finden. Ich weiß jedoch auch nicht wie der COC über die GPIOs behandelt wird.

Hier die Variante ohne COC:


[    3.363521] hid-generic 0003:0E8F:0022.0001: input,hidraw0: USB HID v1.10 Keyboard [GASIA USB KB V11] on usb-3f980000.usb-1.2/input0
[    3.393733] input: GASIA USB KB V11 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.1/0003:0E8F:0022.0002/input/input1
[    3.463523] hid-generic 0003:0E8F:0022.0002: input,hidraw1: USB HID v1.10 Device [GASIA USB KB V11] on usb-3f980000.usb-1.2/input1
[    3.484091] udevd[175]: starting version 175
[    3.563195] usb 1-1.4: new low-speed USB device number 5 using dwc_otg
[    3.681745] usb 1-1.4: New USB device found, idVendor=046d, idProduct=c069
[    3.695422] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    3.709437] usb 1-1.4: Product: USB Laser Mouse
[    3.720584] usb 1-1.4: Manufacturer: Logitech
[    3.746025] input: Logitech USB Laser Mouse as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/0003:046D:C069.0003/input/input2
[    3.783857] hid-generic 0003:046D:C069.0003: input,hidraw2: USB HID v1.10 Mouse [Logitech USB Laser Mouse] on usb-3f980000.usb-1.4/input0
[    4.308924] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    4.493241] usb 1-1.5: new full-speed USB device number 6 using dwc_otg
[    4.613605] usb 1-1.5: New USB device found, idVendor=1b1f, idProduct=c00f
[    4.627037] usb 1-1.5: New USB device strings: Mfr=4, Product=14, SerialNumber=36
[    4.641002] usb 1-1.5: Product: HM-CFG-USB
[    4.651536] usb 1-1.5: Manufacturer: eQ-3
[    4.661964] usb 1-1.5: SerialNumber: MEQ0231641
[    4.684071] hid-generic 0003:1B1F:C00F.0004: hiddev0,hidraw3: USB HID v1.10 Device [eQ-3 HM-CFG-USB] on usb-3f980000.usb-1.5/input0
[    6.370972] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    6.750546] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    6.929715] random: nonblocking pool is initialized
[   11.986099] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[   13.502609] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0x4DE1
[   15.325895] bcm2708 watchdog, heartbeat=10 sec (nowayout=0)
[   15.451096] cfg80211: Calling CRDA to update world regulatory domain
[   15.925311] Adding 102396k swap on /var/swap.  Priority:-1 extents:2 across:2134012k SSFS
[   18.603199] cfg80211: Calling CRDA to update world regulatory domain
[   20.606355] uart-pl011 3f201000.uart: no DMA platform data
[   21.372169] watchdog stopped
[   21.763159] cfg80211: Calling CRDA to update world regulatory domain
[   24.923185] cfg80211: Calling CRDA to update world regulatory domain
[   28.083293] cfg80211: Calling CRDA to update world regulatory domain
[   31.243305] cfg80211: Calling CRDA to update world regulatory domain
[   34.403338] cfg80211: Calling CRDA to update world regulatory domain
[   37.563308] cfg80211: Calling CRDA to update world regulatory domain
[   40.723342] cfg80211: Calling CRDA to update world regulatory domain
[   43.883400] cfg80211: Calling CRDA to update world regulatory domain
[   47.043424] cfg80211: Calling CRDA to update world regulatory domain
[   50.203447] cfg80211: Exceeded CRDA call max attempts. Not calling CRDA


und hier die mit:


[    3.270942] usb 1-1.2: Product: USB KB V11
[    3.280742] usb 1-1.2: Manufacturer: GASIA
[    3.303344] input: GASIA USB KB V11 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/0003:0E8F:0022.0001/input/input0
[    3.373435] hid-generic 0003:0E8F:0022.0001: input,hidraw0: USB HID v1.10 Keyboard [GASIA USB KB V11] on usb-3f980000.usb-1.2/input0
[    3.402068] udevd[175]: starting version 175
[    3.402680] input: GASIA USB KB V11 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.1/0003:0E8F:0022.0002/input/input1
[    3.453533] hid-generic 0003:0E8F:0022.0002: input,hidraw1: USB HID v1.10 Device [GASIA USB KB V11] on usb-3f980000.usb-1.2/input1
[    3.563146] usb 1-1.4: new low-speed USB device number 5 using dwc_otg
[    3.705608] usb 1-1.4: New USB device found, idVendor=046d, idProduct=c069
[    3.719307] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    3.733465] usb 1-1.4: Product: USB Laser Mouse
[    3.744965] usb 1-1.4: Manufacturer: Logitech
[    3.776079] input: Logitech USB Laser Mouse as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/0003:046D:C069.0003/input/input2
[    3.798098] hid-generic 0003:046D:C069.0003: input,hidraw2: USB HID v1.10 Mouse [Logitech USB Laser Mouse] on usb-3f980000.usb-1.4/input0
[    3.957292] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    4.483071] usb 1-1.5: new full-speed USB device number 6 using dwc_otg
[    4.601021] usb 1-1.5: New USB device found, idVendor=1b1f, idProduct=c00f
[    4.614918] usb 1-1.5: New USB device strings: Mfr=4, Product=14, SerialNumber=36
[    4.629666] usb 1-1.5: Product: HM-CFG-USB
[    4.641083] usb 1-1.5: Manufacturer: eQ-3
[    4.652422] usb 1-1.5: SerialNumber: MEQ0231641
[    4.674866] hid-generic 0003:1B1F:C00F.0004: hiddev0,hidraw3: USB HID v1.10 Device [eQ-3 HM-CFG-USB] on usb-3f980000.usb-1.5/input0
[    6.034007] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    6.355320] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    6.881000] random: nonblocking pool is initialized
[   11.537968] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[   13.054109] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0x4DE1
[   14.919054] bcm2708 watchdog, heartbeat=10 sec (nowayout=0)
[   15.049867] cfg80211: Calling CRDA to update world regulatory domain
[   15.523785] Adding 102396k swap on /var/swap.  Priority:-1 extents:2 across:2134012k SSFS
[   18.203124] cfg80211: Calling CRDA to update world regulatory domain
[   20.201455] watchdog stopped
[   20.327606] uart-pl011 3f201000.uart: no DMA platform data
[   21.363142] cfg80211: Calling CRDA to update world regulatory domain
[   24.523131] cfg80211: Calling CRDA to update world regulatory domain
[   27.683210] cfg80211: Calling CRDA to update world regulatory domain
[   30.843209] cfg80211: Calling CRDA to update world regulatory domain
[   34.003262] cfg80211: Calling CRDA to update world regulatory domain
[   37.163304] cfg80211: Calling CRDA to update world regulatory domain
[   40.323294] cfg80211: Calling CRDA to update world regulatory domain
[   43.483361] cfg80211: Calling CRDA to update world regulatory domain
[   46.643379] cfg80211: Calling CRDA to update world regulatory domain
[   49.803395] cfg80211: Exceeded CRDA call max attempts. Not calling CRDA


Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 05 Oktober 2015, 07:16:48
Hallo,

also Dein "dmesg" sagt, das Du einen Original HM-CFG-USB angeschlossen hast. Der wird nicht über ttyAMA0 angesprochen sondern als Netzwerkgerät mit Hilfe von "hmland". Wenn Du also den hmland installierst und einrichtest, dann sollten die Homematicgeräte wieder funktionieren.

Gruß Christoph
Titel: Antw:Permission Denied COC disconnected
Beitrag von: KFK-mpg am 06 Oktober 2015, 06:24:05
Das der HM-CFG-USB angeschlossen war, wusste ich und das er auch einen Treiber benötigt. Den habe ich mir besorgt, als ich merkte das der COC nicht mehr korrekt funktionierte. D.h. Es geht leider immer noch in den gleichen Logfiles um den COC, welcher über die Gpios angeschlossen wird, aber scheinbar nicht erkannt wird. Fragt sich nur Warum?

Viele Grüße
Daniel
Titel: Antw:Permission Denied COC disconnected
Beitrag von: Bennemannc am 06 Oktober 2015, 06:37:42
Hallo,

hast Du alles in der raspi-config richtig eingestellt ? Da gibt es beim PI 2 mehr als vorher.

Gruß Christoph