search

scs / smartmeter-datacollector-configurator

Smart Meter Data Collector Configurator
Other
0 stars 0 forks source link

Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.) #13

Closed kafisatz closed 1 year ago

kafisatz commented 1 year ago

I freshly installed the new RPI image (the previous version was running fine).

Any idea why 'bin/ls /dev/serial/by-id/' is not working for me?

I also tried setting the port manually to '/dev/ttyUSB0' (which worked fine before the upgrade)

see log below

-- Boot 59bab5fef9b844839f0d56e91394221c --
Jul 04 17:00:51 raspberrypi systemd[1]: Starting Smart Meter Data Collector Configurator Service...
Jul 04 17:00:52 raspberrypi systemd[1]: Started Smart Meter Data Collector Configurator Service.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Serving static files from /usr/lib/python3/dist-packages/smartmeter_datacollector_configurator/static.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Started server process [476]
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Waiting for application startup.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Application startup complete.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Uvicorn running on http://0.0.0.0:8000 (Press CTRL+C to quit)
Jul 04 17:01:16 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58704 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:01:21 raspberrypi smartmeter-datacollector-configurator[476]: WARNING:  Unable to read config file. Returning empty config.
Jul 04 17:01:21 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:01:37 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:37 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:40 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:40 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Configuration updated.
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/config HTTP/1.1" 200 OK
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:20 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:20 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Demo services successfully restarted.
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart-demo HTTP/1.1" 200 OK
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:30 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Demo services successfully restarted.
Jul 04 17:06:30 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart-demo HTTP/1.1" 200 OK
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:06:42 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Configuration updated.
Jul 04 17:06:42 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "POST /api/config HTTP/1.1" 200 OK
Jul 04 17:06:43 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:43 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:44 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:45 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:45 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET /api/ttydevices HTTP/1.1" 200 OK

