RFXCOM Help on RPi3 and Openhabian 2.3.0

I am running a RPI3 and OpenHabian 2.3.0. I am attempting to connect and setup 433Mhz Motion detectors by connecting a new RFXtrx433E USB HA controller.

I have read through lots, and lots of threads with others experiencing similar problems with this device but so far none of those solutions have worked for me.

Here is what I have done so far:

To setup a static USB location for the transceiver, I setup a symbolic link for the receiver. I don’t yet have multiple USB devices yet, but plan on adding a ZWave USB device soon.

sudo nano /etc/udev/rules.d/50-usb-serial.rules

Contents of the 50-usb-serial.rules file

SUBSYSTEM=="tty", ATTRS{idVendor}=="0403", ATTRS{product}=="RFXtrx433", SYMLINK+="ttyUSB-9999", GROUP="dialout", MODE="0666"

I confirmed my user running OH was in the dialout group:

openhabian@openhab:/etc/default$ groups
openhabian adm tty dialout cdrom sudo audio video plugdev games users input netdev openhab gpio i2c spi

Added the new ttyUSB-9999 directory into the EXTRA JAVA options:

 sudo nano /etc/default/openhab2

Added the new directory to the EXTRA_JAVA_OPTIONS

EXTRA_JAVA_OPTS="-Dgnu.io.rxtx.SerialPorts=/dev/ttyUSB0:/dev/ttyS0:/dev/ttyS2:/dev/ttyACM0:/dev/ttyAMA0:/dev/ttyUSB-9999"

rebooted the RPi3

sudo shutdown -r now

After reboot, I confirmed the Symbolic link was setup

[22:58:54] openhabian@openhab:/etc/default$ ls -la /dev/ttyUSB*
crw-rw-rw- 1 root dialout 188, 1 Jul 28 22:25 /dev/ttyUSB1
lrwxrwxrwx 1 root root         7 Jul 28 22:24 /dev/ttyUSB-9999 -> ttyUSB1

Ran dmesg to view all connected devices to confirm USB1

