Debugging - node-red-contrib-modbus - serial RTU

Ion3 · 10 February 2021 20:42

Hi,

I have an issue using the "Modbus Read" node of node-red-contrib-modbus. My modbus communication works on a Windows PC using CAS Modbus Scanner. Using the same hardware on a Raspberry Pi gives me some trouble. I am using a USB-RS485-Dongle and a SBC ALE3D5F energy meter. (sorry, as a new user I was only allowed to place two pictures and two links)

To start simple, this is my setup:

setup1

[{"id":"a16a70db.ede3f","type":"modbus-read","z":"e2ecd7f3.450a58","name":"","topic":"","showStatusActivities":true,"logIOActivities":false,"showErrors":true,"unitid":"60","dataType":"HoldingRegister","adr":"35","quantity":"1","rate":"10","rateUnit":"s","delayOnStart":false,"startDelayTime":"5","server":"5c2c3186.30196","useIOFile":false,"ioFile":"","useIOForPayload":false,"emptyMsgOnFail":true,"x":420,"y":200,"wires":[["37cb29ed.6e4e96"],[]]},{"id":"37cb29ed.6e4e96","type":"debug","z":"e2ecd7f3.450a58","name":"","active":true,"tosidebar":true,"console":false,"tostatus":false,"complete":"true","targetType":"full","statusVal":"","statusType":"auto","x":660,"y":220,"wires":[]},{"id":"5c2c3186.30196","type":"modbus-client","name":"","clienttype":"serial","bufferCommands":false,"stateLogEnabled":true,"queueLogEnabled":false,"tcpHost":"127.0.0.1","tcpPort":"502","tcpType":"DEFAULT","serialPort":"/dev/ttyUSB0","serialType":"RTU-BUFFERD","serialBaudrate":"19200","serialDatabits":"8","serialStopbits":"1","serialParity":"even","serialConnectionDelay":"1000","unit_id":"","commandDelay":"30","clientTimeout":"3000","reconnectOnTimeout":false,"reconnectTimeout":"5000","parallelUnitIdsAllowed":false}]

I receive the following debug messages:

debug

The USB-RS485-Dongle seems to be installed correctly:

~ $ dmesg
[    5.926915] usb 1-1.3: New USB device found, idVendor=1a86, idProduct=7523, bcdDevice= 2.54
[    5.943737] usb 1-1.3: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[    5.955483] usb 1-1.3: Product: USB2.0-Ser!

[   10.172846] usb 1-1.3: ch341-uart converter now attached to ttyUSB0

Node-red-contrib-modbus recommends debugging via DEBUG=contribModbus* node-red -v. This gives the following result:

10 Feb 20:29:53 - [info] Starting flows
  contribModbus:queue:core queue serial lock command node Serial_9600_8_E_1 +0ms
  contribModbus:core:client Client -> new +0ms
  contribModbus:core:client Client -> initialized +2ms
  contribModbus:queue:core queue serial lock command node undefined +18ms
  contribModbus:core:client Client -> new +12ms
  contribModbus:core:client Client -> initialized +1ms
10 Feb 20:29:53 - [warn] [modbus-read:a16a70db.ede3f] Client -> open node a16a70db.ede3fundefined
  contribModbus:core:client Client -> new +18ms
  contribModbus:core:client Client -> init +2ms
10 Feb 20:29:53 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm init state after new
10 Feb 20:29:53 - [warn] [modbus-client:5c2c3186.30196] Client -> first fsm init in 500 ms Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +14ms
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +0ms
10 Feb 20:29:53 - [info] Started flows
10 Feb 20:29:53 - [error] Unable to listen on http://127.0.0.1:1880/
10 Feb 20:29:53 - [error] Error: port in use

Does anybody have a qualified recommendation, how to fix this issue?

Thank you very much,
Timo

Ion3 · 10 February 2021 20:47

This is how the node configuration looks like:

...and this is my server configuration:

The modbus devices are:

Colin · 10 February 2021 21:19

Welcome to the forum @Ion3

You are trying to start node red when it is already running. Close the first one before starting another.

craigcurtin · 10 February 2021 21:51

And if that does not fix it - look at permissions on the TTY device - make sure the user that is starting and running node-red has permissions to that device/directory.

Do a search on the forum - about 2 months ago this same issue came up and was i believe resolved.

Do you have the modbus registers/map for the Energy meter ?

Craig

Ion3 · 10 February 2021 22:08

On page 6-7 of the link above.

Ion3 · 10 February 2021 22:14

Did you have this in mind? Just to give it a try:

sudo chmod a+rw /dev/ttyUSB0

Without luck.

UnborN · 10 February 2021 22:15

Hi,

Can you confirm from the menu of your energy meter that the settings for the modbus device id, baud rate, Data bits etc are matching .. also check if the cabling is ok.

Also from the manual it shows this

so maybe you should be reading both registers 34 and 35 that possibly define a 32bit Energy value ?
in the read node try Address 34 ... Quantity 2

craigcurtin · 10 February 2021 22:22

Thats an older one - but yes same issue (it comes up a lot !)

Craig

Ion3 · 10 February 2021 22:27

I can confirm: Same USB-RS485-Dongle, same cable, same energy meter is working in combination with a Windows PC and the CAS Modbus Scanner.

craigcurtin · 10 February 2021 22:28

Just had a quick read of the spec sheet.

It seems that it does an auto read of two registers (big endian) if they are grouped together - which is a little strange - you would send out a request for one register and it sends back two.

Try one of the simple registers on there - based on you using the windows app and verifying all good i would suggest trying another modbus node - i remember when i was trying to get into Modbus to start with - same PC - Modbus-CAS would work to let me query the unit as would some commandline python tools - but i could not get the MOdbus nodes working on NR (under Windows)

Craig

craigcurtin · 10 February 2021 22:31

Sorry - as per Colins message (first answer) - can you confirm that you shutdown NR before launching it again ?

That first message you are getting is essentially telling you that you are trying to run two copies of NR on the same TCP port (1880)

Craig

Ion3 · 10 February 2021 22:38

Correct, the sbc energy meter is doing auto detection on the transmission baud rate and the parity is as well automatically detected. Nevertheless, on windows 9600 baud didn't work; 19200 worked without problems, reading single and multiple registers (in CAS you select the first register an define the amount). As you see in my Node-RED setup, I only want to read one simple voltage parameter. I tried to keep it simple and plan increase complexity after the simple stuff is working.

craigcurtin · 10 February 2021 22:39

Yep - but as per the above - before you go any further - the error message you were giving is saying that NR is not running on the port - can you show your startup logs again after fixing that error ?

Craig

Ion3 · 10 February 2021 22:44

Colin:

Welcome to the forum @Ion3
Ion3:
> 10 Feb 20:29:53 - [error] Unable to listen on http://127.0.0.1:1880/
10 Feb 20:29:53 - [error] Error: port in use
> ```
You are trying to start node red when it is already running. Close the first one before starting another.

Thank you Colin! This (I believe) was a consequence of running DEBUG=contribModbus* node-red -v. (I hope)

I restarted the Raspi several times after this DEBUG-attempt and believe only one instance is running. How can I check if there are running multiple instances of Node-RED?

Ion3 · 10 February 2021 22:46

~ $ dmesg
[    0.000000] Booting Linux on physical CPU 0xf00
[    0.000000] Linux version 5.10.11-v7+ (dom@buildbot) (arm-linux-gnueabihf-gcc                                                                                                                                                             -8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34)                                                                                                                                                              #1399 SMP Thu Jan 28 12:06:05 GMT 2021
[    0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instructio                                                                                                                                                             n cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 2 Model B Rev 1.1
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] Reserved memory: created CMA memory pool at 0x37400000, size 64 M                                                                                                                                                             iB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id share                                                                                                                                                             d-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000003b3fffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000003b3fffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000003b3fffff]
[    0.000000] On node 0 totalpages: 242688
[    0.000000]   DMA zone: 2133 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 242688 pages, LIFO batch:63
[    0.000000] percpu: Embedded 20 pages/cpu s50636 r8192 d23092 u81920
[    0.000000] pcpu-alloc: s50636 r8192 d23092 u81920 alloc=20*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 240555
[    0.000000] Kernel command line: coherent_pool=1M snd_bcm2835.enable_compat_a                                                                                                                                                             lsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=720 bcm2708_fb.fbheight=480 b                                                                                                                                                             cm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  consol                                                                                                                                                             e=ttyAMA0,115200 console=tty1 root=PARTUUID=402c758b-02 rootfstype=ext4 elevator                                                                                                                                                             =deadline fsck.repair=yes rootwait
[    0.000000] Kernel parameter elevator= does not have any effect anymore.
               Please use sysfs to set IO scheduler for individual devices.
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes,                                                                                                                                                              linear)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, li                                                                                                                                                             near)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 879840K/970752K available (9216K kernel code, 1311K rwdat                                                                                                                                                             a, 2936K rodata, 1024K init, 860K bss, 25376K reserved, 65536K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 31819 entries in 63 pages
[    0.000000] ftrace: allocated 63 pages with 6 groups
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000]  Rude variant of Tasks RCU enabled.
[    0.000000]  Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jif                                                                                                                                                             fies.
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] random: get_random_bytes called from start_kernel+0x3ac/0x580 wit                                                                                                                                                             h crng_init=0
[    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.000011] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 43980                                                                                                                                                             46511078ns
[    0.000034] Switching to timer-based delay loop, resolution 52ns
[    0.000387] Console: colour dummy device 80x30
[    0.001353] printk: console [tty1] enabled
[    0.001441] Calibrating delay loop (skipped), value calculated using timer fr                                                                                                                                                             equency.. 38.40 BogoMIPS (lpj=192000)
[    0.001515] pid_max: default: 32768 minimum: 301
[    0.001818] LSM: Security Framework initializing
[    0.002144] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linea                                                                                                                                                             r)
[    0.002211] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes,                                                                                                                                                              linear)
[    0.004318] Disabling memory control group subsystem
[    0.004534] CPU: Testing write buffer coherency: ok
[    0.005273] CPU0: update cpu_capacity 1024
[    0.005326] CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00
[    0.007135] Setting up static identity map for 0x100000 - 0x10003c
[    0.007454] rcu: Hierarchical SRCU implementation.
[    0.008770] smp: Bringing up secondary CPUs ...
[    0.010618] CPU1: update cpu_capacity 1024
[    0.010631] CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01
[    0.012482] CPU2: update cpu_capacity 1024
[    0.012495] CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02
[    0.014258] CPU3: update cpu_capacity 1024
[    0.014270] CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03
[    0.014499] smp: Brought up 1 node, 4 CPUs
[    0.014680] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.014718] CPU: All CPU(s) started in HYP mode.
[    0.014751] CPU: Virtualization extensions available.
[    0.016119] devtmpfs: initialized
[    0.037527] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7                                                                                                                                                              rev 5
[    0.037969] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, ma                                                                                                                                                             x_idle_ns: 19112604462750000 ns
[    0.038049] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.042302] pinctrl core: initialized pinctrl subsystem
[    0.044005] NET: Registered protocol family 16
[    0.049127] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.056430] audit: initializing netlink subsys (disabled)
[    0.057005] audit: type=2000 audit(0.050:1): state=initialized audit_enabled=                                                                                                                                                             0 res=1
[    0.057953] thermal_sys: Registered thermal governor 'step_wise'
[    0.059080] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint                                                                                                                                                              registers.
[    0.059163] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.059558] Serial: AMBA PL011 UART driver
[    0.080122] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.092696] raspberrypi-firmware soc:firmware: Attached to firmware from 2021                                                                                                                                                             -01-27T22:26:53, variant start
[    0.102716] raspberrypi-firmware soc:firmware: Firmware hash is 99d9a48302e45                                                                                                                                                             53cff3688692bb7e9ac760a03fa
[    0.164942] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1
[    0.167846] SCSI subsystem initialized
[    0.168266] usbcore: registered new interface driver usbfs
[    0.168387] usbcore: registered new interface driver hub
[    0.168512] usbcore: registered new device driver usb
[    0.171022] clocksource: Switched to clocksource arch_sys_counter
[    1.922271] VFS: Disk quotas dquot_6.6.0
[    1.922460] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.922758] FS-Cache: Loaded
[    1.923244] CacheFiles: Loaded
[    1.938646] NET: Registered protocol family 2
[    1.940048] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144                                                                                                                                                              bytes, linear)
[    1.940323] TCP established hash table entries: 8192 (order: 3, 32768 bytes,                                                                                                                                                              linear)
[    1.940494] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    1.940718] TCP: Hash tables configured (established 8192 bind 8192)
[    1.941118] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.941447] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[    1.942161] NET: Registered protocol family 1
[    1.943384] RPC: Registered named UNIX socket transport module.
[    1.943439] RPC: Registered udp transport module.
[    1.943476] RPC: Registered tcp transport module.
[    1.943511] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.945491] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counter                                                                                                                                                             s available
[    1.950527] Initialise system trusted keyrings
[    1.951103] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[    1.963054] zbud: loaded
[    1.965809] FS-Cache: Netfs 'nfs' registered for caching
[    1.967095] NFS: Registering the id_resolver key type
[    1.967200] Key type id_resolver registered
[    1.967238] Key type id_legacy registered
[    1.967475] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.969136] Key type asymmetric registered
[    1.969190] Asymmetric key parser 'x509' registered
[    1.969293] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 2                                                                                                                                                             49)
[    1.969344] io scheduler mq-deadline registered
[    1.969381] io scheduler kyber registered
[    1.972789] bcm2708_fb soc:fb: FB found 1 display(s)
[    1.989090] Console: switching to colour frame buffer device 90x30
[    1.999133] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 720                                                                                                                                                             x480
[    2.009298] bcm2835-rng 3f104000.rng: hwrng registered
[    2.013290] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000                                                                                                                                                             000(1024 MiB)
[    2.021392] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f2                                                                                                                                                             00000
[    2.044372] brd: module loaded
[    2.065167] loop: module loaded
[    2.070916] Loading iSCSI transport class v2.0-870.
[    2.076907] libphy: Fixed MDIO Bus: probed
[    2.080833] usbcore: registered new interface driver lan78xx
[    2.084618] usbcore: registered new interface driver smsc95xx
[    2.088049] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    2.820021] Core Release: 2.80a
[    2.823523] Setting default values for core params
[    2.826955] Finished setting default values for core params
[    3.030867] Using Buffer DMA mode
[    3.034337] Periodic Transfer Interrupt Enhancement - disabled
[    3.037791] Multiprocessor Interrupt Enhancement - disabled
[    3.041295] OTG VER PARAM: 0, OTG VER FLAG: 0
[    3.044757] Dedicated Tx FIFOs mode

[    3.048765] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b7514                                                                                                                                                             000 dma = 0xf7514000 len=9024
[    3.058875] FIQ FSM acceleration enabled for :
               Non-periodic Split Transactions
               Periodic Split Transactions
               High-Speed Isochronous Endpoints
               Interrupt/Control Split Transaction hack enabled
[    3.075124] dwc_otg: Microframe scheduler enabled

[    3.075242] WARN::hcd_init_fiq:457: FIQ on core 1

[    3.081108] WARN::hcd_init_fiq:458: FIQ ASM at 807bae50 length 36

[    3.087025] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000
[    3.093031] dwc_otg 3f980000.usb: DWC OTG Controller
[    3.096223] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number                                                                                                                                                              1
[    3.099483] dwc_otg 3f980000.usb: irq 89, io mem 0x00000000
[    3.102691] Init: Port Power? op_state=1
[    3.105807] Init: Power Port (0)
[    3.109337] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bc                                                                                                                                                             dDevice= 5.10
[    3.115647] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=                                                                                                                                                             1
[    3.118983] usb usb1: Product: DWC OTG Controller
[    3.122288] usb usb1: Manufacturer: Linux 5.10.11-v7+ dwc_otg_hcd
[    3.125636] usb usb1: SerialNumber: 3f980000.usb
[    3.130106] hub 1-0:1.0: USB hub found
[    3.133486] hub 1-0:1.0: 1 port detected
[    3.138015] dwc_otg: FIQ enabled
[    3.138034] dwc_otg: NAK holdoff enabled
[    3.138049] dwc_otg: FIQ split-transaction FSM enabled
[    3.138071] Module dwc_common_port init
[    3.138570] usbcore: registered new interface driver usb-storage
[    3.142124] mousedev: PS/2 mouse device common for all mice
[    3.146861] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    3.153421] sdhci: Secure Digital Host Controller Interface driver
[    3.156812] sdhci: Copyright(c) Pierre Ossman
[    3.161048] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
[    3.164836] sdhci-pltfm: SDHCI platform and OF driver helper
[    3.169470] ledtrig-cpu: registered to indicate activity on CPUs
[    3.173535] hid: raw HID events driver (C) Jiri Kosina
[    3.177246] usbcore: registered new interface driver usbhid
[    3.180706] usbhid: USB HID core driver
[    3.190616] Initializing XFRM netlink socket
[    3.194165] NET: Registered protocol family 17
[    3.197684] Key type dns_resolver registered
[    3.201747] Registering SWP/SWPB emulation handler
[    3.205282] registered taskstats version 1
[    3.208631] Loading compiled-in X.509 certificates
[    3.213155] Key type ._fscrypt registered
[    3.216323] Key type .fscrypt registered
[    3.219335] Key type fscrypt-provisioning registered
[    3.237084] uart-pl011 3f201000.serial: cts_event_workaround enabled
[    3.240332] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 114, base_baud                                                                                                                                                              = 0) is a PL011 rev2
[    4.297335] printk: console [ttyAMA0] enabled
[    4.308496] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains drive                                                                                                                                                             r
[    4.321546] sdhost: log_buf @ (ptrval) (f7513000)
[    4.377995] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    4.390782] of_cfs_init
[    4.397005] of_cfs_init: OK
[    4.404283] Waiting for root device PARTUUID=402c758b-02...
[    4.411297] Indeed it is in host mode hprt0 = 00021501
[    4.507453] random: fast init done
[    4.518333] mmc0: host does not support reading read-only switch, assuming wr                                                                                                                                                             ite-enable
[    4.532589] mmc0: new high speed SDHC card at address 0002
[    4.542726] mmcblk0: mmc0:0002 N/A   29.8 GiB
[    4.554182]  mmcblk0: p1 p2
[    4.610474] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. O                                                                                                                                                             pts: (null)
[    4.625472] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    4.631086] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    4.638531] devtmpfs: mounted
[    4.652538] Indeed it is in host mode hprt0 = 00001101
[    4.723767] Freeing unused kernel memory: 1024K
[    4.732438] Run /sbin/init as init process
[    4.740187]   with arguments:
[    4.740215]     /sbin/init
[    4.740229]   with environment:
[    4.740243]     HOME=/
[    4.740256]     TERM=linux
[    4.901562] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcd                                                                                                                                                             Device= 2.00
[    4.917339] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    4.929417] hub 1-1:1.0: USB hub found
[    4.937212] hub 1-1:1.0: 5 ports detected
[    5.261109] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    5.401645] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, b                                                                                                                                                             cdDevice= 2.00
[    5.417432] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber                                                                                                                                                             =0
[    5.432031] smsc95xx v2.0.0
[    5.572671] systemd[1]: System time before build time, advancing clock.
[    5.675274] libphy: smsc95xx-mdiobus: probed
[    5.685015] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-                                                                                                                                                             1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:2e:84:a5
[    5.763700] NET: Registered protocol family 10
[    5.774689] Segment Routing with IPv6
[    5.801135] usb 1-1.3: new full-speed USB device number 4 using dwc_otg
[    5.841515] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SEL                                                                                                                                                             INUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +                                                                                                                                                             XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybr                                                                                                                                                             id)
[    5.884544] systemd[1]: Detected architecture arm.
[    5.944425] usb 1-1.3: New USB device found, idVendor=1a86, idProduct=7523, b                                                                                                                                                             cdDevice= 2.54
[    5.961217] usb 1-1.3: New USB device strings: Mfr=0, Product=2, SerialNumber                                                                                                                                                             =0
[    5.972949] usb 1-1.3: Product: USB2.0-Ser!
[    6.004285] systemd[1]: Set hostname to <HeatingPi>.
[    6.337824] uart-pl011 3f201000.serial: no DMA platform data
[    7.175898] random: systemd: uninitialized urandom read (16 bytes read)
[    7.212182] random: systemd: uninitialized urandom read (16 bytes read)
[    7.224682] systemd[1]: Listening on fsck to fsckd communication Socket.
[    7.240719] random: systemd: uninitialized urandom read (16 bytes read)
[    7.252076] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    7.268511] systemd[1]: Listening on Syslog Socket.
[    7.283126] systemd[1]: Listening on udev Control Socket.
[    7.297686] systemd[1]: Started Forward Password Requests to Wall Directory W                                                                                                                                                             atch.
[    7.314289] systemd[1]: Reached target Swap.
[    7.331638] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    7.615060] i2c /dev entries driver
[    8.476561] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    8.617620] systemd-journald[113]: Received request to flush runtime journal                                                                                                                                                              from PID 1
[    9.569557] vc_sm_cma: module is from the staging directory, the quality is u                                                                                                                                                             nknown, you have been warned.
[    9.573595] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    9.573635] [vc_sm_connected_init]: start
[    9.586999] [vc_sm_connected_init]: installed successfully
[    9.624096] mc: Linux media interface: v0.10
[    9.690213] snd_bcm2835: module is from the staging directory, the quality is                                                                                                                                                              unknown, you have been warned.
[    9.715502] videodev: Linux video capture interface: v2.00
[    9.739207] bcm2835_audio bcm2835_audio: card created with 8 channels
[    9.751526] bcm2835_mmal_vchiq: module is from the staging directory, the qua                                                                                                                                                             lity is unknown, you have been warned.
[    9.753752] bcm2835_mmal_vchiq: module is from the staging directory, the qua                                                                                                                                                             lity is unknown, you have been warned.
[    9.758637] bcm2835_mmal_vchiq: module is from the staging directory, the qua                                                                                                                                                             lity is unknown, you have been warned.
[    9.809681] bcm2835_isp: module is from the staging directory, the quality is                                                                                                                                                              unknown, you have been warned.
[    9.812735] bcm2835_v4l2: module is from the staging directory, the quality i                                                                                                                                                             s unknown, you have been warned.
[    9.831983] bcm2835_codec: module is from the staging directory, the quality                                                                                                                                                              is unknown, you have been warned.
[    9.836758] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev                                                                                                                                                             /video13
[    9.838086] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /de                                                                                                                                                             v/video14
[    9.839169] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /de                                                                                                                                                             v/video15
[    9.845009] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/                                                                                                                                                             video16
[    9.845100] bcm2835-isp bcm2835-isp: Register output node 0 with media contro                                                                                                                                                             ller
[    9.845185] bcm2835-isp bcm2835-isp: Register capture node 1 with media contr                                                                                                                                                             oller
[    9.845262] bcm2835-isp bcm2835-isp: Register capture node 2 with media contr                                                                                                                                                             oller
[    9.845331] bcm2835-isp bcm2835-isp: Register capture node 3 with media contr                                                                                                                                                             oller
[    9.848026] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    9.866015] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    9.866247] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    9.870888] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    9.871166] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    9.889163] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    9.889256] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[   10.307636] usbcore: registered new interface driver usbserial_generic
[   10.307764] usbserial: USB Serial support registered for generic
[   10.328562] usbcore: registered new interface driver ch341
[   10.328706] usbserial: USB Serial support registered for ch341-uart
[   10.328878] ch341 1-1.3:1.0: ch341-uart converter detected
[   10.340940] ch341-uart ttyUSB0: break control not supported, using simulated                                                                                                                                                              break
[   10.341577] usb 1-1.3: ch341-uart converter now attached to ttyUSB0
[   13.736572] random: crng init done
[   13.736606] random: 7 urandom warning(s) missed due to ratelimiting
[   14.179121] 8021q: 802.1Q VLAN Support v1.8
[   14.507835] cfg80211: Loading compiled-in X.509 certificates for regulatory d                                                                                                                                                             atabase
[   14.624118] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[   15.031903] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:1                                                                                                                                                             02396k SSFS
[   15.144539] SMSC LAN8700 usb-001:003:01: attached PHY driver [SMSC LAN8700] (                                                                                                                                                             mii_bus:phy_addr=usb-001:003:01, irq=POLL)
[   15.145185] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[   15.162270] smsc95xx 1-1.1:1.0 eth0: Link is Down
[   17.272295] smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control                                                                                                                                                              off
[   17.272363] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   18.955933] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net                                                                                                                                                             .ipv6.neigh.eth0.retrans_time - use net.ipv6.neigh.eth0.retrans_time_ms instead

craigcurtin · 10 February 2021 22:48

OK and now the Node-red logs (which is what we were referring to) - Did you read colins message at the start of this thread ?

Craig

craigcurtin · 10 February 2021 22:51

Go to the Startup logs again for NR and copy them to here

So are you now trying to run it in Modbus debug mode or not ?

Craig

Ion3 · 10 February 2021 22:53

These are the DEBUG-logs:

~ $ DEBUG=contribModbus* node-red -v
10 Feb 23:52:01 - [info]

Welcome to Node-RED
===================

10 Feb 23:52:01 - [info] Node-RED version: v1.2.9
10 Feb 23:52:01 - [info] Node.js  version: v12.20.1
10 Feb 23:52:01 - [info] Linux 5.10.11-v7+ arm LE
10 Feb 23:52:03 - [info] Loading palette nodes
10 Feb 23:52:09 - [info] Dashboard version 2.27.0 started at /ui
10 Feb 23:52:09 - [info] Settings file  : /home/pi/.node-red/settings.js
10 Feb 23:52:09 - [info] Context store  : 'default' [module=memory]
10 Feb 23:52:09 - [info] User directory : /home/pi/.node-red
10 Feb 23:52:09 - [warn] Projects disabled : editorTheme.projects.enabled=false
10 Feb 23:52:09 - [info] Flows file     : /home/pi/.node-red/flows_HeatingPi.json
10 Feb 23:52:10 - [warn]

---------------------------------------------------------------------
Your flow credentials file is encrypted using a system-generated key.

If the system-generated key is lost for any reason, your credentials
file will not be recoverable, you will have to delete it and re-enter
your credentials.

You should set your own key using the 'credentialSecret' option in
your settings file. Node-RED will then re-encrypt your credentials
file using your chosen key the next time you deploy a change.
---------------------------------------------------------------------

10 Feb 23:52:10 - [info] Starting flows
  contribModbus:queue:core queue serial lock command node Serial_9600_8_E_1 +0ms
  contribModbus:core:client Client -> new +0ms
  contribModbus:core:client Client -> initialized +2ms
  contribModbus:queue:core queue serial lock command node undefined +21ms
  contribModbus:core:client Client -> new +14ms
  contribModbus:core:client Client -> initialized +2ms
10 Feb 23:52:10 - [warn] [modbus-read:a16a70db.ede3f] Client -> open node a16a70db.ede3fundefined
  contribModbus:core:client Client -> new +20ms
  contribModbus:core:client Client -> init +3ms
10 Feb 23:52:10 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm init state after new
10 Feb 23:52:10 - [warn] [modbus-client:5c2c3186.30196] Client -> first fsm init in 500 ms Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +15ms
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +1ms
10 Feb 23:52:10 - [info] Started flows
10 Feb 23:52:10 - [error] Unable to listen on http://127.0.0.1:1880/
10 Feb 23:52:10 - [error] Error: port in use

craigcurtin · 10 February 2021 22:56

Yep so it is showing that something else is using that Port and IP address right at the end.

Presumably you have NR autostarting on the box and then are trying to manually run it again ?

You need to stop the first instance

systemctl stop nodered

And then run the debug version

Craig

Ion3 · 10 February 2021 23:01

It is on autostart and I did not try to start it manually again. Can it be that the DEBUG is trying to start Node-RED again?

The DEBUG-log changed:

~ $ systemctl stop nodered
==== AUTHENTICATING FOR org.freedesktop.systemd1.manage-units ===
Authentication is required to stop 'nodered.service'.
Authenticating as: ,,, (pi)
Password:
==== AUTHENTICATION COMPLETE ===
~ $ DEBUG=contribModbus* node-red -v
10 Feb 23:58:39 - [info]

Welcome to Node-RED
===================

10 Feb 23:58:39 - [info] Node-RED version: v1.2.9
10 Feb 23:58:39 - [info] Node.js  version: v12.20.1
10 Feb 23:58:39 - [info] Linux 5.10.11-v7+ arm LE
10 Feb 23:58:41 - [info] Loading palette nodes
10 Feb 23:58:47 - [info] Dashboard version 2.27.0 started at /ui
10 Feb 23:58:47 - [info] Settings file  : /home/pi/.node-red/settings.js
10 Feb 23:58:47 - [info] Context store  : 'default' [module=memory]
10 Feb 23:58:47 - [info] User directory : /home/pi/.node-red
10 Feb 23:58:47 - [warn] Projects disabled : editorTheme.projects.enabled=false
10 Feb 23:58:47 - [info] Flows file     : /home/pi/.node-red/flows_HeatingPi.json
10 Feb 23:58:47 - [warn]

---------------------------------------------------------------------
Your flow credentials file is encrypted using a system-generated key.

If the system-generated key is lost for any reason, your credentials
file will not be recoverable, you will have to delete it and re-enter
your credentials.

You should set your own key using the 'credentialSecret' option in
your settings file. Node-RED will then re-encrypt your credentials
file using your chosen key the next time you deploy a change.
---------------------------------------------------------------------

10 Feb 23:58:47 - [info] Starting flows
  contribModbus:queue:core queue serial lock command node Serial_9600_8_E_1 +0ms
  contribModbus:core:client Client -> new +0ms
  contribModbus:core:client Client -> initialized +2ms
  contribModbus:queue:core queue serial lock command node undefined +19ms
  contribModbus:core:client Client -> new +12ms
  contribModbus:core:client Client -> initialized +1ms
10 Feb 23:58:48 - [warn] [modbus-read:a16a70db.ede3f] Client -> open node a16a70db.ede3fundefined
  contribModbus:core:client Client -> new +18ms
  contribModbus:core:client Client -> init +2ms
10 Feb 23:58:48 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm init state after new
10 Feb 23:58:48 - [warn] [modbus-client:5c2c3186.30196] Client -> first fsm init in 500 ms Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +14ms
  contribModbus:core:client Client -> init Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +1ms
10 Feb 23:58:48 - [info] Started flows
10 Feb 23:58:48 - [info] Server now running at http://127.0.0.1:1880/
  contribModbus:core:client Client -> RTU buffered port serial Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +494ms
  contribModbus:core:client Client -> opened Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +24ms
  contribModbus:queue:core queue serial unlock command node undefined +557ms
  contribModbus:core:client Client -> time to open Unit 1 Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +1s
  contribModbus:core:client Client -> connected Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
10 Feb 23:58:49 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm connected after state opened Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:queue:core queue serial unlock command node undefined +1s
10 Feb 23:58:49 - [warn] [modbus-read:a16a70db.ede3f] Client -> startIntervalReading node a16a70db.ede3fundefined
  contribModbus:core:client Client -> connected Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +10s
  contribModbus:queue:core queue serial unlock command node undefined +13s
  contribModbus:queue:core queue serial unlock command node undefined +3ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:02 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after connected Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:02 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State connected Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +8ms
10 Feb 23:59:02 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +4ms
  contribModbus:read Timed out +0ms
10 Feb 23:59:02 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +21ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:12 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:12 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +4ms
10 Feb 23:59:12 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +2ms
  contribModbus:read Timed out +10s
10 Feb 23:59:12 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:22 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:22 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +6ms
10 Feb 23:59:22 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
10 Feb 23:59:22 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:32 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:32 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +4ms
10 Feb 23:59:32 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +2ms
  contribModbus:read Timed out +10s
10 Feb 23:59:32 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:42 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:42 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
10 Feb 23:59:42 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
10 Feb 23:59:42 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +6ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
10 Feb 23:59:52 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
10 Feb 23:59:52 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
10 Feb 23:59:52 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
10 Feb 23:59:52 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
11 Feb 00:00:02 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
11 Feb 00:00:02 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +6ms
11 Feb 00:00:02 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
11 Feb 00:00:02 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
11 Feb 00:00:12 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
11 Feb 00:00:12 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +6ms
11 Feb 00:00:12 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
11 Feb 00:00:12 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
11 Feb 00:00:22 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
11 Feb 00:00:22 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
11 Feb 00:00:22 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
11 Feb 00:00:22 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +6ms
  contribModbus:core:client Client -> reading Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7s
  contribModbus:queue:core queue serial unlock command node undefined +10s
  contribModbus:queue:core queue serial unlock command node undefined +1ms
  contribModbus:core:client Client -> failed Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3s
11 Feb 00:00:32 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm failed state after reading Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
11 Feb 00:00:32 - [warn] [modbus-read:a16a70db.ede3f] Modbus Failure On State reading Get More About It By Logging
  contribModbus:core:client Client -> broken Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
11 Feb 00:00:32 - [warn] [modbus-client:5c2c3186.30196] Client -> fsm broken state after failed Get More About It By Logging Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +3ms
  contribModbus:read Timed out +10s
11 Feb 00:00:32 - [error] [modbus-read:a16a70db.ede3f] Timed out
  contribModbus:core:client Client -> activated Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +5ms
^C11 Feb 00:00:35 - [info] Stopping flows
  contribModbus:core:client Client -> stop fsm on close Serial_9600_8_E_1 +3s
  contribModbus:core:client Client -> stopped +2ms
11 Feb 00:00:35 - [warn] [modbus-client:Serial_9600_8_E_1] Client -> stopped state without reconnecting
  contribModbus:core:client Client -> close node Serial_9600_8_E_1 +4ms
  contribModbus:config:client close node Serial_9600_8_E_1 +0ms
  contribModbus:core:client Client -> Connection closed simple Serial_9600_8_E_1 +2ms
  contribModbus:core:client Client -> stop fsm on close 5c2c3186.30196 Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +4ms
  contribModbus:core:client Client -> stopped Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +1ms
11 Feb 00:00:35 - [warn] [modbus-client:5c2c3186.30196] Client -> stopped state without reconnecting Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1
11 Feb 00:00:35 - [warn] [modbus-read:a16a70db.ede3f] Client -> resetIntervalToRead node a16a70db.ede3fundefined
  contribModbus:core:client Client -> close node 5c2c3186.30196 Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +7ms
  contribModbus:config:client close node 5c2c3186.30196 +14ms
11 Feb 00:00:35 - [warn] [modbus-read:a16a70db.ede3f] Client -> close node a16a70db.ede3fundefined
  contribModbus:core:client Client -> Connection closed well 5c2c3186.30196 Serial@/dev/ttyUSB0:19200bit/s default Unit-Id: 1 +24ms

The Debug-Log in Node-RED changed as well:

Topic		Replies	Views
Can connect to Modbus RTU slave with Modbus-serial but not the Modbus Package General	5	2173	26 March 2021
Node-RED-Modbus RTU CRC error Industrial	20	2488	16 March 2021
Modbus help please General	6	1863	23 February 2019
Modbus Failure On State sending Get More About It By Logging General	3	286	14 January 2024
Help to read data using modbus tcp protocol General	1	2882	31 July 2019

Debugging - node-red-contrib-modbus - serial RTU

Related topics