GS-1KVAS-RK - Vultech Server Series RACK 1000VA

[grydan]

Hi , I have a problem with this model. Here the URL https://www.vultech.it/it/serie-server/972-gruppo-di-continuit%C3%A0-server-series-rack-1000va-gs-1kvas-rk-onda-sinusoidale-8052780306003.html

Native software is "PowerManager II"

I have a new rasperry pi4 and I have installed the release from repository (2.8.0.7)

lsusb

Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 001 Device 010: ID 0925:1234 Lakeview Research STD UPS MON V2.0
Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

lsusb -vvv -d0925:

Bus 001 Device 010: ID 0925:1234 Lakeview Research STD UPS MON V2.0
Couldn't open device, some information will be missing
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               1.10
  bDeviceClass            0
  bDeviceSubClass         0
  bDeviceProtocol         0
  bMaxPacketSize0         8
  idVendor           0x0925 Lakeview Research
  idProduct          0x1234
  bcdDevice            0.01
  iManufacturer           0
  iProduct                1 STD UPS MON V2.0
  iSerial                 2 J9552E6E43FBC05
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength       0x0022
    bNumInterfaces          1
    bConfigurationValue     1
    iConfiguration          0
    bmAttributes         0x80
      (Bus Powered)
    MaxPower              100mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         3 Human Interface Device
      bInterfaceSubClass      0
      bInterfaceProtocol      0
      iInterface              0
        HID Device Descriptor:
          bLength                 9
          bDescriptorType        33
          bcdHID               1.00
          bCountryCode            0 Not supported
          bNumDescriptors         1
          bDescriptorType        34 Report
          wDescriptorLength      78
         Report Descriptors:
           ** UNAVAILABLE **
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0006  1x 6 bytes
        bInterval               1

/etc/nut/ups.conf

[vultech]
driver = nutdrv_qx
desc = "Vultech GS-1KVAS-RK"
port = auto
vendorid = "0925"
productid = "1234"
subdriver = "armac"
product = "STD UPS MON V2.0"
bus = 001

sudo /usr/lib/nut/nutdrv_qx -DDDD -a vultech

Network UPS Tools - Generic Q* USB/Serial driver 0.32 (2.8.0)
USB communication driver (libusb 1.0) 0.43
   0.000000     [D3] do_global_args: var='maxretry' val='3'
   0.000704     [D3] main_arg: var='driver' val='nutdrv_qx'
   0.000904     [D3] main_arg: var='desc' val='Vultech GS-1KVAS-RK'
   0.001083     [D3] main_arg: var='port' val='auto'
   0.001307     [D3] main_arg: var='vendorid' val='0925'
   0.001510     [D3] main_arg: var='productid' val='1234'
   0.001698     [D3] main_arg: var='subdriver' val='armac'
   0.001916     [D3] main_arg: var='product' val='STD UPS MON V2.0'
   0.002113     [D3] main_arg: var='bus' val='001'
   0.002357     [D1] debug level is '4'
   0.003861     [D1] upsdrv_initups...
   0.029145     [D2] Checking device 1 of 4 (1D6B/0003)
   0.029357     [D1] Failed to open device (1D6B/0003), skipping: Access denied (insufficient permissions)
   0.029812     [D2] Checking device 2 of 4 (0925/1234)
   0.037222     [D2] - VendorID: 0925
   0.037302     [D2] - ProductID: 1234
   0.037709     [D2] - Manufacturer: unknown
   0.037779     [D2] - Product: STD UPS MON V2.0
   0.038156     [D2] - Serial Number: J9552E6E43FBC05
   0.038225     [D2] - Bus: 001
   0.038595     [D2] - Device: unknown
   0.038662     [D2] - Device release number: 0001
   0.039036     [D2] Trying to match device
   0.039105     [D3] match_function_regex: matching a device...
   0.039696     [D2] Device matches
   0.039769     [D2] Reading first configuration descriptor
   0.039892     [D3] libusb_kernel_driver_active() returned 0
   0.039938     [D2] failed to claim USB device: Resource busy
   0.039979     [D2] Kernel driver already detached
   0.040019     [D2] failed to claim USB device: Resource busy
   0.040058     [D2] Kernel driver already detached
   0.040097     [D2] failed to claim USB device: Resource busy
   0.040139     [D2] Kernel driver already detached
   0.040178     [D2] failed to claim USB device: Resource busy
   0.040218     [D2] Kernel driver already detached
   0.040313     Can't claim USB device [0925:1234]@0/0: Entity not found

I have found a similar thread problem here: #1978

[grydan]

I have run in another moment (because the Resource busy... message) and this is result:

sudo /usr/lib/nut/nutdrv_qx -DDDD -a vultech