[23:04:57] openhabian@openhab:/etc/default$ dmesg
[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.14.52-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1123 SMP Wed Jun 27 17:35:49 BST 2018
[    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] cma: Reserved 8 MiB at 0x3dc00000
[    0.000000] On node 0 totalpages: 255488
[    0.000000] free_area_init_node: node 0, pgdat 80c85000, node_mem_map bd336000
[    0.000000]   Normal zone: 2246 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 255488 pages, LIFO batch:31
[    0.000000] percpu: Embedded 17 pages/cpu @be59f000 s38720 r8192 d22720 u69632
[    0.000000] pcpu-alloc: s38720 r8192 d22720 u69632 alloc=17*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 253242
[    0.000000] Kernel command line: 8250.nr_uarts=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3f000000 vc_mem.mem_size=0x3f600000  dwc_otg.lpm_enable=0 console=tty1 root=PARTUUID=1610e9a8-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 990968K/1021952K available (7168K kernel code, 575K rwdata, 2072K rodata, 1024K init, 706K bss, 22792K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
                   vector  : 0xffff0000 - 0xffff1000   (   4 kB)
                   fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
                   vmalloc : 0xbe800000 - 0xff800000   (1040 MB)
                   lowmem  : 0x80000000 - 0xbe600000   ( 998 MB)
                   modules : 0x7f000000 - 0x80000000   (  16 MB)
                     .text : 0x80008000 - 0x80800000   (8160 kB)
                     .init : 0x80b00000 - 0x80c00000   (1024 kB)
                     .data : 0x80c00000 - 0x80c8fef4   ( 576 kB)
                      .bss : 0x80c96f40 - 0x80d47874   ( 707 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 25258 entries in 75 pages
[    0.000000] Hierarchical RCU implementation.
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000007] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000022] Switching to timer-based delay loop, resolution 52ns
[    0.000275] Console: colour dummy device 80x30
[    0.000806] console [tty1] enabled
[    0.000848] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.000888] pid_max: default: 32768 minimum: 301
[    0.001219] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001253] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002207] Disabling memory control group subsystem
[    0.002300] CPU: Testing write buffer coherency: ok
[    0.002710] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.003107] Setting up static identity map for 0x100000 - 0x10003c
[    0.003239] Hierarchical SRCU implementation.
[    0.003889] smp: Bringing up secondary CPUs ...
[    0.004593] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.005343] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.006077] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.006181] smp: Brought up 1 node, 4 CPUs
[    0.006252] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.006273] CPU: All CPU(s) started in HYP mode.
[    0.006291] CPU: Virtualization extensions available.
[    0.007171] devtmpfs: initialized
[    0.017060] random: get_random_u32 called from bucket_table_alloc+0xfc/0x24c with crng_init=0
[    0.017707] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[    0.017948] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.017992] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.018561] pinctrl core: initialized pinctrl subsystem
[    0.019325] NET: Registered protocol family 16
[    0.021916] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.026700] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.026732] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.026959] Serial: AMBA PL011 UART driver
[    0.028635] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.029112] uart-pl011 3f201000.serial: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe
[    0.060720] bcm2835-dma 3f007000.dma: DMA legacy API manager at be813000, dmachans=0x1
[    0.062164] SCSI subsystem initialized
[    0.062406] usbcore: registered new interface driver usbfs
[    0.062476] usbcore: registered new interface driver hub
[    0.062576] usbcore: registered new device driver usb
[    0.070084] raspberrypi-firmware soc:firmware: Attached to firmware from 2018-07-03 14:16
[    0.071379] clocksource: Switched to clocksource arch_sys_counter
[    0.147486] VFS: Disk quotas dquot_6.6.0
[    0.147601] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.147802] FS-Cache: Loaded
[    0.148017] CacheFiles: Loaded
[    0.156856] NET: Registered protocol family 2
[    0.157593] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.157723] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.157925] TCP: Hash tables configured (established 8192 bind 8192)
[    0.158072] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.158134] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.158377] NET: Registered protocol family 1
[    0.158844] RPC: Registered named UNIX socket transport module.
[    0.158868] RPC: Registered udp transport module.
[    0.158887] RPC: Registered tcp transport module.
[    0.158906] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.160369] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[    0.163120] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[    0.171065] FS-Cache: Netfs 'nfs' registered for caching
[    0.171719] NFS: Registering the id_resolver key type
[    0.171766] Key type id_resolver registered
[    0.171785] Key type id_legacy registered
[    0.171814] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.173717] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[    0.173866] io scheduler noop registered
[    0.173888] io scheduler deadline registered (default)
[    0.174178] io scheduler cfq registered
[    0.174199] io scheduler mq-deadline registered
[    0.174219] io scheduler kyber registered
[    0.176916] BCM2708FB: allocated DMA memory fdd10000
[    0.176961] BCM2708FB: allocated DMA channel 0 @ be813000
[    0.181919] Console: switching to colour frame buffer device 82x26
[    0.186678] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[    0.189359] bcm2835-rng 3f104000.rng: hwrng registered
[    0.190854] vc-mem: phys_addr:0x00000000 mem_base=0x3f000000 mem_size:0x3f600000(1014 MiB)
[    0.194036] vc-sm: Videocore shared memory driver
[    0.195648] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    0.207797] brd: module loaded
[    0.217788] loop: module loaded
[    0.219181] Loading iSCSI transport class v2.0-870.
[    0.221163] libphy: Fixed MDIO Bus: probed
[    0.222613] usbcore: registered new interface driver lan78xx
[    0.223975] usbcore: registered new interface driver smsc95xx
[    0.225261] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    0.454618] Core Release: 2.80a
[    0.455916] Setting default values for core params
[    0.457269] Finished setting default values for core params
[    0.658879] Using Buffer DMA mode
[    0.660232] Periodic Transfer Interrupt Enhancement - disabled
[    0.661665] Multiprocessor Interrupt Enhancement - disabled
[    0.663077] OTG VER PARAM: 0, OTG VER FLAG: 0
[    0.664467] Dedicated Tx FIFOs mode
[    0.666205] WARN::dwc_otg_hcd_init:1046: FIQ DMA bounce buffers: virt = 0xbdd04000 dma = 0xfdd04000 len=9024
[    0.668948] FIQ FSM acceleration enabled for :
               Non-periodic Split Transactions
               Periodic Split Transactions
               High-Speed Isochronous Endpoints
               Interrupt/Control Split Transaction hack enabled