pi@raspberrypi:/dev $ retrieve_tty_devices
-bash: retrieve_tty_devices: command not found
pi@raspberrypi:/dev $ journalctl -u python3-smartmeter-datacollector-configurator
-- Journal begins at Wed 2023-05-24 23:22:35 CEST, ends at Tue 2023-07-04 17:09:47 CEST. --
May 24 23:23:01 raspberrypi systemd[1]: Starting Smart Meter Data Collector Configurator Service...
May 24 23:23:01 raspberrypi systemd[1]: Started Smart Meter Data Collector Configurator Service.
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Serving static files from /usr/lib/python3/dist-packages/smartmeter_datacollector_configurator/static.
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: WARNING:  Unable to read password file. '[Errno 2] No such file or directory: '/var/lib/smartmeter-datacollector/password.txt''
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]:         Generating new file with default password.
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Started server process [471]
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Waiting for application startup.
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Application startup complete.
May 24 23:23:04 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Uvicorn running on http://0.0.0.0:8000 (Press CTRL+C to quit)
Jul 04 16:49:34 raspberrypi smartmeter-datacollector-configurator[471]: WARNING:  Unable to read config file. Returning empty config.
Jul 04 16:49:34 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 16:49:36 raspberrypi smartmeter-datacollector-configurator[471]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 16:49:36 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 16:49:38 raspberrypi smartmeter-datacollector-configurator[471]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 16:49:38 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 16:49:38 raspberrypi smartmeter-datacollector-configurator[471]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 16:49:38 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 16:49:39 raspberrypi smartmeter-datacollector-configurator[471]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 16:49:39 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 16:49:39 raspberrypi smartmeter-datacollector-configurator[471]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 16:49:39 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     10.14.15.209:58280 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 16:52:31 raspberrypi systemd[1]: Stopping Smart Meter Data Collector Configurator Service...
Jul 04 16:52:31 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Shutting down
Jul 04 16:52:31 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Waiting for application shutdown.
Jul 04 16:52:31 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Application shutdown complete.
Jul 04 16:52:31 raspberrypi smartmeter-datacollector-configurator[471]: INFO:     Finished server process [471]
Jul 04 16:52:31 raspberrypi systemd[1]: python3-smartmeter-datacollector-configurator.service: Succeeded.
Jul 04 16:52:31 raspberrypi systemd[1]: Stopped Smart Meter Data Collector Configurator Service.
Jul 04 16:52:31 raspberrypi systemd[1]: python3-smartmeter-datacollector-configurator.service: Consumed 3.343s CPU time.
-- Boot d2c9f74987a44efd90b5212ab4db5624 --
Jul 04 16:52:37 raspberrypi systemd[1]: Starting Smart Meter Data Collector Configurator Service...
Jul 04 16:52:37 raspberrypi systemd[1]: Started Smart Meter Data Collector Configurator Service.
Jul 04 16:52:39 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Serving static files from /usr/lib/python3/dist-packages/smartmeter_datacollector_configurator/static.
Jul 04 16:52:39 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Started server process [468]
Jul 04 16:52:39 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Waiting for application startup.
Jul 04 16:52:39 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Application startup complete.
Jul 04 16:52:39 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Uvicorn running on http://0.0.0.0:8000 (Press CTRL+C to quit)
Jul 04 17:00:48 raspberrypi systemd[1]: Stopping Smart Meter Data Collector Configurator Service...
Jul 04 17:00:48 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Shutting down
Jul 04 17:00:48 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Waiting for application shutdown.
Jul 04 17:00:48 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Application shutdown complete.
Jul 04 17:00:48 raspberrypi smartmeter-datacollector-configurator[468]: INFO:     Finished server process [468]
Jul 04 17:00:48 raspberrypi systemd[1]: python3-smartmeter-datacollector-configurator.service: Succeeded.
Jul 04 17:00:48 raspberrypi systemd[1]: Stopped Smart Meter Data Collector Configurator Service.
Jul 04 17:00:48 raspberrypi systemd[1]: python3-smartmeter-datacollector-configurator.service: Consumed 2.888s CPU time.
-- Boot 59bab5fef9b844839f0d56e91394221c --
Jul 04 17:00:51 raspberrypi systemd[1]: Starting Smart Meter Data Collector Configurator Service...
Jul 04 17:00:52 raspberrypi systemd[1]: Started Smart Meter Data Collector Configurator Service.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Serving static files from /usr/lib/python3/dist-packages/smartmeter_datacollector_configurator/static.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Started server process [476]
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Waiting for application startup.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Application startup complete.
Jul 04 17:00:54 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Uvicorn running on http://0.0.0.0:8000 (Press CTRL+C to quit)
Jul 04 17:01:16 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58704 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:01:21 raspberrypi smartmeter-datacollector-configurator[476]: WARNING:  Unable to read config file. Returning empty config.
Jul 04 17:01:21 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:01:37 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:37 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:39 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:40 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:40 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:01:41 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58703 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Configuration updated.
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/config HTTP/1.1" 200 OK
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:17 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:20 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:20 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Demo services successfully restarted.
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart-demo HTTP/1.1" 200 OK
Jul 04 17:06:24 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:30 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Demo services successfully restarted.
Jul 04 17:06:30 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "POST /api/restart-demo HTTP/1.1" 200 OK
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:06:31 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58949 - "GET /api/ttydevices HTTP/1.1" 200 OK
Jul 04 17:06:42 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     Configuration updated.
Jul 04 17:06:42 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "POST /api/config HTTP/1.1" 200 OK
Jul 04 17:06:43 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     python3-smartmeter-datacollector successfully restarted.
Jul 04 17:06:43 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "POST /api/restart HTTP/1.1" 200 OK
Jul 04 17:06:44 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:45 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:45 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET / HTTP/1.1" 304 Not Modified
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET /api/config HTTP/1.1" 200 OK
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: ERROR:    Unable to get tty devices. (Command '/bin/ls /dev/serial/by-id/*' returned non-zero exit status 2.)
Jul 04 17:06:49 raspberrypi smartmeter-datacollector-configurator[476]: INFO:     10.14.15.209:58950 - "GET /api/ttydevices HTTP/1.1" 200 OK