Network UPS Tools - Generic Q* USB/Serial driver 0.32 (2.8.0)
USB communication driver (libusb 1.0) 0.43
   0.000000     [D3] do_global_args: var='maxretry' val='3'
   0.002399     [D3] main_arg: var='driver' val='nutdrv_qx'
   0.002559     [D3] main_arg: var='desc' val='Vultech GS-1KVAS-RK'
   0.003260     [D3] main_arg: var='port' val='auto'
   0.003900     [D3] main_arg: var='vendorid' val='0925'
   0.004032     [D3] main_arg: var='productid' val='1234'
   0.004328     [D3] main_arg: var='subdriver' val='armac'
   0.004486     [D3] main_arg: var='product' val='STD UPS MON V2.0'
   0.004621     [D3] main_arg: var='bus' val='001'
   0.004745     [D1] debug level is '4'
   0.006250     [D1] upsdrv_initups...
   0.021625     [D2] Checking device 1 of 4 (1D6B/0003)
   0.021853     [D1] Failed to open device (1D6B/0003), skipping: Access denied (insufficient permissions)
   0.022324     [D2] Checking device 2 of 4 (0925/1234)
   0.030507     [D2] - VendorID: 0925
   0.030629     [D2] - ProductID: 1234
   0.031061     [D2] - Manufacturer: unknown
   0.031106     [D2] - Product: STD UPS MON V2.0
   0.031146     [D2] - Serial Number: J9552E6E43FBC05
   0.031184     [D2] - Bus: 001
   0.031222     [D2] - Device: unknown
   0.031260     [D2] - Device release number: 0001
   0.031298     [D2] Trying to match device
   0.031338     [D3] match_function_regex: matching a device...
   0.031912     [D2] Device matches
   0.031995     [D2] Reading first configuration descriptor
   0.032133     [D3] libusb_kernel_driver_active() returned 0
   0.032370     [D2] Claimed interface 0 successfully
   0.032495     [D3] nut_usb_set_altinterface: skipped libusb_set_interface_alt_setting(udev, 0, 0)
   0.032631     [D2] armac: unsupported cmd: QGS
   0.032764     [D2] qx_process_answer: short reply (input.voltage)
   0.032877     [D2] armac: unsupported cmd: QGS
   0.033008     [D2] qx_process_answer: short reply (input.voltage)
   0.033052     [D2] armac: unsupported cmd: QGS
   0.033092     [D2] qx_process_answer: short reply (input.voltage)
   0.033134     [D2] armac: unsupported cmd: M
   0.033177     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.033217     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033257     [D2] armac: unsupported cmd: M
   0.033298     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.033338     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033378     [D2] armac: unsupported cmd: M
   0.033419     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.033458     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033499     [D2] armac: unsupported cmd: M
   0.033541     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.033581     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033621     [D2] armac: unsupported cmd: M
   0.033662     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.033702     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033742     [D2] armac: unsupported cmd: M
   0.033782     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.033821     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.033862     [D2] armac: unsupported cmd: QS
   0.033903     [D2] qx_process_answer: short reply (input.voltage)
   0.033943     [D2] armac: unsupported cmd: QS
   0.033982     [D2] qx_process_answer: short reply (input.voltage)
   0.034022     [D2] armac: unsupported cmd: QS
   0.034062     [D2] qx_process_answer: short reply (input.voltage)
   0.034102     [D2] armac: unsupported cmd: D
   0.034142     [D2] qx_process_answer: short reply (input.voltage)
   0.034182     [D2] armac: unsupported cmd: D
   0.034237     [D2] qx_process_answer: short reply (input.voltage)
   0.034279     [D2] armac: unsupported cmd: D
   0.034318     [D2] qx_process_answer: short reply (input.voltage)
   0.034360     [D4] armac command Q1
   0.101586     [D4] read: ret 6 buf a6: 28 32 34 31 2e  >(241.<
   0.122582     [D4] read: ret 6 buf 86: 35 20 30 30 30  >5 000<
   0.143545     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
   0.164543     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
   0.184552     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   0.205551     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   0.226694     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
   0.247645     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   0.268640     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.769766     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   1.770643     [D1] interrupt read error: Operation timed out (-7)
   1.770866     [D4] qx_process: failed to preprocess answer [input.voltage]
   1.771905     [D4] armac command Q1
   1.850818     [D4] read: ret 6 buf a6: 28 32 34 31 2e  >(241.<
   1.871823     [D4] read: ret 6 buf 86: 34 20 30 30 30  >4 000<
   1.892864     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
   1.913859     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
   1.933829     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   1.954861     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   1.975867     [D4] read: ret 6 buf a6: 32 35 20 34 34  >25 44<
   1.996875     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   2.017871     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.521010     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   3.521873     [D1] interrupt read error: Operation timed out (-7)
   3.522091     [D4] qx_process: failed to preprocess answer [input.voltage]
   3.523065     [D4] armac command Q1
   3.601052     [D4] read: ret 6 buf a6: 28 32 34 31 2e  >(241.<
   3.622101     [D4] read: ret 6 buf 86: 37 20 30 30 30  >7 000<
   3.643094     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
   3.664101     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
   3.685099     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   3.706130     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   3.726103     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
   3.747110     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   3.768116     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.272227     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   5.272997     [D1] interrupt read error: Operation timed out (-7)
   5.273117     [D4] qx_process: failed to preprocess answer [input.voltage]
   5.273201     [D4] armac command Q1
   5.350310     [D4] read: ret 6 buf a6: 28 32 34 31 2e  >(241.<
   5.371346     [D4] read: ret 6 buf 86: 32 20 30 30 30  >2 000<
   5.392335     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
   5.413331     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
   5.434329     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   5.455306     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   5.475346     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
   5.496339     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   5.517324     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.013519     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   7.014367     [D1] interrupt read error: Operation timed out (-7)
   7.014485     [D4] qx_process: failed to preprocess answer [input.voltage]
   7.014556     [D4] armac command Q1
   7.050520     [D4] read: ret 6 buf a6: 28 32 34 31 2e  >(241.<
   7.071601     [D4] read: ret 6 buf 86: 33 20 30 30 30  >3 000<
   7.092535     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
   7.113564     [D4] read: ret 6 buf 86: 39 2e 38 20 30  >9.8 0<
   7.134574     [D4] read: ret 6 buf a6: 32 30 20 34 39  >20 49<
   7.154574     [D4] read: ret 6 buf 86: 2e 39 20 32 2e  >.9 2.<
   7.175639     [D4] read: ret 6 buf a6: 32 35 20 34 34  >25 44<
   7.196577     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   7.217552     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.715717     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   8.716482     [D1] interrupt read error: Operation timed out (-7)
   8.716574     [D4] qx_process: failed to preprocess answer [input.voltage]
   8.716651     [D4] armac command Q1
   8.801752     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
   8.822781     [D4] read: ret 6 buf 86: 39 20 30 30 30  >9 000<
   8.842791     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
   8.863791     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
   8.884794     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   8.905798     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   8.926801     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
   8.947803     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   8.967805     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.466940     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  10.467704     [D1] interrupt read error: Operation timed out (-7)
  10.467823     [D4] qx_process: failed to preprocess answer [input.voltage]
  10.467910     [D4] armac command Q1
  10.551005     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  10.572002     [D4] read: ret 6 buf 86: 35 20 30 30 30  >5 000<
  10.592029     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
  10.612996     [D4] read: ret 6 buf 86: 30 2e 31 20 30  >0.1 0<
  10.634034     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  10.655004     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  10.676069     [D4] read: ret 6 buf a6: 32 35 20 34 34  >25 44<
  10.697041     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  10.717042     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.218151     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  12.218923     [D1] interrupt read error: Operation timed out (-7)
  12.219032     [D4] qx_process: failed to preprocess answer [input.voltage]
  12.219113     [D4] armac command Q1
  12.301230     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  12.322232     [D4] read: ret 6 buf 86: 37 20 30 30 30  >7 000<
  12.343266     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
  12.364267     [D4] read: ret 6 buf 86: 30 2e 36 20 30  >0.6 0<
  12.384267     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  12.405234     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  12.426277     [D4] read: ret 6 buf a6: 32 35 20 34 34  >25 44<
  12.447277     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  12.468279     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.969420     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  13.970155     [D1] interrupt read error: Operation timed out (-7)
  13.970261     [D4] qx_process: failed to preprocess answer [input.voltage]
  13.970345     [D4] armac command Q1
  14.050462     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  14.071467     [D4] read: ret 6 buf 86: 35 20 30 30 30  >5 000<
  14.092471     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  14.113502     [D4] read: ret 6 buf 86: 39 2e 38 20 30  >9.8 0<
  14.133475     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  14.154505     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  14.175514     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
  14.196515     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  14.217496     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.720696     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  15.721413     [D1] interrupt read error: Operation timed out (-7)
  15.721536     [D4] qx_process: failed to preprocess answer [input.voltage]
  15.721618     [D4] armac command Q1
  15.801740     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  15.821738     [D4] read: ret 6 buf 86: 35 20 30 30 30  >5 000<
  15.842737     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  15.863738     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
  15.884709     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  15.905745     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  15.926741     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
  15.946742     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  15.967745     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.471970     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  17.472777     [D1] interrupt read error: Operation timed out (-7)
  17.472893     [D4] qx_process: failed to preprocess answer [input.voltage]
  17.472973     [D4] armac command Q1
  17.550940     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  17.570972     [D4] read: ret 6 buf 86: 35 20 30 30 30  >5 000<
  17.591976     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  17.612970     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
  17.633977     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  17.654979     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  17.675950     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
  17.695987     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  17.716993     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.213106     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  19.213770     [D1] interrupt read error: Operation timed out (-7)
  19.213861     [D4] qx_process: failed to preprocess answer [input.voltage]
  19.213936     [D4] armac command Q1
  19.250164     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  19.271203     [D4] read: ret 6 buf 86: 32 20 30 30 30  >2 000<
  19.292211     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  19.313240     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
  19.334173     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  19.355206     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  19.375177     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
  19.396182     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  19.417185     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.913312     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  20.914116     [D1] interrupt read error: Operation timed out (-7)
  20.914237     [D4] qx_process: failed to preprocess answer [input.voltage]
  20.914331     [D2] find_nut_info: info type series not found
  20.914400     [D2] claim: cannot find series
  20.914474     [D2] find_nut_info: info type series not found
  20.914538     [D2] claim: cannot find series
  20.914610     [D2] find_nut_info: info type series not found
  20.914859     [D2] claim: cannot find series
  20.914945     [D4] armac command Q1
  21.001441     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  21.022405     [D4] read: ret 6 buf 86: 39 20 30 30 30  >9 000<
  21.042411     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
  21.063408     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
  21.084440     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  21.105442     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  21.126445     [D4] read: ret 6 buf a6: 32 33 20 34 34  >23 44<
  21.147446     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  21.167453     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.664602     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  22.665354     [D1] interrupt read error: Operation timed out (-7)
  22.665479     [D4] qx_process: failed to preprocess answer [input.voltage]
  22.665567     [D4] armac command Q1
  22.701667     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  22.721672     [D4] read: ret 6 buf 86: 37 20 30 30 30  >7 000<
  22.742638     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  22.763701     [D4] read: ret 6 buf 86: 39 2e 37 20 30  >9.7 0<
  22.784643     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  22.805671     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  22.826647     [D4] read: ret 6 buf a6: 32 31 20 34 34  >21 44<
  22.846685     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  22.867655     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.365821     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  24.366564     [D1] interrupt read error: Operation timed out (-7)
  24.366673     [D4] qx_process: failed to preprocess answer [input.voltage]
  24.366753     [D4] armac command Q1
  24.405862     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  24.426901     [D4] read: ret 6 buf 86: 37 20 30 30 30  >7 000<
  24.447943     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  24.468877     [D4] read: ret 6 buf 86: 39 2e 37 20 30  >9.7 0<
  24.489873     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
  24.509908     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  24.530880     [D4] read: ret 6 buf a6: 32 31 20 34 34  >21 44<
  24.551909     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  24.572886     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.076066     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  26.076783     [D1] interrupt read error: Operation timed out (-7)
  26.076902     [D4] qx_process: failed to preprocess answer [input.voltage]
  26.076986     [D4] armac command Q1
  26.150104     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
  26.171102     [D4] read: ret 6 buf 86: 36 20 30 30 30  >6 000<
  26.192136     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  26.213146     [D4] read: ret 6 buf 86: 39 2e 36 20 30  >9.6 0<
  26.234145     [D4] read: ret 6 buf a6: 32 30 20 34 39  >20 49<
  26.254110     [D4] read: ret 6 buf 86: 2e 39 20 32 2e  >.9 2.<
  26.275142     [D4] read: ret 6 buf a6: 32 31 20 34 34  >21 44<
  26.296117     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  26.317121     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.816256     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  27.816894     [D1] interrupt read error: Operation timed out (-7)

[jimklimov]

I am not sure the issues are that similar, but it should not hurt to try newer NUT in any case. See e.g. https://github.com/networkupstools/nut/wiki/Building-NUT-for-in%E2%80%90place-upgrades-or-non%E2%80%90disruptive-tests for notes on building a configuration similar to your current (e.g. packaged) installation which you can test right from the build workspace, and if it works - replace the existing setup by make install.

For context, in #1978 the problem is about vendors being creative with the protocol (something your second post with its "screenshots" probably confirms as a related problem, solved there and included in NUT v2.8.1 release).

Your original post however, about "device busy", is something different. Not sure OTOH why that happens - maybe some udev rules were not right and USB VID:PID remained occupied by the system or some other program. Maybe the system-started driver instance kept it busy and could not be killed (or was killed and the OS could not reap the resources back somehow)?..

[grydan]

hI jimklimov I have tried to follow your suggestion IURL, but I don't understand what I do.. can you explain me more in details if is possibile? I have follow the chapter Testing with CI helper But when I run the command: sudo ./ci_build.sh inplace this is the result_

WARNING: Did not find any CI_CCACHE_SYMLINKDIR; specify one explicitly if desired
WARNING: TMPDIR not set, trying to guess
Parallel builds would spawn up to 8 jobs (detected 4 CPUs), or peak out at 32.0 system load average
INFO: Detected CI_OS_NAME='debian'
Processing BUILD_TYPE='inplace' ...
Build host settings:
BUILD_TYPE=inplace
CI_BUILDDIR=.
CI_FAILFAST=false
CI_OS_HINT=$'PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"\nNAME="Debian GNU/Linux"\nVERSION_ID="12"\nVERSION="12 (bookworm)"\nVERSION_CODENAME=bookworm\nID=debian\nHOME_URL="https://www.debian.org/"\nSUPPORT_URL="https://www.debian.org/support"\nBUG_REPORT_URL="https://bugs.debian.org/"'
CI_OS_NAME=debian
CI_PARMAKE_VERBOSITY=silent
CI_REQUIRE_GOOD_GITIGNORE=true
CI_SKIP_CHECK=false
CI_TIME=
CI_TRACE=no
MAKE=make
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
    if [ "$HAVE_CCACHE" = yes ]; then
            if [ x"${CI_CCACHE_STATS_COMPRESSION-}" = xtrue ]; then
            echo "WARNING: CCache stats $WHEN build: tool is enabled, but CCACHE_DIR='$CCACHE_DIR' was not found now" 1>&2;
Linux raspberrypi 6.1.0-rpi4-rpi-v8 #1 SMP PREEMPT Debian 1:6.1.54-1+rpt2 (2023-10-05) aarch64 GNU/Linux
LONG_BIT:64 WORD_BIT:32
Endianness: LE
ERROR: No BUILD_TYPE was specified, doing a minimal default ritual without any required options

/tmp/nut /tmp/nut
/tmp/nut
configure: error: cannot find required auxiliary files: ar-lib missing install-sh config.guess config.sub

instead this is the result of dmesg command,

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[    0.000000] Linux version 6.1.0-rpi4-rpi-v8 (debian-kernel@lists.debian.org) (gcc-12 (Debian 12.2.0-14) 12.2.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT Debian 1:6.1.54-1+rpt2 (2023-10-05)
[    0.000000] random: crng init done
[    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.5
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x000000000dc00000, 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-0x000000007fffffff]
[    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]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[    0.000000] On node 0, zone DMA32: 19456 pages in unavailable ranges
[    0.000000] percpu: Embedded 29 pages/cpu s79144 r8192 d31448 u118784
[    0.000000] pcpu-alloc: s79144 r8192 d31448 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: 496944
[    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=D8:3A:DD:67:42:D0 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=8cde1d42-02 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles
[    0.000000] Unknown kernel command line parameters "splash", will be passed to user space.
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:all(zero), 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: 1347208K/2019328K available (12352K kernel code, 2172K rwdata, 4164K rodata, 4224K init, 1082K bss, 147832K reserved, 524288K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 40047 entries in 157 pages
[    0.000000] ftrace: allocated 157 pages with 5 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.000335] Console: colour dummy device 80x25
[    0.000394] printk: console [tty1] enabled
[    0.000454] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[    0.000481] pid_max: default: 32768 minimum: 301
[    0.000603] LSM: Security Framework initializing
[    0.000805] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.000851] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.002181] cgroup: Disabling memory control group subsystem
[    0.004464] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004481] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.004664] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004677] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.004855] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004868] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005331] rcu: Hierarchical SRCU implementation.
[    0.005344] rcu:     Max phase no-delay instances is 1000.
[    0.007520] EFI services will not be available.
[    0.008108] smp: Bringing up secondary CPUs ...
[    0.009205] Detected PIPT I-cache on CPU1
[    0.009360] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
[    0.010523] Detected PIPT I-cache on CPU2
[    0.010640] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
[    0.011779] Detected PIPT I-cache on CPU3
[    0.011899] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
[    0.012076] smp: Brought up 1 node, 4 CPUs
[    0.012098] SMP: Total of 4 processors activated.
[    0.012111] CPU features: detected: 32-bit EL0 Support
[    0.012121] CPU features: detected: 32-bit EL1 Support
[    0.012134] CPU features: detected: CRC32 instructions
[    0.012272] CPU: All CPU(s) started at EL2
[    0.012296] alternatives: applying system-wide alternatives
[    0.014130] devtmpfs: initialized
[    0.026129] Enabled cp15_barrier support
[    0.026172] Enabled setend support
[    0.026407] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.026444] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.041051] pinctrl core: initialized pinctrl subsystem
[    0.041970] DMI not present or invalid.
[    0.042634] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.046258] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[    0.046573] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.047565] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.047659] audit: initializing netlink subsys (disabled)
[    0.047936] audit: type=2000 audit(0.044:1): state=initialized audit_enabled=0 res=1
[    0.048609] thermal_sys: Registered thermal governor 'step_wise'
[    0.048698] cpuidle: using governor menu
[    0.048979] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.049179] ASID allocator initialised with 32768 entries
[    0.050116] Serial: AMBA PL011 UART driver
[    0.064791] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.088307] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start
[    0.092320] raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7
[    0.108752] KASLR enabled
[    0.142951] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.148593] iommu: Default domain type: Translated 
[    0.148610] iommu: DMA domain TLB invalidation policy: strict mode 
[    0.149071] SCSI subsystem initialized
[    0.149314] usbcore: registered new interface driver usbfs
[    0.149372] usbcore: registered new interface driver hub
[    0.149442] usbcore: registered new device driver usb
[    0.149860] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.150433] pps_core: LinuxPPS API ver. 1 registered
[    0.150447] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.150473] PTP clock support registered
[    0.151645] vgaarb: loaded
[    0.152294] clocksource: Switched to clocksource arch_sys_counter
[    0.152977] VFS: Disk quotas dquot_6.6.0
[    0.153057] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.153254] FS-Cache: Loaded
[    0.153427] CacheFiles: Loaded
[    0.163770] NET: Registered PF_INET protocol family
[    0.164517] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.167495] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
[    0.167540] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.167567] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.167704] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
[    0.168222] TCP: Hash tables configured (established 16384 bind 16384)
[    0.168676] MPTCP token hash table entries: 2048 (order: 3, 49152 bytes, linear)
[    0.168794] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.168844] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.169118] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.169890] RPC: Registered named UNIX socket transport module.
[    0.169906] RPC: Registered udp transport module.
[    0.169916] RPC: Registered tcp transport module.
[    0.169927] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.169952] PCI: CLS 0 bytes, default 64
[    0.170569] Trying to unpack rootfs image as initramfs...
[    0.182651] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    0.183101] kvm [1]: IPA Size Limit: 44 bits
[    0.184732] kvm [1]: vgic interrupt IRQ9
[    0.184991] kvm [1]: Hyp mode initialized successfully
[    1.066119] Freeing initrd memory: 16720K
[    1.251613] Initialise system trusted keyrings
[    1.252182] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[    1.259892] zbud: loaded
[    1.262846] NFS: Registering the id_resolver key type
[    1.262893] Key type id_resolver registered
[    1.262905] Key type id_legacy registered
[    1.263019] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.263036] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    1.264545] Key type asymmetric registered
[    1.264566] Asymmetric key parser 'x509' registered
[    1.264659] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    1.264963] io scheduler mq-deadline registered
[    1.264981] io scheduler kyber registered
[    1.267991] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 27)
[    1.279768] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.279812] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.279904] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.279995] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x007fffffff -> 0x0400000000
[    1.280562] brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE
[    1.281083] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.281103] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.281122] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.281203] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.281479] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.285337] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    1.285607] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
[    1.285799] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
[    1.285911] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
[    1.394403] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.394573] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.394704] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.395197] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.404435] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[    1.404483] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.404507] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.404588] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.404612] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.405065] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
[    1.405303] pcieport 0000:00:00.0: PME: Signaling with IRQ 31
[    1.405832] pcieport 0000:00:00.0: AER: enabled with IRQ 31
[    1.406480] brcm-pcie fd500000.pcie: clkreq control enabled
[    1.423226] iproc-rng200 fe104000.rng: hwrng registered
[    1.423828] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.438718] brd: module loaded
[    1.447716] loop: module loaded
[    1.448765] Loading iSCSI transport class v2.0-870.
[    1.454883] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.552459] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.553646] usbcore: registered new interface driver r8152
[    1.553720] usbcore: registered new interface driver lan78xx
[    1.553779] usbcore: registered new interface driver smsc95xx
[    1.601768] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.601811] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.602543] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890
[    1.603672] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.603695] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.603719] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.604101] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    1.604121] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.604137] usb usb1: Product: xHCI Host Controller
[    1.604151] usb usb1: Manufacturer: Linux 6.1.0-rpi4-rpi-v8 xhci-hcd
[    1.604164] usb usb1: SerialNumber: 0000:01:00.0
[    1.604976] hub 1-0:1.0: USB hub found
[    1.605045] hub 1-0:1.0: 1 port detected
[    1.606003] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
[    1.606024] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.606039] usb usb2: Product: xHCI Host Controller
[    1.606053] usb usb2: Manufacturer: Linux 6.1.0-rpi4-rpi-v8 xhci-hcd
[    1.606066] usb usb2: SerialNumber: 0000:01:00.0
[    1.606738] hub 2-0:1.0: USB hub found
[    1.606832] hub 2-0:1.0: 4 ports detected
[    1.608722] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.609082] dwc_otg: FIQ enabled
[    1.609093] dwc_otg: NAK holdoff enabled
[    1.609103] dwc_otg: FIQ split-transaction FSM enabled
[    1.609120] Module dwc_common_port init
[    1.610502] usbcore: registered new interface driver uas
[    1.610599] usbcore: registered new interface driver usb-storage
[    1.611583] mousedev: PS/2 mouse device common for all mice
[    1.619706] sdhci: Secure Digital Host Controller Interface driver
[    1.619726] sdhci: Copyright(c) Pierre Ossman
[    1.620486] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.624621] ledtrig-cpu: registered to indicate activity on CPUs
[    1.624994] hid: raw HID events driver (C) Jiri Kosina
[    1.625223] usbcore: registered new interface driver usbhid
[    1.625237] usbhid: USB HID core driver
[    1.636002] NET: Registered PF_PACKET protocol family
[    1.636144] Key type dns_resolver registered
[    1.637453] registered taskstats version 1
[    1.637542] Loading compiled-in X.509 certificates
[    1.666358] Loaded X.509 cert 'Debian Secure Boot CA: 6ccece7e4c6c0d1f6149f3dd27dfcc5cbb419ea1'
[    1.666476] Loaded X.509 cert 'Debian Secure Boot Signer 2022 - linux: 14011249c2675ea8e5148542202005810584b25f'
[    1.667404] Key type .fscrypt registered
[    1.667419] Key type fscrypt-provisioning registered
[    1.683232] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.684115] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.684355] fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.684627] serial serial0: tty port ttyAMA1 registered
[    1.694287] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.694783] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.696463] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.696486] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.727246] of_cfs_init
[    1.727384] of_cfs_init: OK
[    1.761066] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    1.770598] Freeing unused kernel memory: 4224K
[    1.770821] Run /init as init process
[    1.770833]   with arguments:
[    1.770842]     /init
[    1.770852]     splash
[    1.770862]   with environment:
[    1.770871]     HOME=/
[    1.770880]     TERM=linux
[    1.812708] mmc1: new high speed SDIO card at address 0001
[    1.860356] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.861396] mmc0: new ultra high speed DDR50 SDHC card at address 5048
[    1.862534] mmcblk0: mmc0:5048 SD32G 29.7 GiB 
[    1.866041]  mmcblk0: p1 p2
[    1.866749] mmcblk0: mmc0:5048 SD32G 29.7 GiB (quirks 0x00004000)
[    2.018930] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    2.018968] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.018985] usb 1-1: Product: USB2.0 Hub
[    2.022604] hub 1-1:1.0: USB hub found
[    2.022914] hub 1-1:1.0: 4 ports detected
[    2.316358] usb 1-1.1: new full-speed USB device number 3 using xhci_hcd
[    2.429227] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    2.429264] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    2.429281] usb 1-1.1: Product: STD UPS MON V2.0
[    2.429296] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[    2.441576] hid-generic 0003:0925:1234.0001: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[    2.726631] brcmstb-i2c fef04500.i2c:  @97500hz registered in polling mode
[    2.727618] brcmstb-i2c fef09500.i2c:  @97500hz registered in polling mode
[    2.750161] usb 1-1.1: USB disconnect, device number 3
[    2.878346] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    2.886037] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4])
[    2.889253] Registered IR keymap rc-cec
[    2.889440] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0
[    2.889664] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0
[    2.893482] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4])
[    2.896705] Registered IR keymap rc-cec
[    2.896893] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1
[    2.897094] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input1
[    2.901390] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4])
[    2.902117] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4])
[    2.902590] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.903064] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.903530] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.903845] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.904368] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.908612] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[    2.909654] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.916353] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.916525] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.976348] usb 1-1.1: new full-speed USB device number 4 using xhci_hcd
[    3.085586] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    3.085625] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    3.085642] usb 1-1.1: Product: STD UPS MON V2.0
[    3.085658] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[    3.099843] hid-generic 0003:0925:1234.0002: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[    3.395873] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    4.060619] systemd[1]: System time before build time, advancing clock.
[    4.238725] NET: Registered PF_INET6 protocol family
[    4.240574] Segment Routing with IPv6
[    4.240620] In-situ OAM (IOAM) with IPv6
[    4.318136] systemd[1]: systemd 252.17-1~deb12u1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[    4.318191] systemd[1]: Detected architecture arm64.
[    4.328471] systemd[1]: Hostname set to <raspberrypi>.
[    4.542456] usb 1-1.1: USB disconnect, device number 4
[    4.768382] usb 1-1.1: new full-speed USB device number 5 using xhci_hcd
[    4.881225] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    4.881262] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    4.881279] usb 1-1.1: Product: STD UPS MON V2.0
[    4.881293] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[    4.893342] hid-generic 0003:0925:1234.0003: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[    5.291712] systemd[1]: Queued start job for default target graphical.target.
[    5.316598] systemd[1]: Created slice system-getty.slice - Slice /system/getty.
[    5.318535] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[    5.320041] systemd[1]: Created slice system-nut\x2ddriver.slice - Slice /system/nut-driver.
[    5.321624] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
[    5.322701] systemd[1]: Created slice user.slice - User and Session Slice.
[    5.323305] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[    5.324537] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
[    5.324872] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[    5.325096] systemd[1]: Reached target nss-user-lookup.target - User and Group Name Lookups.
[    5.325333] systemd[1]: Reached target slices.target - Slice Units.
[    5.325481] systemd[1]: Reached target swap.target - Swaps.
[    5.325660] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[    5.326660] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket.
[    5.327118] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[    5.329131] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
[    5.330167] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[    5.331287] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[    5.333467] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[    5.334409] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[    5.335471] systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages).
[    5.360848] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
[    5.366619] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
[    5.372653] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
[    5.373483] systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab).
[    5.382422] systemd[1]: Starting fake-hwclock.service - Restore / save the current clock...
[    5.388453] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout...
[    5.394871] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
[    5.401818] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
[    5.409105] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
[    5.416607] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
[    5.424123] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
[    5.435230] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
[    5.442463] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
[    5.443844] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root).
[    5.456857] systemd[1]: Starting systemd-journald.service - Journal Service...
[    5.473246] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
[    5.479659] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
[    5.488057] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[    5.514735] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
[    5.516426] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com
[    5.516558] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
[    5.518322] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[    5.521309] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
[    5.533647] fuse: init (API version 7.37)
[    5.542230] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[    5.543521] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
[    5.546793] systemd[1]: Finished fake-hwclock.service - Restore / save the current clock.
[    5.550377] systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
[    5.551653] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
[    5.554655] systemd[1]: modprobe@drm.service: Deactivated successfully.
[    5.555830] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
[    5.558519] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
[    5.559829] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[    5.562645] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[    5.563858] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
[    5.566720] systemd[1]: modprobe@loop.service: Deactivated successfully.
[    5.567860] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
[    5.587580] i2c_dev: i2c /dev entries driver
[    5.601361] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
[    5.609969] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
[    5.610819] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
[    5.620450] EXT4-fs (mmcblk0p2): re-mounted. Quota mode: none.
[    5.628737] systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
[    5.641315] systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
[    5.643225] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[    5.650582] systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[    5.650889] systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
[    5.673488] systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed...
[    5.679614] systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
[    5.690812] systemd[1]: Starting systemd-sysusers.service - Create System Users...
[    5.693353] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
[    5.742534] systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed.
[    5.744246] systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[    5.777869] systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
[    5.817391] systemd[1]: Finished systemd-sysusers.service - Create System Users.
[    5.845490] systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
[    5.846913] systemd[1]: Started systemd-journald.service - Journal Service.
[    5.917758] systemd-journald[267]: Received client request to flush runtime journal.
[    5.925308] systemd-journald[267]: File /var/log/journal/55a96178d2d54848b58de36a92a5e3af/system.journal corrupted or uncleanly shut down, renaming and replacing.
[    6.334638] usb 1-1.1: USB disconnect, device number 5
[    6.564436] usb 1-1.1: new full-speed USB device number 6 using xhci_hcd
[    6.688177] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    6.688217] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    6.688235] usb 1-1.1: Product: STD UPS MON V2.0
[    6.688250] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[    6.755702] hid-generic 0003:0925:1234.0004: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[    7.161631] mc: Linux media interface: v0.10
[    7.208998] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    7.225718] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    7.227787] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    7.227825] [vc_sm_connected_init]: start
[    7.232693] rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
[    7.241157] bcm2835_audio bcm2835_audio: card created with 8 channels
[    7.248925] rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
[    7.257473] [vc_sm_connected_init]: installed successfully
[    7.312402] videodev: Linux video capture interface: v2.00
[    7.389721] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    7.422390] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    7.465552] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    7.510669] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    7.515030] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
[    7.516452] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    7.518162] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    7.524448] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    7.524500] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    7.524526] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    7.524546] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    7.524584] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    7.536428] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
[    7.540520] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
[    7.544438] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
[    7.544994] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
[    7.545035] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    7.545060] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    7.545096] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    7.545115] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    7.545402] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    7.546615] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    7.582577] rpivid feb10000.codec: Device registered as /dev/video19
[    7.588450] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    7.588537] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    7.621972] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    7.622039] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    7.648525] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    7.648588] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    7.674108] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[    7.674170] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[    7.707297] bcm2835-codec bcm2835-codec: Device registered as /dev/video31
[    7.707366] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
[    7.821233] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    7.822310] cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
[    7.823349] cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
[    7.825422] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    7.830702] platform regulatory.0: firmware: direct-loading firmware regulatory.db
[    7.831638] platform regulatory.0: firmware: direct-loading firmware regulatory.db.p7s
[    7.970164] Bluetooth: Core ver 2.22
[    7.982560] NET: Registered PF_BLUETOOTH protocol family
[    7.982591] Bluetooth: HCI device and connection manager initialized
[    7.982625] Bluetooth: HCI socket layer initialized
[    7.982648] Bluetooth: L2CAP socket layer initialized
[    7.982703] Bluetooth: SCO socket layer initialized
[    8.018615] brcmfmac: F1 signature read @0x18000000=0x15264345
[    8.042760] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    8.043767] usbcore: registered new interface driver brcmfmac
[    8.050946] Bluetooth: HCI UART driver ver 2.3
[    8.050984] Bluetooth: HCI UART protocol H4 registered
[    8.064376] Bluetooth: HCI UART protocol Three-wire (H5) registered
[    8.066128] Bluetooth: HCI UART protocol Broadcom registered
[    8.067143] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
[    8.067584] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
[    8.070148] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.bin
[    8.071491] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.txt
[    8.072471] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.clm_blob
[    8.127041] usb 1-1.1: USB disconnect, device number 6
[    8.184882] uart-pl011 fe201000.serial: no DMA platform data
[    8.352428] usb 1-1.1: new full-speed USB device number 7 using xhci_hcd
[    8.376646] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
[    8.471434] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    8.471473] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    8.471491] usb 1-1.1: Product: STD UPS MON V2.0
[    8.471507] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[    8.481223] Bluetooth: hci0: BCM: chip id 107
[    8.481678] Bluetooth: hci0: BCM: features 0x2f
[    8.482924] Bluetooth: hci0: BCM4345C0
[    8.482953] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
[    8.484849] hid-generic 0003:0925:1234.0005: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[    8.605454] bluetooth hci0: firmware: direct-loading firmware brcm/BCM4345C0.raspberrypi,4-model-b.hcd
[    8.605499] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,4-model-b.hcd' Patch
[    9.397676] Bluetooth: hci0: BCM: features 0x2f
[    9.399318] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190
[    9.399354] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382
[    9.919260] usb 1-1.1: USB disconnect, device number 7
[   10.160390] usb 1-1.1: new full-speed USB device number 8 using xhci_hcd
[   10.269441] usb 1-1.1: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[   10.269481] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[   10.269499] usb 1-1.1: Product: STD UPS MON V2.0
[   10.269514] usb 1-1.1: SerialNumber: J9552E6E43FBC05
[   10.292250] hid-generic 0003:0925:1234.0006: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.1/input0
[   10.865514] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[   11.830110] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   11.830147] Bluetooth: BNEP filters: protocol multicast
[   11.830181] Bluetooth: BNEP socket layer initialized
[   11.849391] Bluetooth: MGMT ver 1.22
[   11.891692] NET: Registered PF_ALG protocol family
[   12.396759] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[   12.400142] bcmgenet fd580000.ethernet eth0: Link is Down
[   12.436630] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[   14.709310] Bluetooth: RFCOMM TTY layer initialized
[   14.709339] Bluetooth: RFCOMM socket layer initialized
[   14.709362] Bluetooth: RFCOMM ver 1.11
[   15.464457] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   15.464810] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[  622.364966] usb 1-1.1: USB disconnect, device number 8
[  625.244610] usb 1-1.4: new full-speed USB device number 9 using xhci_hcd
[  625.353368] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[  625.353379] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[  625.353384] usb 1-1.4: Product: STD UPS MON V2.0
[  625.353390] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[  625.364534] hid-generic 0003:0925:1234.0007: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[  626.702458] usb 1-1.4: USB disconnect, device number 9
[  626.928656] usb 1-1.4: new full-speed USB device number 10 using xhci_hcd
[  627.037506] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[  627.037523] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[  627.037529] usb 1-1.4: Product: STD UPS MON V2.0
[  627.037534] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[  627.048673] hid-generic 0003:0925:1234.0008: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0