[    0.675394] dwc_otg: Microframe scheduler enabled
[    0.675443] WARN::hcd_init_fiq:459: FIQ on core 1 at 0x805e7fa8
[    0.676772] WARN::hcd_init_fiq:460: FIQ ASM at 0x805e8310 length 36
[    0.678092] WARN::hcd_init_fiq:486: MPHI regs_base at 0xbe87e000
[    0.679432] dwc_otg 3f980000.usb: DWC OTG Controller
[    0.680786] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    0.682195] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
[    0.683568] Init: Port Power? op_state=1
[    0.684884] Init: Power Port (0)
[    0.686355] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    0.687701] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.689036] usb usb1: Product: DWC OTG Controller
[    0.690344] usb usb1: Manufacturer: Linux 4.14.52-v7+ dwc_otg_hcd
[    0.691686] usb usb1: SerialNumber: 3f980000.usb
[    0.693581] hub 1-0:1.0: USB hub found
[    0.694884] hub 1-0:1.0: 1 port detected
[    0.696582] dwc_otg: FIQ enabled
[    0.696587] dwc_otg: NAK holdoff enabled
[    0.696592] dwc_otg: FIQ split-transaction FSM enabled
[    0.696602] Module dwc_common_port init
[    0.696817] usbcore: registered new interface driver usb-storage
[    0.698218] mousedev: PS/2 mouse device common for all mice
[    0.699538] IR NEC protocol handler initialized
[    0.700803] IR RC5(x/sz) protocol handler initialized
[    0.702124] IR RC6 protocol handler initialized
[    0.703395] IR JVC protocol handler initialized
[    0.704608] IR Sony protocol handler initialized
[    0.705825] IR SANYO protocol handler initialized
[    0.707042] IR Sharp protocol handler initialized
[    0.708206] IR MCE Keyboard/mouse protocol handler initialized
[    0.709387] IR XMP protocol handler initialized
[    0.711215] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    0.712721] bcm2835-cpufreq: min=600000 max=1200000
[    0.714293] sdhci: Secure Digital Host Controller Interface driver
[    0.715533] sdhci: Copyright(c) Pierre Ossman
[    0.717096] mmc-bcm2835 3f300000.mmc: could not get clk, deferring probe
[    0.718668] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
[    0.720042] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.722738] ledtrig-cpu: registered to indicate activity on CPUs
[    0.724216] hidraw: raw HID events driver (C) Jiri Kosina
[    0.725718] usbcore: registered new interface driver usbhid
[    0.727054] usbhid: USB HID core driver
[    0.728923] vchiq: vchiq_init_state: slot_zero = bdd80000, is_master = 0
[    0.731566] [vc_sm_connected_init]: start
[    0.734996] vc_vchi_sm_init: failed to open VCHI service (-1)
[    0.735004] [vc_sm_connected_init]: failed to initialize shared memory service
[    0.737848] [vc_sm_connected_init]: end - returning -1
[    0.739957] Initializing XFRM netlink socket
[    0.741459] NET: Registered protocol family 17
[    0.743041] Key type dns_resolver registered
[    0.744894] Registering SWP/SWPB emulation handler
[    0.746896] registered taskstats version 1
[    0.754129] uart-pl011 3f201000.serial: cts_event_workaround enabled
[    0.755674] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
[    0.760065] 3f215040.serial: ttyS0 at MMIO 0x0 (irq = 166, base_baud = 31250000) is a 16550
[    0.763945] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    0.765487] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[    0.821984] sdhost: log_buf @ bdd07000 (fdd07000)
[    0.859709] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    0.862767] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    0.865766] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    0.869926] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    0.901407] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    0.903717] of_cfs_init
[    0.905097] of_cfs_init: OK
[    0.906781] Waiting for root device PARTUUID=1610e9a8-02...
[    0.923093] Indeed it is in host mode hprt0 = 00021501
[    0.991250] random: fast init done
[    1.050911] mmc1: new high speed SDIO card at address 0001
[    1.091690] mmc0: host does not support reading read-only switch, assuming write-enable
[    1.097947] mmc0: new high speed SDHC card at address aaaa
[    1.099699] mmcblk0: mmc0:aaaa ADLCD 29.7 GiB
[    1.103519]  mmcblk0: p1 p2
[    1.126129] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.128645] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.138006] devtmpfs: mounted
[    1.141447] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    1.142418] Freeing unused kernel memory: 1024K
[    1.144420] Indeed it is in host mode hprt0 = 00001101
[    1.381744] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    1.383352] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    1.385526] hub 1-1:1.0: USB hub found
[    1.387141] hub 1-1:1.0: 5 ports detected
[    1.684526] systemd[1]: System time before build time, advancing clock.
[    1.701428] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    1.806145] NET: Registered protocol family 10
[    1.808894] Segment Routing with IPv6
[    1.822055] ip_tables: (C) 2000-2006 Netfilter Core Team
[    1.831739] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    1.833376] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    1.837575] smsc95xx v1.0.6
[    1.843834] random: systemd: uninitialized urandom read (16 bytes read)
[    1.850633] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
[    1.856052] systemd[1]: Detected architecture arm.
[    1.881034] systemd[1]: Set hostname to <openhab>.
[    1.916890] random: systemd: uninitialized urandom read (16 bytes read)
[    1.926351] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:a4:3c:8c
[    1.937690] random: systemd-cryptse: uninitialized urandom read (16 bytes read)
[    2.021459] usb 1-1.3: new full-speed USB device number 4 using dwc_otg
[    2.196202] usb 1-1.3: New USB device found, idVendor=0403, idProduct=6001
[    2.197911] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.199584] usb 1-1.3: Product: RFXtrx433
[    2.201220] usb 1-1.3: Manufacturer: RFXCOM
[    2.202851] usb 1-1.3: SerialNumber: A12IVCQJ
[    2.385542] systemd[1]: Listening on fsck to fsckd communication Socket.
[    2.389741] systemd[1]: Listening on Syslog Socket.
[    2.393999] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    2.417231] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    2.423012] systemd[1]: Listening on Journal Socket (/dev/log).
[    2.427455] systemd[1]: Created slice User and Session Slice.
[    2.431300] systemd[1]: Listening on udev Kernel Socket.
[    2.893303] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    2.984336] systemd-journald[95]: Received request to flush runtime journal from PID 1
[    3.595954] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    3.607165] bcm2835_alsa bcm2835_alsa: card created with 8 channels
[    3.641928] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
[    3.673723] brcmfmac: brcmf_fw_map_chip_to_name: using brcm/brcmfmac43430-sdio.bin for chip 0x00a9a6(43430) rev 0x000001
[    3.673966] usbcore: registered new interface driver brcmfmac
[    3.811506] usbcore: registered new interface driver usbserial
[    3.811570] usbcore: registered new interface driver usbserial_generic
[    3.811633] usbserial: USB Serial support registered for generic
[    3.830729] usbcore: registered new interface driver ftdi_sio
[    3.830803] usbserial: USB Serial support registered for FTDI USB Serial Device
[    3.832052] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[    3.832229] usb 1-1.3: Detected FT232RL
[    3.834300] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB0
[    3.901896] brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: Oct 23 2017 03:55:53 version 7.45.98.38 (r674442 CY) FWID 01-e58d219f
[    3.902683] brcmfmac: brcmf_c_preinit_dcmds: CLM version = API: 12.2 Data: 7.11.15 Compiler: 1.24.2 ClmImport: 1.24.1 Creation: 2014-05-26 10:53:55 Inc Data: 9.10.39 Inc Compiler: 1.29.4 Inc ClmImport: 1.36.3 Creation: 2017-10-23 03:47:14
[    5.005258] uart-pl011 3f201000.serial: no DMA platform data
[    5.314579] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[    5.540687] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[    5.540708] brcmfmac: power management disabled
[    5.873476] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[    5.873748] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    7.460270] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    7.462638] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC1E1
[    9.536562] Bluetooth: Core ver 2.22
[    9.536661] NET: Registered protocol family 31
[    9.536664] Bluetooth: HCI device and connection manager initialized
[    9.537595] Bluetooth: HCI socket layer initialized
[    9.537611] Bluetooth: L2CAP socket layer initialized
[    9.537644] Bluetooth: SCO socket layer initialized
[    9.550323] Bluetooth: HCI UART driver ver 2.3
[    9.550333] Bluetooth: HCI UART protocol H4 registered
[    9.550336] Bluetooth: HCI UART protocol Three-wire (H5) registered
[    9.550463] Bluetooth: HCI UART protocol Broadcom registered
[    9.717329] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    9.717339] Bluetooth: BNEP filters: protocol multicast
[    9.717358] Bluetooth: BNEP socket layer initialized
[   54.346778] random: crng init done
[   54.346791] random: 7 urandom warning(s) missed due to ratelimiting
[16699.250881] systemd[1]: apt-daily.timer: Adding 1h 32min 25.249546s random time.
[16702.928819] systemd[1]: apt-daily.timer: Adding 32min 11.411232s random time.
[16703.291843] systemd[1]: apt-daily.timer: Adding 5h 23min 37.928241s random time.
[16703.628858] systemd[1]: apt-daily.timer: Adding 44min 10.734382s random time.
[17451.063247] ftdi_sio ttyUSB0: usb_serial_generic_read_bulk_callback - urb stopped: -32
[17451.063346] ftdi_sio ttyUSB0: usb_serial_generic_read_bulk_callback - urb stopped: -32
[17451.075643] usb 1-1.3: USB disconnect, device number 4
[17451.076281] ftdi_sio ttyUSB0: FTDI USB Serial Device converter now disconnected from ttyUSB0
[17451.076351] ftdi_sio 1-1.3:1.0: device disconnected
[17935.727200] usb 1-1.3: new full-speed USB device number 5 using dwc_otg
[17935.881979] usb 1-1.3: New USB device found, idVendor=0403, idProduct=6001
[17935.881989] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[17935.881993] usb 1-1.3: Product: RFXtrx433
[17935.881997] usb 1-1.3: Manufacturer: RFXCOM
[17935.882002] usb 1-1.3: SerialNumber: A12IVCQJ
[17935.890244] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[17935.890336] usb 1-1.3: Detected FT232RL
[17935.891360] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB1