pi@raspberrypi:/dev $ lsusb
Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 003: ID 0403:6001 Future Technology Devices International, Ltd FT232 Serial (UART) IC
Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
pi@raspberrypi:/dev $ ls /dev/ttyU*
/dev/ttyUSB0
pi@raspberrypi:/dev $  dmesg | grep -i serial
[    0.049433] Serial: AMBA PL011 UART driver
[    1.560718] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.560789] usb usb1: SerialNumber: 0000:01:00.0
[    1.562656] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.562727] usb usb2: SerialNumber: 0000:01:00.0
[    1.606186] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.606958] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.607123] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.967824] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.385687] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.385763] usb 1-1.3: SerialNumber: AB0LONW7
[    6.468535] usbcore: registered new interface driver usbserial_generic
[    6.468686] usbserial: USB Serial support registered for generic
[    6.498103] usbserial: USB Serial support registered for FTDI USB Serial Device
[    6.498364] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[    6.513594] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB0
[    7.375821] uart-pl011 fe201000.serial: no DMA platform data
pi@raspberrypi:/dev $ dmesg | grep -i FTDI
[    2.385741] usb 1-1.3: Manufacturer: FTDI
[    6.497005] usbcore: registered new interface driver ftdi_sio
[    6.498103] usbserial: USB Serial support registered for FTDI USB Serial Device
[    6.498364] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[    6.513594] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB0
pi@raspberrypi:/dev $ dmesg
[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[    0.000000] Linux version 6.1.21-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1642 SMP PREEMPT Mon Apr  3 17:24:16 BST 2023
[    0.000000] random: crng init done
[    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.4
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x000000000ec00000, size 512 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000003fffffff]
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000ffffffff]
[    0.000000]   Normal   [mem 0x0000000100000000-0x00000001ffffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000003b3fffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000]   node   0: [mem 0x0000000100000000-0x00000001ffffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001ffffffff]
[    0.000000] On node 0, zone DMA32: 19456 pages in unavailable ranges
[    0.000000] On node 0, zone Normal: 16384 pages in unavailable ranges
[    0.000000] percpu: Embedded 29 pages/cpu s78504 r8192 d32088 u118784
[    0.000000] pcpu-alloc: s78504 r8192 d32088 u118784 alloc=29*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Detected PIPT I-cache on CPU0
[    0.000000] CPU features: detected: Spectre-v2
[    0.000000] CPU features: detected: Spectre-v3a
[    0.000000] CPU features: detected: Spectre-v4
[    0.000000] CPU features: detected: Spectre-BHB
[    0.000000] CPU features: kernel page table isolation forced ON by KASLR
[    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
[    0.000000] CPU features: detected: ARM erratum 1742098
[    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 2028848
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0  smsc95xx.macaddr=E4:5F:01:0E:73:7E vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=d5b38ea9-02 rootfstype=ext4 fsck.repair=yes rootwait
[    0.000000] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.000000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: area num 4.
[    0.000000] software IO TLB: mapped [mem 0x0000000037400000-0x000000003b400000] (64MB)
[    0.000000] Memory: 7471364K/8245248K available (11776K kernel code, 2106K rwdata, 3688K rodata, 4160K init, 1077K bss, 249596K reserved, 524288K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 39744 entries in 156 pages
[    0.000000] ftrace: allocated 156 pages with 4 groups
[    0.000000] trace event string verifier disabled
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    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 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000001] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000310] Console: colour dummy device 80x25
[    0.000920] printk: console [tty1] enabled
[    0.000997] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[    0.001038] pid_max: default: 32768 minimum: 301
[    0.001181] LSM: Security Framework initializing
[    0.001459] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.001593] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.002876] cgroup: Disabling memory control group subsystem
[    0.005133] cblist_init_generic: Setting adjustable number of callback queues.
[    0.005169] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005362] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005554] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.006010] rcu: Hierarchical SRCU implementation.
[    0.006035] rcu:     Max phase no-delay instances is 1000.
[    0.007374] EFI services will not be available.
[    0.007994] smp: Bringing up secondary CPUs ...
[    0.009077] Detected PIPT I-cache on CPU1
[    0.009229] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
[    0.010379] Detected PIPT I-cache on CPU2
[    0.010503] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
[    0.011615] Detected PIPT I-cache on CPU3
[    0.011738] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
[    0.011883] smp: Brought up 1 node, 4 CPUs
[    0.012016] SMP: Total of 4 processors activated.
[    0.012037] CPU features: detected: 32-bit EL0 Support
[    0.012056] CPU features: detected: 32-bit EL1 Support
[    0.012078] CPU features: detected: CRC32 instructions
[    0.012221] CPU: All CPU(s) started at EL2
[    0.012255] alternatives: applying system-wide alternatives
[    0.014276] devtmpfs: initialized
[    0.026229] Enabled cp15_barrier support
[    0.026295] Enabled setend support
[    0.026526] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.026578] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.041010] pinctrl core: initialized pinctrl subsystem
[    0.041914] DMI not present or invalid.
[    0.042618] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.046228] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[    0.046545] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.047505] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.047617] audit: initializing netlink subsys (disabled)
[    0.047912] audit: type=2000 audit(0.044:1): state=initialized audit_enabled=0 res=1
[    0.048561] thermal_sys: Registered thermal governor 'step_wise'
[    0.048653] cpuidle: using governor menu
[    0.049043] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.049254] ASID allocator initialised with 32768 entries
[    0.049433] Serial: AMBA PL011 UART driver
[    0.062466] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.084289] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-03-17T10:50:39, variant start
[    0.088303] raspberrypi-firmware soc:firmware: Firmware hash is 82f3750a65fadae9a38077e3c2e217ad158c8d54
[    0.104230] KASLR enabled
[    0.140021] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.145779] SCSI subsystem initialized
[    0.146065] usbcore: registered new interface driver usbfs
[    0.146138] usbcore: registered new interface driver hub
[    0.146217] usbcore: registered new device driver usb
[    0.146604] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.146831] usb_phy_generic phy: dummy supplies not allowed for exclusive requests
[    0.147205] pps_core: LinuxPPS API ver. 1 registered
[    0.147229] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.147270] PTP clock support registered
[    0.148379] vgaarb: loaded
[    0.149106] clocksource: Switched to clocksource arch_sys_counter
[    0.150122] VFS: Disk quotas dquot_6.6.0
[    0.150219] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.150415] FS-Cache: Loaded
[    0.150603] CacheFiles: Loaded
[    0.159808] NET: Registered PF_INET protocol family
[    0.160903] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.169945] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear)
[    0.170076] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.170125] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.170629] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear)
[    0.173222] TCP: Hash tables configured (established 65536 bind 65536)
[    0.173524] UDP hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.173690] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.174089] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.174959] RPC: Registered named UNIX socket transport module.
[    0.174993] RPC: Registered udp transport module.
[    0.175012] RPC: Registered tcp transport module.
[    0.175031] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.175065] PCI: CLS 0 bytes, default 64
[    0.177778] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    0.178188] kvm [1]: IPA Size Limit: 44 bits
[    0.179541] kvm [1]: vgic interrupt IRQ9
[    0.179792] kvm [1]: Hyp mode initialized successfully
[    1.310052] Initialise system trusted keyrings
[    1.310549] workingset: timestamp_bits=46 max_order=21 bucket_order=0
[    1.318201] zbud: loaded
[    1.321232] NFS: Registering the id_resolver key type
[    1.321289] Key type id_resolver registered
[    1.321310] Key type id_legacy registered
[    1.321433] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.321462] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    1.322865] Key type asymmetric registered
[    1.322898] Asymmetric key parser 'x509' registered
[    1.322999] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    1.323289] io scheduler mq-deadline registered
[    1.323318] io scheduler kyber registered
[    1.325495] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 27)
[    1.334234] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.334299] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.334402] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.334500] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
[    1.335555] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.335588] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.335617] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.335705] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.335972] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.340162] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
[    1.340378] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
[    1.340495] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
[    1.403200] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.403378] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.403515] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.404010] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.404801] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.404841] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.404898] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.404929] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.418306] iproc-rng200 fe104000.rng: hwrng registered
[    1.418891] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.420385] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    1.433276] brd: module loaded
[    1.441941] loop: module loaded
[    1.442752] Loading iSCSI transport class v2.0-870.
[    1.448113] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.509268] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.510444] usbcore: registered new interface driver r8152
[    1.510550] usbcore: registered new interface driver lan78xx
[    1.510636] usbcore: registered new interface driver smsc95xx
[    1.558133] pci 0000:00:00.0: enabling device (0000 -> 0002)
[    1.558339] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.558383] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.559140] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0001e40000000890
[    1.560228] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.560263] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.560299] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.560682] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    1.560718] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.560745] usb usb1: Product: xHCI Host Controller
[    1.560767] usb usb1: Manufacturer: Linux 6.1.21-v8+ xhci-hcd
[    1.560789] usb usb1: SerialNumber: 0000:01:00.0
[    1.561595] hub 1-0:1.0: USB hub found
[    1.561686] hub 1-0:1.0: 1 port detected
[    1.562620] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
[    1.562656] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.562683] usb usb2: Product: xHCI Host Controller
[    1.562705] usb usb2: Manufacturer: Linux 6.1.21-v8+ xhci-hcd
[    1.562727] usb usb2: SerialNumber: 0000:01:00.0
[    1.563381] hub 2-0:1.0: USB hub found
[    1.563501] hub 2-0:1.0: 4 ports detected
[    1.565336] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.565687] dwc_otg: FIQ enabled
[    1.565699] dwc_otg: NAK holdoff enabled
[    1.565709] dwc_otg: FIQ split-transaction FSM enabled
[    1.565726] Module dwc_common_port init
[    1.566299] usbcore: registered new interface driver uas
[    1.566418] usbcore: registered new interface driver usb-storage
[    1.566664] mousedev: PS/2 mouse device common for all mice
[    1.573226] sdhci: Secure Digital Host Controller Interface driver
[    1.573266] sdhci: Copyright(c) Pierre Ossman
[    1.573947] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.577612] ledtrig-cpu: registered to indicate activity on CPUs
[    1.577980] hid: raw HID events driver (C) Jiri Kosina
[    1.578206] usbcore: registered new interface driver usbhid
[    1.578232] usbhid: USB HID core driver
[    1.587873] NET: Registered PF_PACKET protocol family
[    1.588013] Key type dns_resolver registered
[    1.589449] registered taskstats version 1
[    1.589552] Loading compiled-in X.509 certificates
[    1.590468] Key type .fscrypt registered
[    1.590496] Key type fscrypt-provisioning registered
[    1.606186] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.606958] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.607123] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.616289] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.616776] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.618135] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.618169] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.645477] of_cfs_init
[    1.645658] of_cfs_init: OK
[    1.681143] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    1.681490] Waiting for root device PARTUUID=d5b38ea9-02...
[    1.729249] mmc1: new high speed SDIO card at address 0001
[    1.784124] mmc0: new ultra high speed DDR50 SDHC card at address aaaa
[    1.785215] mmcblk0: mmc0:aaaa SP32G 29.7 GiB
[    1.788400]  mmcblk0: p1 p2
[    1.788998] mmcblk0: mmc0:aaaa SP32G 29.7 GiB (quirks 0x00004000)
[    1.804238] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    1.804369] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.805188] devtmpfs: mounted
[    1.814015] Freeing unused kernel memory: 4160K
[    1.814234] Run /sbin/init as init process
[    1.814256]   with arguments:
[    1.814265]     /sbin/init
[    1.814275]   with environment:
[    1.814284]     HOME=/
[    1.814293]     TERM=linux
[    1.817141] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.967761] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    1.967824] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    1.967852] usb 1-1: Product: USB2.0 Hub
[    1.969869] hub 1-1:1.0: USB hub found
[    1.970239] hub 1-1:1.0: 4 ports detected
[    2.166557] systemd[1]: System time before build time, advancing clock.
[    2.265167] usb 1-1.3: new full-speed USB device number 3 using xhci_hcd
[    2.347308] NET: Registered PF_INET6 protocol family
[    2.349346] Segment Routing with IPv6
[    2.349405] In-situ OAM (IOAM) with IPv6
[    2.385622] usb 1-1.3: New USB device found, idVendor=0403, idProduct=6001, bcdDevice= 6.00
[    2.385687] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.385717] usb 1-1.3: Product: FT232R USB UART
[    2.385741] usb 1-1.3: Manufacturer: FTDI
[    2.385763] usb 1-1.3: SerialNumber: AB0LONW7
[    2.419440] systemd[1]: systemd 247.3-7+deb11u2 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified)
[    2.420517] systemd[1]: Detected architecture arm64.
[    2.432267] systemd[1]: Set hostname to <raspberrypi>.
[    3.127126] systemd[1]: Queued start job for default target Multi-User System.
[    3.150795] systemd[1]: Created slice system-getty.slice.
[    3.152539] systemd[1]: Created slice system-modprobe.slice.
[    3.153960] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    3.155130] systemd[1]: Created slice User and Session Slice.
[    3.155970] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    3.156731] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.158203] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.158738] systemd[1]: Reached target Local Encrypted Volumes.
[    3.159246] systemd[1]: Reached target Paths.
[    3.159654] systemd[1]: Reached target Slices.
[    3.160051] systemd[1]: Reached target Swap.
[    3.161381] systemd[1]: Listening on Syslog Socket.
[    3.162438] systemd[1]: Listening on fsck to fsckd communication Socket.
[    3.163129] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    3.164657] systemd[1]: Listening on Journal Audit Socket.
[    3.165819] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.167099] systemd[1]: Listening on Journal Socket.
[    3.170929] systemd[1]: Listening on udev Control Socket.
[    3.172062] systemd[1]: Listening on udev Kernel Socket.
[    3.173428] systemd[1]: Condition check resulted in Huge Pages File System being skipped.
[    3.205621] systemd[1]: Mounting POSIX Message Queue File System...
[    3.211125] systemd[1]: Mounting RPC Pipe File System...
[    3.217473] systemd[1]: Mounting Kernel Debug File System...
[    3.224090] systemd[1]: Mounting Kernel Trace File System...
[    3.225188] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
[    3.233343] systemd[1]: Starting Restore / save the current clock...
[    3.243764] systemd[1]: Starting Set the console keyboard layout...
[    3.250016] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    3.256555] systemd[1]: Starting Load Kernel Module configfs...
[    3.263128] systemd[1]: Starting Load Kernel Module drm...
[    3.269720] systemd[1]: Starting Load Kernel Module fuse...
[    3.273585] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
[    3.281618] systemd[1]: Starting File System Check on Root Device...
[    3.294781] systemd[1]: Starting Journal Service...
[    3.325245] fuse: init (API version 7.37)
[    3.366099] systemd[1]: Starting Load Kernel Modules...
[    3.371919] systemd[1]: Starting Coldplug All udev Devices...
[    3.391194] systemd[1]: Mounted POSIX Message Queue File System.
[    3.402789] systemd[1]: Mounted RPC Pipe File System.
[    3.403893] systemd[1]: Mounted Kernel Debug File System.
[    3.404921] systemd[1]: Mounted Kernel Trace File System.
[    3.407595] systemd[1]: Finished Restore / save the current clock.
[    3.414326] systemd[1]: Finished Create list of static device nodes for the current kernel.
[    3.419221] systemd[1]: modprobe@configfs.service: Succeeded.
[    3.421807] systemd[1]: Finished Load Kernel Module configfs.
[    3.428359] systemd[1]: modprobe@fuse.service: Succeeded.
[    3.430582] systemd[1]: Finished Load Kernel Module fuse.
[    3.461936] systemd[1]: Mounting FUSE Control File System...
[    3.468011] systemd[1]: Mounting Kernel Configuration File System...
[    3.474979] systemd[1]: Started File System Check Daemon to report status.
[    3.484003] systemd[1]: modprobe@drm.service: Succeeded.
[    3.485794] systemd[1]: Finished Load Kernel Module drm.
[    3.488682] systemd[1]: Finished Load Kernel Modules.
[    3.490165] systemd[1]: Mounted FUSE Control File System.
[    3.495907] systemd[1]: Starting Apply Kernel Variables...
[    3.522700] systemd[1]: Mounted Kernel Configuration File System.
[    3.550395] systemd[1]: Finished File System Check on Root Device.
[    3.590619] systemd[1]: Starting Remount Root and Kernel File Systems...
[    3.593769] systemd[1]: Finished Apply Kernel Variables.
[    3.727836] systemd[1]: Finished Set the console keyboard layout.
[    3.740733] EXT4-fs (mmcblk0p2): re-mounted. Quota mode: none.
[    3.747495] systemd[1]: Started Journal Service.
[    3.825170] systemd-journald[141]: Received client request to flush runtime journal.
[    3.836799] systemd-journald[141]: File /var/log/journal/82f0526b998c402a952677f72b3ceafe/system.journal corrupted or uncleanly shut down, renaming and replacing.
[    4.802310] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    4.811499] mc: Linux media interface: v0.10
[    4.850021] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    4.850064] [vc_sm_connected_init]: start
[    4.851091] [vc_sm_connected_init]: installed successfully
[    4.932942] brcmstb-i2c fef04500.i2c:  @97500hz registered in polling mode
[    4.950753] videodev: Linux video capture interface: v2.00
[    4.964959] brcmstb-i2c fef09500.i2c:  @97500hz registered in polling mode
[    5.165441] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    5.178706] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    5.206071] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    5.211051] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    5.212864] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    5.228732] bcm2835_audio bcm2835_audio: card created with 8 channels
[    5.240852] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    5.240949] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    5.257250] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    5.257312] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    5.266259] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    5.266325] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    5.269190] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
[    5.279029] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[    5.279100] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[    5.302320] bcm2835-codec bcm2835-codec: Device registered as /dev/video31
[    5.302422] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
[    5.329795] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    5.356342] rpivid feb10000.codec: Device registered as /dev/video19
[    5.406116] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    5.423588] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    5.450651] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    5.451346] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    5.451385] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    5.451408] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    5.451426] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    5.451442] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    5.462615] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    5.474797] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    5.480648] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
[    5.485534] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
[    5.488237] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
[    5.490605] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
[    5.506568] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
[    5.506618] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    5.506640] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    5.506658] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    5.506675] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    5.587355] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    5.878989] brcmfmac: F1 signature read @0x18000000=0x15264345
[    5.903550] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    5.937638] usbcore: registered new interface driver brcmfmac
[    6.168794] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
[    6.468535] usbcore: registered new interface driver usbserial_generic
[    6.468686] usbserial: USB Serial support registered for generic
[    6.497005] usbcore: registered new interface driver ftdi_sio
[    6.498103] usbserial: USB Serial support registered for FTDI USB Serial Device
[    6.498364] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected
[    6.498591] usb 1-1.3: Detected FT232R
[    6.513594] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB0
[    6.765513] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4])
[    6.768910] Registered IR keymap rc-cec
[    6.769630] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0
[    6.770336] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0
[    6.779067] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4])
[    6.783729] Registered IR keymap rc-cec
[    6.784407] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1
[    6.785072] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input1
[    6.833866] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4])
[    6.834510] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4])
[    6.849480] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4])
[    6.867164] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4])
[    6.885441] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4])
[    6.885914] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4])
[    6.886465] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4])
[    6.898385] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[    6.899196] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    7.375821] uart-pl011 fe201000.serial: no DMA platform data
[    7.461047] 8021q: 802.1Q VLAN Support v1.8
[    7.567650] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[    8.190921] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[    8.192510] bcmgenet fd580000.ethernet eth0: Link is Down
[   11.261412] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[   11.261491] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   15.188503] Bluetooth: Core ver 2.22
[   15.188592] NET: Registered PF_BLUETOOTH protocol family
[   15.188597] Bluetooth: HCI device and connection manager initialized
[   15.188613] Bluetooth: HCI socket layer initialized
[   15.188621] Bluetooth: L2CAP socket layer initialized
[   15.188633] Bluetooth: SCO socket layer initialized
[   15.197537] Bluetooth: HCI UART driver ver 2.3
[   15.197559] Bluetooth: HCI UART protocol H4 registered
[   15.197618] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   15.197788] Bluetooth: HCI UART protocol Broadcom registered
[   15.538183] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   15.538202] Bluetooth: BNEP filters: protocol multicast
[   15.538215] Bluetooth: BNEP socket layer initialized
[   15.542262] Bluetooth: MGMT ver 1.22
[   15.549857] NET: Registered PF_ALG protocol family
pi@raspberrypi:/dev $
raymar9 commented 1 year ago