[jimklimov]

It seems you did not follow the config prerequisites chapter to install the build tools etc.?

Assuming a Debian derived OS, check this list: https://networkupstools.org/docs/user-manual.chunked/_build_prerequisites_to_make_nut_from_scratch_on_various_operating_systems.html#_debian_10_11

[grydan]

OK I have follow the url, thank... but If now I run command from /tmp/ directory:

sudo ./drivers/nutdrv_qx -a vultech

Network UPS Tools - Generic Q* Serial driver 0.36 (2.8.1-31-ge451a97bc)

Fatal error: 'vendorid' is not a valid variable name for this driver.

Look in the man page or call this driver with -h for a list of
valid variable names and flags.
upsnotify: failed to notify about state 4: no notification tech defined, will not spam more about it

[jimklimov]

That's strange :\ Did you get libusb dev libraries+headers package? Is USB support reported as enabled after NUT configuration?

[jimklimov]

"No notification tech" suggests you lack libsystemd-dev too?

[grydan]

Ok now I have redone all steps...and I'm occur in the problem Resource busy .. argggggh

sudo ./drivers/nutdrv_qx -s tempups     -d1 -DDDDDD -x port=auto     -x vendorid=0925 -x productid=1234     -x subdriver=armac
Network UPS Tools - Generic Q* USB/Serial driver 0.36 (2.8.1-35-g8c913eda4)
USB communication driver (libusb 1.0) 0.46
   0.000000     [D3] main_arg: var='port' val='auto'
   0.000105     [D6] testinfo_reloadable: var=port, infoname=driver.parameter.port, newval=auto, reloadable=0, reload_flag=0
   0.000162     [D6] testinfo_reloadable: verdict for (re)loading var=port value: 1
   0.000219     [D5] send_to_all: SETINFO driver.parameter.port "auto"
   0.000303     [D3] main_arg: var='vendorid' val='0925'
   0.000369     [D5] send_to_all: SETINFO driver.parameter.vendorid "0925"
   0.000424     [D3] main_arg: var='productid' val='1234'
   0.000499     [D5] send_to_all: SETINFO driver.parameter.productid "1234"
   0.000552     [D3] main_arg: var='subdriver' val='armac'
   0.000610     [D5] send_to_all: SETINFO driver.parameter.subdriver "armac"
   0.000662     [D1] Network UPS Tools version 2.8.1-35-g8c913eda4 (release/snapshot of 2.8.1.1) built with gcc (Debian 12.2.0-14) 12.2.0 and configured with flags: --prefix=/usr --sbindir=/usr/sbin --bindir=/usr/bin --sysconfdir=/etc/nut --with-group=nut --with-user=nut --enable-Wcolor --enable-warnings --enable-Werror --enable-keep_nut_report_feature --with-all=auto --with-cgi=auto --with-serial=auto --with-dev=auto --with-doc=skip --with-nut_monitor=auto --with-pynut=auto --disable-force-nut-version-header --enable-check-NIT --enable-maintainer-mode
   0.000747     [D1] debug level is '6'
   0.000799     [D5] send_to_all: SETINFO driver.debug "6"
   0.000852     [D5] send_to_all: SETFLAGS driver.debug RW NUMBER
   0.002153     [D1] Succeeded to become_user(nut): now UID=112 GID=122
   0.002230     [D5] send_to_all: SETINFO device.type "ups"
   0.002285     [D5] send_to_all: SETINFO driver.state "init.device"
   0.002334     [D1] upsdrv_initups...
   0.027277     [D2] Checking device 1 of 4 (1D6B/0003)
   0.027451     [D1] Failed to open device (1D6B/0003), skipping: Access denied (insufficient permissions)
   0.027510     [D2] Checking device 2 of 4 (0925/1234)
   0.036862     [D2] - VendorID: 0925
   0.036925     [D2] - ProductID: 1234
   0.036974     [D2] - Manufacturer: unknown
   0.037021     [D2] - Product: STD UPS MON V2.0
   0.037068     [D2] - Serial Number: J9552E6E43FBC05
   0.037115     [D2] - Bus: 001
   0.037161     [D2] - Bus Port: 004
   0.037210     [D2] - Device: 008
   0.037256     [D2] - Device release number: 0001
   0.037302     [D2] Trying to match device
   0.037351     [D3] match_function_regex: matching a device...
   0.037526     [D2] Device matches
   0.037577     [D2] Reading configuration descriptor 1 of 1
   0.037655     [D3] libusb_kernel_driver_active() returned 0: Success
   0.037719     [D2] failed to claim USB device: Resource busy
   0.037785     [D2] Kernel driver already detached
   0.037841     [D2] failed to claim USB device: Resource busy
   0.037897     [D2] Kernel driver already detached
   0.037952     [D2] failed to claim USB device: Resource busy
   0.038008     [D2] Kernel driver already detached
   0.038064     [D2] failed to claim USB device: Resource busy
   0.038124     [D2] Kernel driver already detached
   0.038183     Can't claim USB device [0925:1234]@0/0/0: Entity not found
   0.038250     [D5] send_to_all: SETINFO driver.state "cleanup.exit"