In the PaperUI added the generic RFXCOM USB Transceiver and set the following options:

After I saved the Thing, I check and it is showing as ONLINE


but when I attempt to find the motion sensors that are using unencoded messaging I don’t find any new devices.

In the events log I see the following errors:

2018-07-28 22:25:47.483 [ERROR] [rnal.discovery.RFXComBridgeDiscovery] - Error occurred during discovery
java.io.IOException: device not found (2)
	at jd2xx.JD2XX.listDevices(Native Method) ~[210:org.openhab.binding.rfxcom:2.3.0]
	at jd2xx.JD2XX.listDevicesByDescription(JD2XX.java:826) [210:org.openhab.binding.rfxcom:2.3.0]
	at org.openhab.binding.rfxcom.internal.discovery.RFXComBridgeDiscovery.discoverRfxcom(RFXComBridgeDiscovery.java:82) [210:org.openhab.binding.rfxcom:2.3.0]
	at org.openhab.binding.rfxcom.internal.discovery.RFXComBridgeDiscovery.startScan(RFXComBridgeDiscovery.java:58) [210:org.openhab.binding.rfxcom:2.3.0]
	at org.eclipse.smarthome.config.discovery.AbstractDiscoveryService.startScan(AbstractDiscoveryService.java:208) [97:org.eclipse.smarthome.config.discovery:0.10.0.oh230]
	at org.eclipse.smarthome.config.discovery.internal.DiscoveryServiceRegistryImpl.startScan(DiscoveryServiceRegistryImpl.java:427) [97:org.eclipse.smarthome.config.discovery:0.10.0.oh230]
	at org.eclipse.smarthome.config.discovery.internal.DiscoveryServiceRegistryImpl.startScans(DiscoveryServiceRegistryImpl.java:403) [97:org.eclipse.smarthome.config.discovery:0.10.0.oh230]
	at org.eclipse.smarthome.config.discovery.internal.DiscoveryServiceRegistryImpl.startScan(DiscoveryServiceRegistryImpl.java:260) [97:org.eclipse.smarthome.config.discovery:0.10.0.oh230]
	at org.eclipse.smarthome.io.rest.core.internal.discovery.DiscoveryResource.scan(DiscoveryResource.java:97) [118:org.eclipse.smarthome.io.rest.core:0.10.0.oh230]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:?]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:?]
	at org.glassfish.jersey.server.model.internal.ResourceMethodInvocationHandlerFactory$1.invoke(ResourceMethodInvocationHandlerFactory.java:81) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher$1.run(AbstractJavaResourceMethodDispatcher.java:144) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher.invoke(AbstractJavaResourceMethodDispatcher.java:161) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.internal.JavaResourceMethodDispatcherProvider$ResponseOutInvoker.doDispatch(JavaResourceMethodDispatcherProvider.java:160) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.internal.AbstractJavaResourceMethodDispatcher.dispatch(AbstractJavaResourceMethodDispatcher.java:99) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:389) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.ResourceMethodInvoker.apply(ResourceMethodInvoker.java:347) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.model.ResourceMethodInvoker.apply(ResourceMethodInvoker.java:102) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.ServerRuntime$2.run(ServerRuntime.java:326) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:271) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:267) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.internal.Errors.process(Errors.java:315) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.internal.Errors.process(Errors.java:297) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.internal.Errors.process(Errors.java:267) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:317) [169:org.glassfish.jersey.core.jersey-common:2.22.2]
	at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154) [170:org.glassfish.jersey.core.jersey-server:2.22.2]
	at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
	at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
	at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76) [15:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253]
	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:848) [85:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:584) [85:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) [183:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) [82:org.eclipse.jetty.security:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:284) [183:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [85:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) [183:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.Server.handle(Server.java:534) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:333) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [84:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [76:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [76:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [76:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [87:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [87:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [87:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [87:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [87:org.eclipse.jetty.util:9.3.21.v20170918]
	at java.lang.Thread.run(Thread.java:748) [?:?]

This is as far as I have been able to get. I have been working to get this working now for over three weeks.
I would be extremely grateful for any assistance that can be offered.

Is there ANYONE in the community that help with this request? Once I get a final resolution I will update the initial step by steps that I posted with the resolution included for a candidate of a sticky solution for others.

I am still looking for assistance with the RFXCOM setup. I have read every single RFXCOM request for help and followed ALL troubleshooting and none of the solutions offered work.

Based on all the requests for help and no real solutions, only steps that sometime work and sometime don’t, I am looking for a definitive reason why it isn’t working and what the fix is.

This is my first “thing” to try to setup on OPENHAB and I am now over a month without being able to get this to work. I can read log files and am NOT a newbie when it come to linux. Not a single person or guide has explained from start to finish how an RFXCOM transceiver needs to function so that I can troubleshoot what is not working. I would greatly like to get the information on how this is supposed to work and what are the blockers from allowing it to function and how to resolve them.

Are you sure these devices are / will be recognised by the rfxcom, reading your story I doubt whether it’s an openHAB problem.

Better check the documentation whether these sensors are supported and use the rfxcom application (rfxmngr) to test whether you are able to receive and process these signals using purely the rfxcom.

http://www.rfxcom.com/epages/78165469.sf/nl_NL/?ObjectPath=/Shops/78165469/Categories/Downloads

The devices I am trying to discover in OH are unencoded devices. I have tested the transceiver on a Windows pc using rfxmgr and these devices can be seen in the rfxmgr portal on a PC. These are only sensors so there is now need to speak to the device from OH.

The log files appear that the issue in in the jd2xx.JD2XX.listDevices portion of the OpenHab system, I just don’t now how to test whether the Transciver is properly configured and if not where to fix it

If you configure the binding in DEBUG or TRACE mode you should see every message the binding sees.

Go to the karaf console: https://docs.openhab.org/administration/console.html

And enable debuging for the rfxcom:

log:set DEBUG org.openhab.binding.rfxcom

Tailing the log should give you output now, if the device reports online I’m pretty sure that it initialized correctly.

I will do this and report back.

I have a similar setup and have bought four ‘identical’ 433MHz PIRs.

Although all four provide ‘data’ when my RFXtrx433E is connected to a PC and using RFXmngr, only two provide meaningful data and only these two get seen by openHAB.

I need to revisit the problem and I’ll post here if I find anything useful.

I have about thirty devices in total connected to my RFXtrx433E and when I add a new device, usually manually by connecting the RFXtrx433E (as there is invariably a setting that needs tweaking or for devices that onlyreceive and do not transmit), the RFXtrx433E will not work again once plugged into my RPI unless I plug it in and then unplug it after a few seconds and then plug it in again.

Otherwise it works fine.

This is the data I get from the RFXtrx433E RFX Manager window for one of the devices that work:


Packettype    = Lighting5
subtype       = Kangtai, Cotech
Sequence nbr  = 49
ID            = EEB6 decimal:61110
Unit          = 26
Command       = Off
Signal level  = 7  -64dBm

This is what I get for one of the devices that does not work:

Packettype    = Lighting4
subtype       = PT2262
Sequence nbr  = 126
Code          = 402836 decimal:4204598
S1- S24  = 0100 0000 0010 1000 0011 0110 
Pulse         = 403 usec
Signal level  = 7  -64dBm

What do you get?

Did you gather this data from the windows rfxmgr?

Yes. It’s a copy and paste from the output window.

Hi I’m using RFXcom as well. Use it to control lights and sensors.
I guess you are trying to find the actuator automatically via PaperUI?

If try then I get the same error message

2018-08-12 20:51:51.339 [ERROR] [rnal.discovery.RFXComBridgeDiscovery] - Error occurred during discovery java.io.IOException: device not found (2)

You can better mannually add the actuator.

2 steps: with RFxmgr for windows get the data from the sensor.
for instance:

11-8-2018 01:48:49:079
Packettype = Lighting2
subtype = AC
Sequence nbr = 4
ID = 1B77D5E decimal:28802396
Unit = 10
Command = Off
Signal level = 7 -64dBm

then add this item manually.
I will post a next message with a screenshot. (as newby I can only upload one picture…)

DONE! hope this works

Add manual the actuator:

I was able to determine that the sensors that I purchased (https://www.amazon.com/gp/product/B073WTR8PW/ref=oh_aui_detailpage_o00_s01?ie=UTF8&psc=1) seem to be ARC. I activated ARC in the Transceiver config and I now at least see data coming in over the bridge.

I have one device turned on. I do not have anything else turned on so I think I am also getting some neighbor data too.

2018-08-12 18:41:36.298 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0903017127A0BF8C0656, Packet type = UNDECODED_RF_MESSAGE, Seq number = 113, Sub type = ARC
2018-08-12 18:41:36.395 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0903017228505FC6064D, Packet type = UNDECODED_RF_MESSAGE, Seq number = 114, Sub type = ARC
2018-08-12 18:41:37.944 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0D030173438888B88043934003E1, Packet type = UNDECODED_RF_MESSAGE, Seq number = 115, Sub type = ARC
2018-08-12 18:41:38.056 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0D03017443C4445C4021C08005B0, Packet type = UNDECODED_RF_MESSAGE, Seq number = 116, Sub type = ARC
2018-08-12 18:41:38.184 [DEBUG] [g.rfxcom.handler.RFXComBridgeHandler] - Message received: Raw data = 0D030175438888BB0087250003E2, Packet type = UNDECODED_RF_MESSAGE, Seq number = 117, Sub type = ARC

I am trying to identify the the data coming across.
I am pretty sure this is my device:
0903019728D05FC6064D
0903019828D05FC60656
0903019928505FC6064D
0903019B28505FC60656
0903019C28505FC60656

What is the device ID? What is the code for motion/no-motion? These motion sensors came with NO details on the expected decoding data.

I looked on the circuit boards to any type of ID of the device and couldn’t find anything.
Suggestions?

Mostly they just send motion signals, I don’t expect them to send no-motion messages.

Did something pop up in your inbox? When using undecoded messages things like device ids do not matter that is why they are called undecoded :slightly_smiling_face:

You need a rule to process their raw messages

They look the same as the ones I bought. Have you tried enabling Lighting4 in RFXMngr and seeing if you get any usable data like I did?

I will try lighting 4. What type of device will they look like isnihg this interface?
Also when I go to manually add them. What type of device?

Sorry, it was Lighting5!

See my post just above which shows the data from supposedly identical devices - a good one, and a bad one. Manually set it to those. (But I’m sure my devices were found automatically).

I have been traveling extensively for work, so I am sorry for the delay in saying thank you very much for your input!

I have checked my RP3 openhab setup today after a few weeks of not looking at it and I have 29 devices in my inbox (I enabled all the device types in the OH RFX Transceiver Thing Config Page). I see a Lighting 4, Lighting5, SECURITY1 and UNDECODED_RF_MESSAGE-UNDECODED devices in the INBOX.

Tom, could you shared some details as to how you were able to identify your motion sensors in OH and how you were able to create channel rules based on the CHANNEL content? I cannot figure out out of the Lighting5 things what channel values = motion

I am still very new to OH and still haven’t gotten to the step of actually doing something with a THING yet. A couple of screen captures would go a long way.

Thank you in advance!

Sure.

Here’s the PIR device data for one PIR I got from the RFXMngr program window:

Packettype    = Lighting5
subtype       = Kangtai, Cotech
Sequence nbr  = 49
ID            = EEB6 decimal:61110
Unit          = 26
Command       = Off
Signal level  = 7  -64dBm

Here are the stages to add the device to openHAB. I did it manually:
In PaperUI:

  • Add Thing (Press +)

  • Choose binding: RFXCOM binding

  • Select: Add Manually

  • Select the device ID/Unit from the device data (in this case 61110.26)

  • Select subtype Kangtai, Cotech

  • Select the bridge (your RFXCOM RFXtrx433E)

From the Thing Channels, copy the Contact data to your clip board:

  • Create a new Item in an Items file:
Contact PIR_433_1  "PIR_Upstairs landing"   <contact>   (gPIR,startpersist)     { channel="rfxcom:lighting5:52b6e788:contact", expire="5s,state=OPEN" }

I added an expire after five seconds to avoid multiple readings and to revert the state back to OPEN (It’s closed when movement is detected).

Here’s a simple rule:

rule "Intruder detect"

when 
	Item PIR_433_1 changed to CLOSED	
then	
	logInfo("Intruder","Intruder detected: upstairs landing")
end
1 Like