Probably because /dev/serial/by-id/* has not been created by udev for some reason. I just checked again with my test setup. I have no problem with this new feature.

The reason to check the directory /dev/serial/by-id is to clearly define the dongle for a smartmeter. Relating on /dev/ttyUSB* is problematic if more than one dongle is plugged in. It could be assigned the other way around after the next boot. Nevertheless, you can still assign a custom device to a smart meter as you found out. What exactly did not work after you used entered /dev/ttyUSB0?

You only provided log from the smartmeter-datacollector-configurator service. What about smartmeter-datacollector service which uses the generated config from the configurator?

Can you also provide the generated config after you deployed it in the web application? It is stored at /var/lib/smartmeter-datacollector/datacollector.ini.

kafisatz commented 1 year ago

The config /var/lib/smartmeter-datacollector/datacollector.ini looks fine, see screenshot. I note that the web UI will show the TTY USB Port as '' (empty) when I load the config, this is because the drop down is empty (because the above function fails).

The data collector it self is working fine.

I think we can close this issue. I was irritated by the fact that the datacollector-configurator journal shows an ERROR (I think it is triggered by the refresh button on the Web UI). But I can see now that things are working fine when I type the port by hand and save the config (although it is not loaded properly).

image
kafisatz commented 1 year ago

Can you tell me how to create /dev/serial/by-id/* manually? @raymar9

raymar9 commented 1 year ago

I note that the web UI will show the TTY USB Port as '' (empty) when I load the config, this is because the drop down is empty (because the above function fails).

Ok, I try to fix this in a future release. Thanks for the feedback.

I was irritated by the fact that the datacollector-configurator journal shows an ERROR (I think it is triggered by the refresh button on the Web UI). But I can see now that things are working fine when I type the port by hand and save the config (although it is not loaded properly).

Yes, the web UI automatically tries to retrieve the tty devices or does that explicitly when pressing the "refresh Button".

Can you tell me how to create /dev/serial/by-id/* manually?

This should only be done with udev. Maybe the following link helps: https://unix.stackexchange.com/questions/66901/how-to-bind-usb-device-under-a-static-name