This is the result of dmesg , do you have any suggestion for me?

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[    0.000000] Linux version 6.1.0-rpi4-rpi-v8 (debian-kernel@lists.debian.org) (gcc-12 (Debian 12.2.0-14) 12.2.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT Debian 1:6.1.54-1+rpt2 (2023-10-05)
[    0.000000] random: crng init done
[    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.5
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x000000000dc00000, 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-0x000000007fffffff]
[    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]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[    0.000000] On node 0, zone DMA32: 19456 pages in unavailable ranges
[    0.000000] percpu: Embedded 29 pages/cpu s79144 r8192 d31448 u118784
[    0.000000] pcpu-alloc: s79144 r8192 d31448 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: 496944
[    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=D8:3A:DD:67:42:D0 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=8cde1d42-02 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles
[    0.000000] Unknown kernel command line parameters "splash", will be passed to user space.
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:all(zero), 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: 1347208K/2019328K available (12352K kernel code, 2172K rwdata, 4164K rodata, 4224K init, 1082K bss, 147832K reserved, 524288K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 40047 entries in 157 pages
[    0.000000] ftrace: allocated 157 pages with 5 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.000332] Console: colour dummy device 80x25
[    0.000390] printk: console [tty1] enabled
[    0.000447] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[    0.000474] pid_max: default: 32768 minimum: 301
[    0.000592] LSM: Security Framework initializing
[    0.000787] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.000830] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.002104] cgroup: Disabling memory control group subsystem
[    0.004296] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004312] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.004489] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004502] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.004672] cblist_init_generic: Setting adjustable number of callback queues.
[    0.004684] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005127] rcu: Hierarchical SRCU implementation.
[    0.005139] rcu:     Max phase no-delay instances is 1000.
[    0.007278] EFI services will not be available.
[    0.007792] smp: Bringing up secondary CPUs ...
[    0.008877] Detected PIPT I-cache on CPU1
[    0.009029] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
[    0.010139] Detected PIPT I-cache on CPU2
[    0.010257] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
[    0.011341] Detected PIPT I-cache on CPU3
[    0.011460] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
[    0.011603] smp: Brought up 1 node, 4 CPUs
[    0.011624] SMP: Total of 4 processors activated.
[    0.011636] CPU features: detected: 32-bit EL0 Support
[    0.011645] CPU features: detected: 32-bit EL1 Support
[    0.011658] CPU features: detected: CRC32 instructions
[    0.011790] CPU: All CPU(s) started at EL2
[    0.011813] alternatives: applying system-wide alternatives
[    0.013617] devtmpfs: initialized
[    0.025459] Enabled cp15_barrier support
[    0.025500] Enabled setend support
[    0.025727] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.025765] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.039317] pinctrl core: initialized pinctrl subsystem
[    0.040212] DMI not present or invalid.
[    0.040922] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.044316] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[    0.044624] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.045593] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.045688] audit: initializing netlink subsys (disabled)
[    0.045951] audit: type=2000 audit(0.044:1): state=initialized audit_enabled=0 res=1
[    0.046580] thermal_sys: Registered thermal governor 'step_wise'
[    0.046665] cpuidle: using governor menu
[    0.046943] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.047137] ASID allocator initialised with 32768 entries
[    0.048067] Serial: AMBA PL011 UART driver
[    0.062063] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.085005] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start
[    0.089018] raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7
[    0.104864] KASLR enabled
[    0.138358] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.143731] iommu: Default domain type: Translated
[    0.143747] iommu: DMA domain TLB invalidation policy: strict mode
[    0.144198] SCSI subsystem initialized
[    0.144433] usbcore: registered new interface driver usbfs
[    0.144490] usbcore: registered new interface driver hub
[    0.144555] usbcore: registered new device driver usb
[    0.144945] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.145504] pps_core: LinuxPPS API ver. 1 registered
[    0.145517] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.145543] PTP clock support registered
[    0.146690] vgaarb: loaded
[    0.147279] clocksource: Switched to clocksource arch_sys_counter
[    0.148217] VFS: Disk quotas dquot_6.6.0
[    0.148293] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.148482] FS-Cache: Loaded
[    0.148663] CacheFiles: Loaded
[    0.158825] NET: Registered PF_INET protocol family
[    0.159237] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.162263] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
[    0.162305] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.162331] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.162457] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
[    0.162972] TCP: Hash tables configured (established 16384 bind 16384)
[    0.163408] MPTCP token hash table entries: 2048 (order: 3, 49152 bytes, linear)
[    0.163530] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.163577] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.163844] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.164598] RPC: Registered named UNIX socket transport module.
[    0.164614] RPC: Registered udp transport module.
[    0.164625] RPC: Registered tcp transport module.
[    0.164634] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.164658] PCI: CLS 0 bytes, default 64
[    0.165175] Trying to unpack rootfs image as initramfs...
[    0.185550] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    0.186008] kvm [1]: IPA Size Limit: 44 bits
[    0.187518] kvm [1]: vgic interrupt IRQ9
[    0.187756] kvm [1]: Hyp mode initialized successfully
[    1.060802] Freeing initrd memory: 16720K
[    1.235856] Initialise system trusted keyrings
[    1.236390] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[    1.244018] zbud: loaded
[    1.246940] NFS: Registering the id_resolver key type
[    1.246979] Key type id_resolver registered
[    1.246991] Key type id_legacy registered
[    1.247104] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    1.247120] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    1.248613] Key type asymmetric registered
[    1.248633] Asymmetric key parser 'x509' registered
[    1.248723] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    1.249000] io scheduler mq-deadline registered
[    1.249017] io scheduler kyber registered
[    1.251964] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 27)
[    1.262995] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    1.263038] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    1.263125] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    1.263211] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x007fffffff -> 0x0400000000
[    1.263799] brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE
[    1.264303] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    1.264323] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.264341] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    1.264420] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    1.264680] pci 0000:00:00.0: PME# supported from D0 D3hot
[    1.268534] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    1.268794] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
[    1.268999] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
[    1.269101] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
[    1.377387] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    1.377554] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    1.377681] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    1.378164] pci 0000:01:00.0: PME# supported from D0 D3hot
[    1.387391] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[    1.387439] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    1.387463] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    1.387542] pci 0000:00:00.0: PCI bridge to [bus 01]
[    1.387566] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    1.387995] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
[    1.388223] pcieport 0000:00:00.0: PME: Signaling with IRQ 31
[    1.388742] pcieport 0000:00:00.0: AER: enabled with IRQ 31
[    1.389366] brcm-pcie fd500000.pcie: clkreq control enabled
[    1.405406] iproc-rng200 fe104000.rng: hwrng registered
[    1.405975] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    1.420579] brd: module loaded
[    1.429445] loop: module loaded
[    1.430376] Loading iSCSI transport class v2.0-870.
[    1.436378] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    1.543436] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    1.544618] usbcore: registered new interface driver r8152
[    1.544690] usbcore: registered new interface driver lan78xx
[    1.544748] usbcore: registered new interface driver smsc95xx
[    1.592661] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.592705] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    1.593410] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890
[    1.594512] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    1.594535] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    1.594558] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    1.594936] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    1.594956] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.594971] usb usb1: Product: xHCI Host Controller
[    1.594984] usb usb1: Manufacturer: Linux 6.1.0-rpi4-rpi-v8 xhci-hcd
[    1.594997] usb usb1: SerialNumber: 0000:01:00.0
[    1.595785] hub 1-0:1.0: USB hub found
[    1.595853] hub 1-0:1.0: 1 port detected
[    1.596764] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
[    1.596784] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.596799] usb usb2: Product: xHCI Host Controller
[    1.596811] usb usb2: Manufacturer: Linux 6.1.0-rpi4-rpi-v8 xhci-hcd
[    1.596824] usb usb2: SerialNumber: 0000:01:00.0
[    1.597477] hub 2-0:1.0: USB hub found
[    1.597541] hub 2-0:1.0: 4 ports detected
[    1.599361] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.599696] dwc_otg: FIQ enabled
[    1.599707] dwc_otg: NAK holdoff enabled
[    1.599717] dwc_otg: FIQ split-transaction FSM enabled
[    1.599733] Module dwc_common_port init
[    1.601071] usbcore: registered new interface driver uas
[    1.601166] usbcore: registered new interface driver usb-storage
[    1.602091] mousedev: PS/2 mouse device common for all mice
[    1.609832] sdhci: Secure Digital Host Controller Interface driver
[    1.609852] sdhci: Copyright(c) Pierre Ossman
[    1.610528] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.614538] ledtrig-cpu: registered to indicate activity on CPUs
[    1.614912] hid: raw HID events driver (C) Jiri Kosina
[    1.615113] usbcore: registered new interface driver usbhid
[    1.615127] usbhid: USB HID core driver
[    1.625374] NET: Registered PF_PACKET protocol family
[    1.625496] Key type dns_resolver registered
[    1.626766] registered taskstats version 1
[    1.626851] Loading compiled-in X.509 certificates
[    1.654913] Loaded X.509 cert 'Debian Secure Boot CA: 6ccece7e4c6c0d1f6149f3dd27dfcc5cbb419ea1'
[    1.655030] Loaded X.509 cert 'Debian Secure Boot Signer 2022 - linux: 14011249c2675ea8e5148542202005810584b25f'
[    1.656129] Key type .fscrypt registered
[    1.656144] Key type fscrypt-provisioning registered
[    1.671549] uart-pl011 fe201000.serial: there is not valid maps for state default
[    1.672398] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    1.672563] fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
[    1.672813] serial serial0: tty port ttyAMA1 registered
[    1.682240] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    1.682715] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    1.684325] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    1.684348] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    1.712882] of_cfs_init
[    1.713026] of_cfs_init: OK
[    1.747428] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    1.756489] Freeing unused kernel memory: 4224K
[    1.756707] Run /init as init process
[    1.756719]   with arguments:
[    1.756728]     /init
[    1.756738]     splash
[    1.756747]   with environment:
[    1.756756]     HOME=/
[    1.756765]     TERM=linux
[    1.796538] mmc1: new high speed SDIO card at address 0001
[    1.847409] mmc0: new ultra high speed DDR50 SDHC card at address 5048
[    1.848551] mmcblk0: mmc0:5048 SD32G 29.7 GiB
[    1.851351] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.852046]  mmcblk0: p1 p2
[    1.852659] mmcblk0: mmc0:5048 SD32G 29.7 GiB (quirks 0x00004000)
[    2.001961] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    2.001998] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    2.002015] usb 1-1: Product: USB2.0 Hub
[    2.004466] hub 1-1:1.0: USB hub found
[    2.004719] hub 1-1:1.0: 4 ports detected
[    2.299334] usb 1-1.4: new full-speed USB device number 3 using xhci_hcd
[    2.408385] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    2.408420] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    2.408436] usb 1-1.4: Product: STD UPS MON V2.0
[    2.408450] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[    2.420718] hid-generic 0003:0925:1234.0001: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[    2.678742] brcmstb-i2c fef04500.i2c:  @97500hz registered in polling mode
[    2.679662] brcmstb-i2c fef09500.i2c:  @97500hz registered in polling mode
[    2.733068] usb 1-1.4: USB disconnect, device number 3
[    2.790706] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    2.851005] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4])
[    2.853884] Registered IR keymap rc-cec
[    2.854060] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0
[    2.854259] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0
[    2.859615] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4])
[    2.862471] Registered IR keymap rc-cec
[    2.862652] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1
[    2.862855] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input1
[    2.869654] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4])
[    2.870369] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4])
[    2.870825] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.871231] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.871741] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.872060] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.872500] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4])
[    2.876262] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
[    2.876942] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.883570] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.883719] vc4-drm gpu: [drm] Cannot find any crtc or sizes
[    2.971342] usb 1-1.4: new full-speed USB device number 4 using xhci_hcd
[    3.080292] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    3.080328] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    3.080345] usb 1-1.4: Product: STD UPS MON V2.0
[    3.080359] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[    3.093081] hid-generic 0003:0925:1234.0002: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[    3.310969] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    3.957246] systemd[1]: System time before build time, advancing clock.
[    4.133909] NET: Registered PF_INET6 protocol family
[    4.135759] Segment Routing with IPv6
[    4.135801] In-situ OAM (IOAM) with IPv6
[    4.212720] systemd[1]: systemd 252.17-1~deb12u1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[    4.212774] systemd[1]: Detected architecture arm64.
[    4.223129] systemd[1]: Hostname set to <raspberrypi>.
[    4.525341] usb 1-1.4: USB disconnect, device number 4
[    4.755319] usb 1-1.4: new full-speed USB device number 5 using xhci_hcd
[    4.868271] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    4.868308] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    4.868325] usb 1-1.4: Product: STD UPS MON V2.0
[    4.868339] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[    4.880501] hid-generic 0003:0925:1234.0003: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[    5.189257] systemd[1]: Queued start job for default target graphical.target.
[    5.211619] systemd[1]: Created slice system-getty.slice - Slice /system/getty.
[    5.213494] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[    5.215000] systemd[1]: Created slice system-nut\x2ddriver.slice - Slice /system/nut-driver.
[    5.216553] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
[    5.217617] systemd[1]: Created slice user.slice - User and Session Slice.
[    5.218215] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[    5.219449] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
[    5.219795] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[    5.220024] systemd[1]: Reached target nss-user-lookup.target - User and Group Name Lookups.
[    5.220266] systemd[1]: Reached target slices.target - Slice Units.
[    5.220428] systemd[1]: Reached target swap.target - Swaps.
[    5.220621] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[    5.221546] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket.
[    5.221975] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[    5.223975] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
[    5.224978] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[    5.226085] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[    5.228172] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[    5.229142] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[    5.230138] systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages).
[    5.259859] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
[    5.265386] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
[    5.271121] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
[    5.271939] systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab).
[    5.280712] systemd[1]: Starting fake-hwclock.service - Restore / save the current clock...
[    5.286562] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout...
[    5.292937] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
[    5.299665] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
[    5.306802] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
[    5.314235] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
[    5.321718] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
[    5.328849] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
[    5.336183] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
[    5.337406] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root).
[    5.349245] systemd[1]: Starting systemd-journald.service - Journal Service...
[    5.369362] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
[    5.375969] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
[    5.382697] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[    5.392234] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com
[    5.396618] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
[    5.398416] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
[    5.400182] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[    5.406826] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
[    5.410725] systemd[1]: Finished fake-hwclock.service - Restore / save the current clock.
[    5.414350] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[    5.416084] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
[    5.418740] systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
[    5.420580] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
[    5.423637] systemd[1]: modprobe@drm.service: Deactivated successfully.
[    5.424966] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
[    5.428785] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
[    5.430202] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[    5.433255] systemd[1]: modprobe@loop.service: Deactivated successfully.
[    5.434596] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
[    5.439886] fuse: init (API version 7.37)
[    5.468344] i2c_dev: i2c /dev entries driver
[    5.471988] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
[    5.472796] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
[    5.476097] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[    5.480239] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
[    5.483227] systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
[    5.491298] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
[    5.492573] EXT4-fs (mmcblk0p2): re-mounted. Quota mode: none.
[    5.499830] systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
[    5.513406] systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
[    5.516262] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
[    5.517984] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[    5.519927] systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[    5.520234] systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
[    5.525945] systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed...
[    5.548683] systemd[1]: Starting systemd-sysusers.service - Create System Users...
[    5.628883] systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
[    5.636504] systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed.
[    5.638261] systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[    5.675132] systemd[1]: Finished systemd-sysusers.service - Create System Users.
[    5.696356] systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
[    5.732726] systemd[1]: Started systemd-journald.service - Journal Service.
[    5.803138] systemd-journald[266]: Received client request to flush runtime journal.
[    5.810529] systemd-journald[266]: File /var/log/journal/55a96178d2d54848b58de36a92a5e3af/system.journal corrupted or uncleanly shut down, renaming and replacing.
[    6.317625] usb 1-1.4: USB disconnect, device number 5
[    6.571412] usb 1-1.4: new full-speed USB device number 6 using xhci_hcd
[    6.682330] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    6.682374] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    6.682392] usb 1-1.4: Product: STD UPS MON V2.0
[    6.682407] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[    6.717735] hid-generic 0003:0925:1234.0004: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[    6.934949] mc: Linux media interface: v0.10
[    7.001537] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    7.006848] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    7.006889] [vc_sm_connected_init]: start
[    7.010396] rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
[    7.015776] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    7.041686] rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
[    7.066494] bcm2835_audio bcm2835_audio: card created with 8 channels
[    7.068201] videodev: Linux video capture interface: v2.00
[    7.078274] [vc_sm_connected_init]: installed successfully
[    7.306072] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    7.312813] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    7.354697] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    7.361738] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    7.374131] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    7.397744] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
[    7.406806] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    7.406965] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    7.407035] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    7.407810] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    7.411851] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    7.421476] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    7.421538] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    7.424835] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    7.424884] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    7.424908] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    7.424928] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    7.424946] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    7.429904] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    7.429986] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    7.438548] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
[    7.441719] bcm2835-codec bcm2835-codec: Device registered as /dev/video18
[    7.441743] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
[    7.441784] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
[    7.445964] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
[    7.446301] rpivid feb10000.codec: Device registered as /dev/video19
[    7.446830] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
[    7.446909] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    7.446934] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    7.446952] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    7.446970] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    7.447488] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    7.447990] bcm2835-codec bcm2835-codec: Device registered as /dev/video31
[    7.448041] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
[    7.549921] Bluetooth: Core ver 2.22
[    7.550078] NET: Registered PF_BLUETOOTH protocol family
[    7.550091] Bluetooth: HCI device and connection manager initialized
[    7.550122] Bluetooth: HCI socket layer initialized
[    7.550143] Bluetooth: L2CAP socket layer initialized
[    7.550190] Bluetooth: SCO socket layer initialized
[    7.595427] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    7.596464] cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
[    7.607676] cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
[    7.608718] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    7.618894] platform regulatory.0: firmware: direct-loading firmware regulatory.db
[    7.623695] platform regulatory.0: firmware: direct-loading firmware regulatory.db.p7s
[    7.627453] Bluetooth: HCI UART driver ver 2.3
[    7.627489] Bluetooth: HCI UART protocol H4 registered
[    7.627645] Bluetooth: HCI UART protocol Three-wire (H5) registered
[    7.628088] Bluetooth: HCI UART protocol Broadcom registered
[    7.629848] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
[    7.630205] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
[    7.747794] uart-pl011 fe201000.serial: no DMA platform data
[    8.016223] Bluetooth: hci0: BCM: chip id 107
[    8.016662] Bluetooth: hci0: BCM: features 0x2f
[    8.017893] Bluetooth: hci0: BCM4345C0
[    8.017921] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
[    8.024433] bluetooth hci0: firmware: direct-loading firmware brcm/BCM4345C0.raspberrypi,4-model-b.hcd
[    8.024471] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,4-model-b.hcd' Patch
[    8.069596] brcmfmac: F1 signature read @0x18000000=0x15264345
[    8.087175] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    8.095927] usbcore: registered new interface driver brcmfmac
[    8.109919] usb 1-1.4: USB disconnect, device number 6
[    8.119949] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.bin
[    8.121225] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.txt
[    8.122254] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43455-sdio.raspberrypi,4-model-b.clm_blob
[    8.339352] usb 1-1.4: new full-speed USB device number 7 using xhci_hcd
[    8.377024] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
[    8.450511] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[    8.450556] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[    8.450572] usb 1-1.4: Product: STD UPS MON V2.0
[    8.450605] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[    8.513231] hid-generic 0003:0925:1234.0005: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[    8.848961] Bluetooth: hci0: BCM: features 0x2f
[    8.851499] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190
[    8.851529] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382
[    9.902364] usb 1-1.4: USB disconnect, device number 7
[   10.155458] usb 1-1.4: new full-speed USB device number 8 using xhci_hcd
[   10.267243] usb 1-1.4: New USB device found, idVendor=0925, idProduct=1234, bcdDevice= 0.01
[   10.267318] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=2
[   10.267336] usb 1-1.4: Product: STD UPS MON V2.0
[   10.267351] usb 1-1.4: SerialNumber: J9552E6E43FBC05
[   10.285508] hid-generic 0003:0925:1234.0006: hiddev96,hidraw0: USB HID v1.00 Device [STD UPS MON V2.0] on usb-0000:01:00.0-1.4/input0
[   10.463684] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[   11.277774] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   11.277811] Bluetooth: BNEP filters: protocol multicast
[   11.277845] Bluetooth: BNEP socket layer initialized
[   11.290321] Bluetooth: MGMT ver 1.22
[   11.315336] NET: Registered PF_ALG protocol family
[   11.847186] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[   11.850482] bcmgenet fd580000.ethernet eth0: Link is Down
[   11.886465] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
[   14.911452] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   14.911807] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[   15.344569] Bluetooth: RFCOMM TTY layer initialized
[   15.344596] Bluetooth: RFCOMM socket layer initialized
[   15.344614] Bluetooth: RFCOMM ver 1.11

[grydan]

If I re-run the command in another time seem that this work with 2.8.1 What do you think? I need only solve the problem of Resource busy (It seems that the UPS is constantly connecting and disconnecting....but could it be that I am wrong?)

sudo ./drivers/nutdrv_qx -s tempups -d1 -DDDDDD -x port=auto -x vendorid=0925 -x productid=1234 -x subdriver=armac

Network UPS Tools - Generic Q* USB/Serial driver 0.36 (2.8.1-35-g8c913eda4)
USB communication driver (libusb 1.0) 0.46
   0.000000     [D3] main_arg: var='port' val='auto'
   0.000153     [D6] testinfo_reloadable: var=port, infoname=driver.parameter.port, newval=auto, reloadable=0, reload_flag=0
   0.000210     [D6] testinfo_reloadable: verdict for (re)loading var=port value: 1
   0.000265     [D5] send_to_all: SETINFO driver.parameter.port "auto"
   0.000350     [D3] main_arg: var='vendorid' val='0925'
   0.000414     [D5] send_to_all: SETINFO driver.parameter.vendorid "0925"
   0.000468     [D3] main_arg: var='productid' val='1234'
   0.000577     [D5] send_to_all: SETINFO driver.parameter.productid "1234"
   0.000784     [D3] main_arg: var='subdriver' val='armac'
   0.001060     [D5] send_to_all: SETINFO driver.parameter.subdriver "armac"
   0.001280     [D1] Network UPS Tools version 2.8.1-35-g8c913eda4 (release/snapshot of 2.8.1.1) built with gcc (Debian 12.2.0-14) 12.2.0 and configured with flags: --prefix=/usr --sbindir=/usr/sbin --bindir=/usr/bin --sysconfdir=/etc/nut --with-group=nut --with-user=nut --enable-Wcolor --enable-warnings --enable-Werror --enable-keep_nut_report_feature --with-all=auto --with-cgi=auto --with-serial=auto --with-dev=auto --with-doc=skip --with-nut_monitor=auto --with-pynut=auto --disable-force-nut-version-header --enable-check-NIT --enable-maintainer-mode
   0.001700     [D1] debug level is '6'
   0.001908     [D5] send_to_all: SETINFO driver.debug "6"
   0.002115     [D5] send_to_all: SETFLAGS driver.debug RW NUMBER
   0.003651     [D1] Succeeded to become_user(nut): now UID=112 GID=122
   0.003728     [D5] send_to_all: SETINFO device.type "ups"
   0.003783     [D5] send_to_all: SETINFO driver.state "init.device"
   0.003871     [D1] upsdrv_initups...
   0.028964     [D2] Checking device 1 of 4 (1D6B/0003)
   0.029277     [D1] Failed to open device (1D6B/0003), skipping: Access denied (insufficient permissions)
   0.029487     [D2] Checking device 2 of 4 (0925/1234)
   0.038016     [D2] - VendorID: 0925
   0.038201     [D2] - ProductID: 1234
   0.038349     [D2] - Manufacturer: unknown
   0.038399     [D2] - Product: STD UPS MON V2.0
   0.038475     [D2] - Serial Number: J9552E6E43FBC05
   0.038674     [D2] - Bus: 001
   0.038811     [D2] - Bus Port: 004
   0.038901     [D2] - Device: 008
   0.038951     [D2] - Device release number: 0001
   0.038997     [D2] Trying to match device
   0.039075     [D3] match_function_regex: matching a device...
   0.039551     [D2] Device matches
   0.039632     [D2] Reading configuration descriptor 1 of 1
   0.039744     [D3] libusb_kernel_driver_active() returned 0: Success
   0.040147     [D2] Claimed interface 0 successfully
   0.040427     [D3] nut_usb_set_altinterface: skipped libusb_set_interface_alt_setting(udev, 0, 0)
   0.040540     [D5] send_to_all: SETINFO ups.vendorid "0925"
   0.040672     [D5] send_to_all: SETINFO ups.productid "1234"
   0.040925     [D2] armac: unsupported cmd: QGS
   0.041160     [D2] qx_process_answer: short reply (input.voltage)
   0.041409     [D2] armac: unsupported cmd: QGS
   0.041603     [D2] qx_process_answer: short reply (input.voltage)
   0.041778     [D2] armac: unsupported cmd: QGS
   0.042038     [D2] qx_process_answer: short reply (input.voltage)
   0.042120     [D2] armac: unsupported cmd: M
   0.042174     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.042224     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.042274     [D2] armac: unsupported cmd: M
   0.042404     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.042623     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.042679     [D2] armac: unsupported cmd: M
   0.042782     [D2] voltronic_qs_protocol: invalid protocol [M]
   0.042998     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.043255     [D2] armac: unsupported cmd: M
   0.043480     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.043598     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.043652     [D2] armac: unsupported cmd: M
   0.043704     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.043785     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.044046     [D2] armac: unsupported cmd: M
   0.044167     [D2] voltronic_qs_hex_protocol: invalid protocol [M]
   0.044218     [D4] ups_infoval_set: failed to preprocess value [ups.firmware.aux: M]
   0.044270     [D2] armac: unsupported cmd: QS
   0.044349     [D2] qx_process_answer: short reply (input.voltage)
   0.044533     [D2] armac: unsupported cmd: QS
   0.044586     [D2] qx_process_answer: short reply (input.voltage)
   0.044636     [D2] armac: unsupported cmd: QS
   0.044715     [D2] qx_process_answer: short reply (input.voltage)
   0.044837     [D2] armac: unsupported cmd: D
   0.044976     [D2] qx_process_answer: short reply (input.voltage)
   0.045072     [D2] armac: unsupported cmd: D
   0.045124     [D2] qx_process_answer: short reply (input.voltage)
   0.045268     [D2] armac: unsupported cmd: D
   0.045408     [D2] qx_process_answer: short reply (input.voltage)
   0.045462     [D4] armac command Q1
   0.227483     [D4] read: ret 6 buf a6: 28 32 34 30 2e  >(240.<
   0.248483     [D4] read: ret 6 buf 86: 34 20 30 30 30  >4 000<
   0.269482     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
   0.290480     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
   0.311485     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   0.332485     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   0.352489     [D4] read: ret 6 buf a6: 32 33 20 34 33  >23 43<
   0.373491     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   0.394494     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.894590     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   0.894622     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   0.894640     [D3] armac command Q1 response read: '(240.4 000.0 219.9 020 50.0 2.23 43.0 00000001'
   0.894684     [D5] send_to_all: SETINFO input.voltage "240.4"
   0.894722     [D4] armac command ID
0< 1.560658     [D4] read: ret 6 buf a5: 4e 41 4b 0d 30  >NAK
   1.560688     [D3] trailing bytes in serial transmission found: 4  copied out of 5
   1.560705     [D3] armac command ID response read: 'NAK'
   1.560723     [D4] bestups_preprocess_id_answer: wrong length [device.model: 4]
   1.560740     [D4] qx_process: failed to preprocess answer [device.model]
   1.560772     [D5] send_to_all: DELINFO input.voltage
   1.560844     [D4] armac command Q1
   1.742679     [D4] read: ret 6 buf 86: 28 32 34 30 2e  >(240.<
   1.762680     [D4] read: ret 6 buf a6: 30 20 30 30 30  >0 000<
   1.783684     [D4] read: ret 6 buf 86: 2e 30 20 32 32  >.0 22<
   1.804692     [D4] read: ret 6 buf a6: 30 2e 31 20 30  >0.1 0<
   1.825691     [D4] read: ret 6 buf 86: 32 30 20 34 39  >20 49<
   1.846690     [D4] read: ret 6 buf a6: 2e 39 20 32 2e  >.9 2.<
   1.867695     [D4] read: ret 6 buf 86: 32 33 20 34 33  >23 43<
   1.887695     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   1.908701     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.406872     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   2.406961     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   2.407013     [D3] armac command Q1 response read: '(240.0 000.0 220.1 020 49.9 2.23 43.0 00000001'
   2.407089     [D5] send_to_all: SETINFO input.voltage "240.0"
   2.407111     [D4] armac command ID
0< 3.083873     [D4] read: ret 6 buf 85: 4e 41 4b 0d 30  >NAK
   3.083906     [D3] trailing bytes in serial transmission found: 4  copied out of 5
   3.083943     [D3] armac command ID response read: 'NAK'
   3.083963     [D4] bestups_preprocess_id_answer: wrong length [device.model: 4]
   3.083981     [D4] qx_process: failed to preprocess answer [device.model]
   3.084001     [D5] send_to_all: DELINFO input.voltage
   3.084020     [D4] armac command Q1
   3.261887     [D4] read: ret 6 buf a6: 28 32 33 39 2e  >(239.<
   3.282888     [D4] read: ret 6 buf 86: 36 20 30 30 30  >6 000<
   3.303893     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
   3.324894     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
   3.345895     [D4] read: ret 6 buf a6: 32 30 20 35 30  >20 50<
   3.366898     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
   3.386899     [D4] read: ret 6 buf a6: 32 33 20 34 33  >23 43<
   3.407903     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
   3.428905     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.929992     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
   3.930020     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   3.930038     [D3] armac command Q1 response read: '(239.6 000.0 219.9 020 50.0 2.23 43.0 00000001'
   3.930075     [D5] send_to_all: SETINFO input.voltage "239.6"
   3.930096     [D4] armac command ID
0< 4.597093     [D4] read: ret 6 buf a5: 4e 41 4b 0d 30  >NAK
   4.597172     [D3] trailing bytes in serial transmission found: 4  copied out of 5
   4.597214     [D3] armac command ID response read: 'NAK'
   4.597234     [D4] bestups_preprocess_id_answer: wrong length [device.model: 4]
   4.597264     [D4] qx_process: failed to preprocess answer [device.model]
   4.597284     [D5] send_to_all: DELINFO input.voltage
   4.597303     [D4] armac command Q1
   4.782094     [D4] read: ret 6 buf 86: 28 32 33 39 2e  >(239.<
   4.803098     [D4] read: ret 6 buf a6: 34 20 30 30 30  >4 000<
   4.824098     [D4] read: ret 6 buf 86: 2e 30 20 32 31  >.0 21<
   4.845097     [D4] read: ret 6 buf a6: 39 2e 38 20 30  >9.8 0<
   4.866111     [D4] read: ret 6 buf 86: 32 30 20 35 30  >20 50<
   4.886103     [D4] read: ret 6 buf a6: 2e 30 20 32 2e  >.0 2.<
   4.907108     [D4] read: ret 6 buf 86: 32 33 20 34 33  >23 43<
   4.928117     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   4.949115     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.453377     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   5.453460     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   5.453514     [D3] armac command Q1 response read: '(239.4 000.0 219.8 020 50.0 2.23 43.0 00000001'
   5.453603     [D5] send_to_all: SETINFO input.voltage "239.4"
   5.453659     [D2] armac: unsupported cmd: QPI
   5.453750     [D2] qx_process_answer: short reply (ups.firmware.aux)
   5.453923     [D5] send_to_all: DELINFO input.voltage
   5.454170     [D4] armac command Q1
   5.632283     [D4] read: ret 6 buf 86: 28 32 33 38 2e  >(238.<
   5.653312     [D4] read: ret 6 buf a6: 38 20 30 30 30  >8 000<
   5.674350     [D4] read: ret 6 buf 86: 2e 30 20 32 31  >.0 21<
   5.695288     [D4] read: ret 6 buf a6: 39 2e 39 20 30  >9.9 0<
   5.715321     [D4] read: ret 6 buf 86: 32 30 20 34 39  >20 49<
   5.736293     [D4] read: ret 6 buf a6: 2e 39 20 32 2e  >.9 2.<
   5.757326     [D4] read: ret 6 buf 86: 32 35 20 34 33  >25 43<
   5.778304     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   5.799308     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.298523     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   6.298721     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   6.298888     [D3] armac command Q1 response read: '(238.8 000.0 219.9 020 49.9 2.25 43.0 00000001'
   6.299126     [D5] send_to_all: SETINFO input.voltage "238.8"
   6.299335     [D2] armac: unsupported cmd: QPI
   6.299551     [D2] qx_process_answer: short reply (ups.firmware.aux)
   6.299745     [D5] send_to_all: DELINFO input.voltage
   6.300086     [D4] armac command Q1
   6.482399     [D4] read: ret 6 buf 86: 28 32 33 38 2e  >(238.<
   6.503399     [D4] read: ret 6 buf a6: 36 20 30 30 30  >6 000<
   6.524439     [D4] read: ret 6 buf 86: 2e 30 20 32 32  >.0 22<
   6.544403     [D4] read: ret 6 buf a6: 30 2e 32 20 30  >0.2 0<
   6.565437     [D4] read: ret 6 buf 86: 31 39 20 34 39  >19 49<
   6.586408     [D4] read: ret 6 buf a6: 2e 39 20 32 2e  >.9 2.<
   6.607416     [D4] read: ret 6 buf 86: 32 33 20 34 33  >23 43<
   6.628414     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   6.649454     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.154605     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   7.154780     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   7.154939     [D3] armac command Q1 response read: '(238.6 000.0 220.2 019 49.9 2.23 43.0 00000001'
   7.155160     [D5] send_to_all: SETINFO input.voltage "238.6"
   7.155370     [D2] armac: unsupported cmd: QPI
   7.155582     [D2] qx_process_answer: short reply (ups.firmware.aux)
   7.155796     [D5] send_to_all: DELINFO input.voltage
   7.156132     [D4] armac command Q1
   7.332543     [D4] read: ret 6 buf 86: 28 32 33 38 2e  >(238.<
   7.353577     [D4] read: ret 6 buf a6: 34 20 30 30 30  >4 000<
   7.373591     [D4] read: ret 6 buf 86: 2e 30 20 32 32  >.0 22<
   7.394519     [D4] read: ret 6 buf a6: 30 2e 30 20 30  >0.0 0<
   7.415524     [D4] read: ret 6 buf 86: 32 30 20 35 30  >20 50<
   7.436592     [D4] read: ret 6 buf a6: 2e 30 20 32 2e  >.0 2.<
   7.457581     [D4] read: ret 6 buf 86: 32 35 20 34 33  >25 43<
   7.478602     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   7.498569     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.000721     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   8.000802     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   8.000856     [D3] armac command Q1 response read: '(238.4 000.0 220.0 020 50.0 2.25 43.0 00000001'
   8.000946     [D5] send_to_all: SETINFO input.voltage "238.4"
   8.001017     [D4] armac command I
   8.182658     [D4] read: ret 6 buf 86: 23 32 32 32 32  >#2222<
   8.202629     [D4] read: ret 6 buf a6: 32 32 32 32 32  >22222<
   8.223635     [D4] read: ret 6 buf 86: 32 32 32 32 32  >22222<
   8.244635     [D4] read: ret 6 buf a6: 32 32 32 32 32  >22222<
   8.265670     [D4] read: ret 6 buf 86: 32 32 32 32 32  >22222<
   8.286668     [D4] read: ret 6 buf a6: 32 32 32 52 31  >222R1<
   8.307681     [D4] read: ret 6 buf 86: 2e 30 30 2e 34  >.00.4<
4< 8.816814     [D4] read: ret 6 buf a5: 37 20 20 0d 34  >7
   8.816999     [D3] trailing bytes in serial transmission found: 4  copied out of 5
   8.817159     [D3] armac command I response read: '#222222222222222222222222222R1.00.47  '
   8.817366     [D5] send_to_all: SETINFO ups.firmware "R1.00.47"
   8.817552     Using protocol: Megatec 0.07
   8.817670     [D5] send_to_all: SETINFO driver.state "init.quiet"
   8.817734     [D5] send_to_all: SETINFO driver.version "2.8.1-35-g8c913eda4"
   8.817792     [D5] send_to_all: SETINFO driver.version.internal "0.36"
   8.817848     [D5] send_to_all: SETINFO driver.name "nutdrv_qx"
   8.818019     [D5] send_to_all: SETINFO driver.state "init.info"
   8.818219     [D1] upsdrv_initinfo...
   8.818483     [D5] send_to_all: SETINFO driver.version.data "Megatec 0.07"
   8.818737     [D4] armac command Q1
   8.982740     [D4] read: ret 6 buf 86: 28 32 33 38 2e  >(238.<
   9.002765     [D4] read: ret 6 buf a6: 36 20 30 30 30  >6 000<
   9.023804     [D4] read: ret 6 buf 86: 2e 30 20 32 32  >.0 22<
   9.044744     [D4] read: ret 6 buf a6: 30 2e 30 20 30  >0.0 0<
   9.065775     [D4] read: ret 6 buf 86: 32 30 20 35 30  >20 50<
   9.086747     [D4] read: ret 6 buf a6: 2e 30 20 32 2e  >.0 2.<
   9.106752     [D4] read: ret 6 buf 86: 32 35 20 34 33  >25 43<
   9.127779     [D4] read: ret 6 buf a6: 2e 30 20 30 30  >.0 00<
   9.148786     [D4] read: ret 6 buf 86: 30 30 30 30 30  >00000<
000<.652887     [D4] read: ret 6 buf a3: 31 0d 30 30 30  >1
   9.652949     [D3] trailing bytes in serial transmission found: 2  copied out of 3
   9.653000     [D3] armac command Q1 response read: '(238.6 000.0 220.0 020 50.0 2.25 43.0 00000001'
   9.653077     [D5] send_to_all: SETINFO input.voltage.fault "0.0"
   9.653156     [D5] send_to_all: SETINFO output.voltage "220.0"
   9.653286     [D5] send_to_all: SETINFO ups.load "20"
   9.653457     [D5] send_to_all: SETINFO input.frequency "50.0"
   9.653592     [D5] send_to_all: SETINFO battery.voltage "2.25"
   9.653664     [D5] send_to_all: SETINFO ups.temperature "43.0"
   9.653773     [D5] update_status: OL
   9.653952     [D5] update_status: !LB
   9.654106     [D5] send_to_all: SETINFO ups.type "online"
   9.654166     [D5] update_status: !CAL
   9.654317     [D5] update_status: !FSD
   9.654491     [D5] send_to_all: SETINFO ups.beeper.status "enabled"
   9.654727     [D4] armac command F
   9.831884     [D4] read: ret 6 buf 86: 23 32 32 30 2e  >#220.<
   9.852899     [D4] read: ret 6 buf a6: 30 20 30 30 34  >0 004<
   9.873889     [D4] read: ret 6 buf 86: 20 30 32 34 2e  > 024.<
   9.894855     [D4] read: ret 6 buf a6: 30 20 35 30 2e  >0 50.<
50.<.399974     [D4] read: ret 6 buf 83: 30 0d 35 30 2e  >0
  10.400038     [D3] trailing bytes in serial transmission found: 2  copied out of 3
  10.400092     [D3] armac command F response read: '#220.0 004 024.0 50.0'
  10.400176     [D5] send_to_all: SETINFO input.voltage.nominal "220"
  10.400250     [D5] send_to_all: SETINFO input.current.nominal "4.0"
  10.400320     [D5] send_to_all: SETINFO battery.voltage.nominal "24.0"
  10.400389     [D5] send_to_all: SETINFO input.frequency.nominal "50"
  10.400443     [D4] armac command I
  10.572009     [D4] read: ret 6 buf a6: 23 32 32 32 32  >#2222<
  10.592950     [D4] read: ret 6 buf 86: 32 32 32 32 32  >22222<
  10.613952     [D4] read: ret 6 buf a6: 32 32 32 32 32  >22222<
  10.634951     [D4] read: ret 6 buf 86: 32 32 32 32 32  >22222<
  10.655985     [D4] read: ret 6 buf a6: 32 32 32 32 32  >22222<
  10.676010     [D4] read: ret 6 buf 86: 32 32 32 52 31  >222R1<
  10.696962     [D4] read: ret 6 buf a6: 2e 30 30 2e 34  >.00.4<
4<11.206065     [D4] read: ret 6 buf 85: 37 20 20 0d 34  >7
  11.206126     [D3] trailing bytes in serial transmission found: 4  copied out of 5
  11.206180     [D3] armac command I response read: '#222222222222222222222222222R1.00.47  '
  11.206251     [D5] send_to_all: SETINFO device.mfr "222222222222222"
  11.206317     [D5] send_to_all: SETINFO device.model "2222222222"
  11.206378     [D5] send_to_all: ADDCMD beeper.toggle
  11.206434     [D5] send_to_all: ADDCMD load.off
  11.206488     [D5] send_to_all: ADDCMD load.on
  11.206541     [D5] send_to_all: ADDCMD shutdown.return
  11.206594     [D5] send_to_all: ADDCMD shutdown.stayoff
  11.206648     [D5] send_to_all: ADDCMD shutdown.stop
  11.206701     [D5] send_to_all: ADDCMD test.battery.start
  11.206754     [D5] send_to_all: ADDCMD test.battery.start.deep
  11.206808     [D5] send_to_all: ADDCMD test.battery.start.quick
  11.206861     [D5] send_to_all: ADDCMD test.battery.stop
  11.206918     [D5] send_to_all: SETINFO ups.delay.start "180"
  11.206972     [D5] send_to_all: SETFLAGS ups.delay.start RW
  11.207065     [D5] send_to_all: ADDRANGE ups.delay.start 0 599940
  11.207123     [D5] send_to_all: SETFLAGS ups.delay.start RW NUMBER
  11.207192     [D5] send_to_all: SETINFO ups.delay.shutdown "30"
  11.207246     [D5] send_to_all: SETFLAGS ups.delay.shutdown RW
  11.207300     [D5] send_to_all: ADDRANGE ups.delay.shutdown 12 600
  11.207355     [D5] send_to_all: SETFLAGS ups.delay.shutdown RW NUMBER
  11.207412     No values for battery high/low voltages
  11.207471     [D5] send_to_all: SETINFO battery.voltage.low "20.80"
  11.207529     [D5] send_to_all: SETINFO battery.voltage.high "26.00"
  11.207583     Using 'guesstimation' (low: 20.800000, high: 26.000000)!
  11.207652     [D5] send_to_all: SETINFO battery.charge "0"
  11.207720     Autodetected 12 as number of battery packs [24/2.25]
  11.207771     Battery runtime will not be calculated (runtimecal not set)
  11.207838     [D5] send_to_all: SETINFO driver.parameter.pollfreq "30"
  11.207914     [D5] send_to_all: SETINFO driver.state "init.updateinfo"
  11.208014     [D1] upsdrv_updateinfo...
  11.208067     [D1] Quick update...
  11.208120     [D4] armac command Q1
  11.372137     [D4] read: ret 6 buf a6: 28 32 33 39 2e  >(239.<
  11.393060     [D4] read: ret 6 buf 86: 31 20 30 30 30  >1 000<
  11.414090     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
  11.435106     [D4] read: ret 6 buf 86: 30 2e 32 20 30  >0.2 0<
  11.456104     [D4] read: ret 6 buf a6: 32 30 20 34 39  >20 49<
  11.476071     [D4] read: ret 6 buf 86: 2e 39 20 32 2e  >.9 2.<
  11.497071     [D4] read: ret 6 buf a6: 32 33 20 34 33  >23 43<
  11.518100     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  11.539078     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.042229     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  12.042300     [D3] trailing bytes in serial transmission found: 2  copied out of 3
  12.042354     [D3] armac command Q1 response read: '(239.1 000.0 220.2 020 49.9 2.23 43.0 00000001'
  12.042416     [D5] update_status: OL
  12.042473     [D5] update_status: !LB
  12.042534     [D5] update_status: !CAL
  12.042588     [D5] update_status: !FSD
  12.042656     [D5] send_to_all: SETINFO ups.status "OL"
  12.042707     [D5] send_to_all: DATAOK
  12.042765     [D5] send_to_all: SETINFO driver.state "init.quiet"
  12.042825     [D5] send_to_all: SETINFO driver.parameter.pollinterval "2"
  12.042883     [D5] send_to_all: SETINFO driver.parameter.synchronous "auto"
  12.042936     Running as foreground process, not saving a PID file
  12.042991     [D5] send_to_all: SETINFO driver.flag.allow_killpower "0"
  12.043045     [D5] send_to_all: SETFLAGS driver.flag.allow_killpower RW NUMBER
  12.043103     [D5] send_to_all: ADDCMD driver.killpower
  12.043156     [D5] send_to_all: ADDCMD driver.reload
  12.043208     [D5] send_to_all: ADDCMD driver.reload-or-exit
  12.043263     [D5] send_to_all: ADDCMD driver.reload-or-error
  12.043316     [D5] send_to_all: SETINFO driver.state "quiet"
  12.043366     [D1] Driver initialization completed, beginning data dump (1 loops)
  12.043422     [D5] send_to_all: SETINFO driver.state "updateinfo"
  12.043472     [D1] upsdrv_updateinfo...
  12.043534     [D1] Quick update...
  12.043588     [D4] armac command Q1
  12.227173     [D4] read: ret 6 buf a6: 28 32 33 39 2e  >(239.<
  12.248205     [D4] read: ret 6 buf 86: 31 20 30 30 30  >1 000<
  12.269215     [D4] read: ret 6 buf a6: 2e 30 20 32 31  >.0 21<
  12.290179     [D4] read: ret 6 buf 86: 39 2e 39 20 30  >9.9 0<
  12.311182     [D4] read: ret 6 buf a6: 32 30 20 34 39  >20 49<
  12.332181     [D4] read: ret 6 buf 86: 2e 39 20 32 2e  >.9 2.<
  12.352218     [D4] read: ret 6 buf a6: 32 35 20 34 33  >25 43<
  12.373189     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  12.394197     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.898349     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  12.898414     [D3] trailing bytes in serial transmission found: 2  copied out of 3
  12.898468     [D3] armac command Q1 response read: '(239.1 000.0 219.9 020 49.9 2.25 43.0 00000001'
  12.898534     [D5] update_status: OL
  12.898591     [D5] update_status: !LB
  12.898652     [D5] update_status: !CAL
  12.898713     [D5] update_status: !FSD
  12.898780     [D5] send_to_all: SETINFO driver.state "quiet"
  12.898837     [D5] send_to_all: SETINFO driver.state "updateinfo"
  12.898887     [D1] upsdrv_updateinfo...
  12.898939     [D1] Quick update...
  12.898993     [D4] armac command Q1
  13.072312     [D4] read: ret 6 buf a6: 28 32 33 39 2e  >(239.<
  13.093287     [D4] read: ret 6 buf 86: 31 20 30 30 30  >1 000<
  13.114292     [D4] read: ret 6 buf a6: 2e 30 20 32 32  >.0 22<
  13.134290     [D4] read: ret 6 buf 86: 30 2e 30 20 30  >0.0 0<
  13.155294     [D4] read: ret 6 buf a6: 31 39 20 35 30  >19 50<
  13.176319     [D4] read: ret 6 buf 86: 2e 30 20 32 2e  >.0 2.<
  13.197301     [D4] read: ret 6 buf a6: 32 33 20 34 33  >23 43<
  13.218302     [D4] read: ret 6 buf 86: 2e 30 20 30 30  >.0 00<
  13.239306     [D4] read: ret 6 buf a6: 30 30 30 30 30  >00000<
000<.743408     [D4] read: ret 6 buf 83: 31 0d 30 30 30  >1
  13.743469     [D3] trailing bytes in serial transmission found: 2  copied out of 3
  13.743521     [D3] armac command Q1 response read: '(239.1 000.0 220.0 019 50.0 2.23 43.0 00000001'
  13.743579     [D5] update_status: OL
  13.743634     [D5] update_status: !LB
  13.743692     [D5] update_status: !CAL
  13.743748     [D5] update_status: !FSD
  13.743811     [D5] send_to_all: SETINFO driver.state "quiet"
  13.743866     [D5] send_to_all: SETINFO driver.state "dumping"
  13.743916     [D3] Entering dstate_dump
battery.charge: 0
battery.voltage: 2.25
battery.voltage.high: 26.00
battery.voltage.low: 20.80
battery.voltage.nominal: 24.0
device.mfr: 222222222222222
device.model: 2222222222
device.type: ups
driver.debug: 6
driver.flag.allow_killpower: 0
driver.name: nutdrv_qx
driver.parameter.pollfreq: 30
driver.parameter.pollinterval: 2
driver.parameter.port: auto
driver.parameter.productid: 1234
driver.parameter.subdriver: armac
driver.parameter.synchronous: auto
driver.parameter.vendorid: 0925
driver.state: dumping
driver.version: 2.8.1-35-g8c913eda4
driver.version.data: Megatec 0.07
driver.version.internal: 0.36
driver.version.usb: libusb-1.0.26 (API: 0x1000109)
input.current.nominal: 4.0
input.frequency: 50.0
input.frequency.nominal: 50
input.voltage: 238.4
input.voltage.fault: 0.0
input.voltage.nominal: 220
output.voltage: 220.0
ups.beeper.status: enabled
ups.delay.shutdown: 30
ups.delay.start: 180
ups.firmware: R1.00.47
ups.load: 20
ups.productid: 1234
ups.status: OL
ups.temperature: 43.0
ups.type: online
ups.vendorid: 0925
  13.745162     [D5] send_to_all: SETINFO driver.state "cleanup.upsdrv"
  13.745215     [D1] upsdrv_cleanup...
  13.745978     [D5] send_to_all: SETINFO driver.state "cleanup.exit"

[grydan]

I also have one last question for you.... I installed on my rasperry PI4 nut with the command:

---

sudo apt install nut

---

the version that downloads from the official repositories is version 2.8.0.7 ...

Is there an alternative repository from which I can get version 2.8.1-35 which I just tested and recompiled from github?

I don't understand what is the procedure to replace NUT with the most up-to-date version?

[grydan]

Hi, I have follow After a step here

after a complete rasperry reboot now work.

Missing only battery information: is normal or is possible to fix? I have also tested the condition when UPS go on Battery, removing the current; but that charge value does not change

I have also installed the http CGI and this is the result:

[grydan]

solved this is the way to fix also this: battery charge

[jimklimov]

Congratulations with your progress and new learnings :)

As for repositories with recent NUT builds packaged - I am not aware of any, at least the NUT CI efforts do not currently produce packages nor containers.

There is a lingering hope to provide "reference" packaging definitions in the source tree and integrate perhaps with OBS or GitHub actions to build them into deb/rpm/... archives. But so far there was not much progress about that.