fventuri / codecserver-mbelib-module

GNU General Public License v3.0
18 stars 11 forks source link

All compiles ok with no errors but codecserver_ambe is showing as NO in Features #3

Closed alastair-bor closed 2 years ago

alastair-bor commented 2 years ago

Using all recommended settings and followed instructions exactly. No errors in compliation, etc. but OpenwebRX doesn't "enable" the codecserver.

Feb 04 09:17:33 openwebrx codecserver[374]: Hello, I'm the codecserver. Feb 04 09:17:33 openwebrx codecserver[374]: now scanning for modules... Feb 04 09:17:33 openwebrx codecserver[374]: registering new driver: "ambe3k" Feb 04 09:17:33 openwebrx codecserver[374]: registering new driver: "mbelib" Feb 04 09:17:33 openwebrx codecserver[374]: loading devices from configuration... Feb 04 09:17:33 openwebrx codecserver[374]: registering new device for codecs: ambe, Feb 04 09:17:33 openwebrx codecserver[374]: auto-detecing devices... Feb 04 09:17:33 openwebrx codecserver[374]: scanning for "ambe3k" devices... Feb 04 09:17:33 openwebrx codecserver[374]: scanning for "mbelib" devices... Feb 04 09:17:33 openwebrx codecserver[374]: device scan complete. Feb 04 09:17:33 openwebrx codecserver[374]: received signal: 15

fventuri commented 2 years ago

@alastair-bor - thanks for reporting this problem.

I just ran a quick test running OpenWebRX + Codec Server (this morning I did a 'git pull' and I noticed it had a few recent changes, so I rebuilt and reinstalled it) + this codecserver-mbelib-module (which I rebuilt and reinstalled too, to make sure it was consistent with the recent changes in Codec Server), and I was able to decode a local D-Star repeater without any problem.

This is what my codecserver log looks like:

Feb 04 06:31:10 fvdesktop codecserver[3910]: Hello, I'm the codecserver.
Feb 04 06:31:10 fvdesktop codecserver[3910]: now scanning for modules...
Feb 04 06:31:10 fvdesktop codecserver[3910]: registering new driver: "ambe3k"
Feb 04 06:31:10 fvdesktop codecserver[3910]: registering new driver: "mbelib"
Feb 04 06:31:10 fvdesktop codecserver[3910]: loading devices from configuration...
Feb 04 06:31:10 fvdesktop codecserver[3910]: registering new device for codecs: ambe,
Feb 04 06:31:10 fvdesktop codecserver[3910]: auto-detecing devices...
Feb 04 06:31:10 fvdesktop codecserver[3910]: scanning for "ambe3k" devices...
Feb 04 06:31:10 fvdesktop codecserver[3910]: scanning for "mbelib" devices...
Feb 04 06:31:10 fvdesktop codecserver[3910]: device scan complete.
Feb 04 06:31:10 fvdesktop codecserver[3910]: check for codec: ambe
Feb 04 06:31:10 fvdesktop codecserver[3910]: client requests codec ambe
Feb 04 06:31:10 fvdesktop codecserver[3910]: starting new session
Feb 04 06:31:11 fvdesktop codecserver[3910]: renegotiating: direction: decode; ratep: 0130:0763:4000:0000:0000:0048
Feb 04 06:31:11 fvdesktop codecserver[3910]: client requests codec ambe
Feb 04 06:31:11 fvdesktop codecserver[3910]: starting new session
...

The clue about your problem is that line 'received signal: 15' (SIGTERM) right after the message 'device scan complete' (same second). If you are using the standard OpenWebRX configuration and settings, Codec Server runs under the account 'codecserver', while the Python script openwebrx.py runs under a different account, so in this scenario that signal cannot come from the OpenWebRX process, but it must come from somewhere else.

At this point I would try to figure out either from journalctl or from /var/log/messages the cause of that signal 15 - that could help us understand what's going on and why.

Franco

alastair-bor commented 2 years ago

Thanks Franco for the clues and I appreciate your time on this.

My installation started with the image file here: https://www.openwebrx.de/download/rpi.php I didn't do a fresh install using these instructions: https://github.com/jketterl/openwebrx/wiki/Manual-Package-installation-(including-digital-voice)

So my user account situation is what would be from the Pi image. From your instructions I did as follows:

  1. codecserver installation exactly per: https://github.com/jketterl/codecserver
  2. mbelib instructions exactly per: https://github.com/szechyjs/mbelib
  3. sudo useradd -r -d /nonexistent -c 'OpenWebRX Codec Server' codecserver
  4. The rest of the build as described here: https://github.com/fventuri/codecserver-mbelib-module

The full journalctl from a fresh boot looks like this:

-- Logs begin at Mon 2022-02-07 02:41:39 UTC, end at Mon 2022-02-07 02:51:14 UTC. -- Feb 07 02:41:39 openwebrx kernel: Booting Linux on physical CPU 0x0 Feb 07 02:41:39 openwebrx kernel: Linux version 5.10.63-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1496 SMP Wed Dec 1 15:58:56 GMT 20 Feb 07 02:41:39 openwebrx kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Feb 07 02:41:39 openwebrx kernel: CPU: div instructions available: patching division code Feb 07 02:41:39 openwebrx kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Feb 07 02:41:39 openwebrx kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.4 Feb 07 02:41:39 openwebrx kernel: random: fast init done Feb 07 02:41:39 openwebrx kernel: Memory policy: Data cache writealloc Feb 07 02:41:39 openwebrx kernel: Reserved memory: created CMA memory pool at 0x000000001ac00000, size 320 MiB Feb 07 02:41:39 openwebrx kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 07 02:41:39 openwebrx kernel: Zone ranges: Feb 07 02:41:39 openwebrx kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Feb 07 02:41:39 openwebrx kernel: Normal empty Feb 07 02:41:39 openwebrx kernel: HighMem [mem 0x0000000030000000-0x00000001ffffffff] Feb 07 02:41:39 openwebrx kernel: Movable zone start for each node Feb 07 02:41:39 openwebrx kernel: Early memory node ranges Feb 07 02:41:39 openwebrx kernel: node 0: [mem 0x0000000000000000-0x000000003b3fffff] Feb 07 02:41:39 openwebrx kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff] Feb 07 02:41:39 openwebrx kernel: node 0: [mem 0x0000000100000000-0x00000001ffffffff] Feb 07 02:41:39 openwebrx kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001ffffffff] Feb 07 02:41:39 openwebrx kernel: On node 0 totalpages: 2061312 Feb 07 02:41:39 openwebrx kernel: DMA zone: 1728 pages used for memmap Feb 07 02:41:39 openwebrx kernel: DMA zone: 0 pages reserved Feb 07 02:41:39 openwebrx kernel: DMA zone: 196608 pages, LIFO batch:63 Feb 07 02:41:39 openwebrx kernel: HighMem zone: 1864704 pages, LIFO batch:63 Feb 07 02:41:39 openwebrx kernel: percpu: Embedded 20 pages/cpu s50828 r8192 d22900 u81920 Feb 07 02:41:39 openwebrx kernel: pcpu-alloc: s50828 r8192 d22900 u81920 alloc=20*4096 Feb 07 02:41:39 openwebrx kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 07 02:41:39 openwebrx kernel: Built 1 zonelists, mobility grouping on. Total pages: 2059584 Feb 07 02:41:39 openwebrx kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=DC:A6:32:D1:A1:B5 vc_mem.mem_base=0x3ec00000 vc_me Feb 07 02:41:39 openwebrx kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Feb 07 02:41:39 openwebrx kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Feb 07 02:41:39 openwebrx kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 07 02:41:39 openwebrx kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 07 02:41:39 openwebrx kernel: software IO TLB: mapped [mem 0x0000000012400000-0x0000000016400000] (64MB) Feb 07 02:41:39 openwebrx kernel: Memory: 7758572K/8245248K available (10240K kernel code, 1364K rwdata, 3192K rodata, 2048K init, 891K bss, 158996K reserved, 327680K cma-reserved, 7458816K highmem) Feb 07 02:41:39 openwebrx kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 07 02:41:39 openwebrx kernel: ftrace: allocating 34315 entries in 68 pages Feb 07 02:41:39 openwebrx kernel: ftrace: allocated 68 pages with 2 groups Feb 07 02:41:39 openwebrx kernel: rcu: Hierarchical RCU implementation. Feb 07 02:41:39 openwebrx kernel: Rude variant of Tasks RCU enabled. Feb 07 02:41:39 openwebrx kernel: Tracing variant of Tasks RCU enabled. Feb 07 02:41:39 openwebrx kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Feb 07 02:41:39 openwebrx kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Feb 07 02:41:39 openwebrx kernel: GIC: Using split EOI/Deactivate mode Feb 07 02:41:39 openwebrx kernel: random: get_random_bytes called from start_kernel+0x3c8/0x59c with crng_init=1 Feb 07 02:41:39 openwebrx kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns Feb 07 02:41:39 openwebrx kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns Feb 07 02:41:39 openwebrx kernel: bcm2835: system timer (irq = 25) Feb 07 02:41:39 openwebrx kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 07 02:41:39 openwebrx kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 07 02:41:39 openwebrx kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 07 02:41:39 openwebrx kernel: Switching to timer-based delay loop, resolution 18ns Feb 07 02:41:39 openwebrx kernel: Console: colour dummy device 80x30 Feb 07 02:41:39 openwebrx kernel: printk: console [tty1] enabled Feb 07 02:41:39 openwebrx kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Feb 07 02:41:39 openwebrx kernel: pid_max: default: 32768 minimum: 301 Feb 07 02:41:39 openwebrx kernel: LSM: Security Framework initializing Feb 07 02:41:39 openwebrx kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 07 02:41:39 openwebrx kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Feb 07 02:41:39 openwebrx kernel: cgroup: Disabling memory control group subsystem Feb 07 02:41:39 openwebrx kernel: CPU: Testing write buffer coherency: ok Feb 07 02:41:39 openwebrx kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Feb 07 02:41:39 openwebrx kernel: Setting up static identity map for 0x200000 - 0x20003c Feb 07 02:41:39 openwebrx kernel: rcu: Hierarchical SRCU implementation. Feb 07 02:41:39 openwebrx kernel: smp: Bringing up secondary CPUs ... Feb 07 02:41:39 openwebrx kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Feb 07 02:41:39 openwebrx kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Feb 07 02:41:39 openwebrx kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Feb 07 02:41:39 openwebrx kernel: smp: Brought up 1 node, 4 CPUs Feb 07 02:41:39 openwebrx kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Feb 07 02:41:39 openwebrx kernel: CPU: All CPU(s) started in HYP mode. Feb 07 02:41:39 openwebrx kernel: CPU: Virtualization extensions available. Feb 07 02:41:39 openwebrx kernel: devtmpfs: initialized Feb 07 02:41:39 openwebrx kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Feb 07 02:41:39 openwebrx kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Feb 07 02:41:39 openwebrx kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 07 02:41:39 openwebrx kernel: pinctrl core: initialized pinctrl subsystem Feb 07 02:41:39 openwebrx kernel: NET: Registered protocol family 16 Feb 07 02:41:39 openwebrx kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Feb 07 02:41:39 openwebrx kernel: audit: initializing netlink subsys (disabled) Feb 07 02:41:39 openwebrx kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Feb 07 02:41:39 openwebrx kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 07 02:41:39 openwebrx kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Feb 07 02:41:39 openwebrx kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Feb 07 02:41:39 openwebrx kernel: Serial: AMBA PL011 UART driver Feb 07 02:41:39 openwebrx kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Feb 07 02:41:39 openwebrx kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2021-12-01T15:01:54, variant start Feb 07 02:41:39 openwebrx kernel: raspberrypi-firmware soc:firmware: Firmware hash is 71bd3109023a0c8575585ba87cbb374d2eeb038f Feb 07 02:41:39 openwebrx kernel: Kprobes globally optimized Feb 07 02:41:39 openwebrx kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Feb 07 02:41:39 openwebrx kernel: vgaarb: loaded Feb 07 02:41:39 openwebrx kernel: SCSI subsystem initialized Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver usbfs Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver hub Feb 07 02:41:39 openwebrx kernel: usbcore: registered new device driver usb Feb 07 02:41:39 openwebrx kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Feb 07 02:41:39 openwebrx kernel: clocksource: Switched to clocksource arch_sys_counter Feb 07 02:41:39 openwebrx kernel: VFS: Disk quotas dquot_6.6.0 Feb 07 02:41:39 openwebrx kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Feb 07 02:41:39 openwebrx kernel: FS-Cache: Loaded Feb 07 02:41:39 openwebrx kernel: CacheFiles: Loaded Feb 07 02:41:39 openwebrx kernel: NET: Registered protocol family 2 Feb 07 02:41:39 openwebrx kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 07 02:41:39 openwebrx kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Feb 07 02:41:39 openwebrx kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Feb 07 02:41:39 openwebrx kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 07 02:41:39 openwebrx kernel: TCP: Hash tables configured (established 8192 bind 8192) Feb 07 02:41:39 openwebrx kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 07 02:41:39 openwebrx kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Feb 07 02:41:39 openwebrx kernel: NET: Registered protocol family 1 Feb 07 02:41:39 openwebrx kernel: RPC: Registered named UNIX socket transport module. Feb 07 02:41:39 openwebrx kernel: RPC: Registered udp transport module. Feb 07 02:41:39 openwebrx kernel: RPC: Registered tcp transport module. Feb 07 02:41:39 openwebrx kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 07 02:41:39 openwebrx kernel: PCI: CLS 0 bytes, default 64 Feb 07 02:41:39 openwebrx kernel: Initialise system trusted keyrings Feb 07 02:41:39 openwebrx kernel: workingset: timestamp_bits=14 max_order=21 bucket_order=7 Feb 07 02:41:39 openwebrx kernel: zbud: loaded Feb 07 02:41:39 openwebrx kernel: FS-Cache: Netfs 'nfs' registered for caching Feb 07 02:41:39 openwebrx kernel: NFS: Registering the id_resolver key type Feb 07 02:41:39 openwebrx kernel: Key type id_resolver registered Feb 07 02:41:39 openwebrx kernel: Key type id_legacy registered Feb 07 02:41:39 openwebrx kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 07 02:41:39 openwebrx kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 07 02:41:39 openwebrx kernel: Key type asymmetric registered Feb 07 02:41:39 openwebrx kernel: Asymmetric key parser 'x509' registered Feb 07 02:41:39 openwebrx kernel: bounce: pool size: 64 pages Feb 07 02:41:39 openwebrx kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Feb 07 02:41:39 openwebrx kernel: io scheduler mq-deadline registered Feb 07 02:41:39 openwebrx kernel: io scheduler kyber registered Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Feb 07 02:41:39 openwebrx kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Feb 07 02:41:39 openwebrx kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 07 02:41:39 openwebrx kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 07 02:41:39 openwebrx kernel: PCI: bus0: Fast back to back transfers disabled Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 07 02:41:39 openwebrx kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Feb 07 02:41:39 openwebrx kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Feb 07 02:41:39 openwebrx kernel: pci 0000:01:00.0: PME# supported from D0 D3hot Feb 07 02:41:39 openwebrx kernel: PCI: bus1: Fast back to back transfers disabled Feb 07 02:41:39 openwebrx kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Feb 07 02:41:39 openwebrx kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 07 02:41:39 openwebrx kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Feb 07 02:41:39 openwebrx kernel: pcieport 0000:00:00.0: enabling device (0140 -> 0142) Feb 07 02:41:39 openwebrx kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 62 Feb 07 02:41:39 openwebrx kernel: iproc-rng200 fe104000.rng: hwrng registered Feb 07 02:41:39 openwebrx kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Feb 07 02:41:39 openwebrx kernel: gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 Feb 07 02:41:39 openwebrx kernel: brd: module loaded Feb 07 02:41:39 openwebrx kernel: loop: module loaded Feb 07 02:41:39 openwebrx kernel: Loading iSCSI transport class v2.0-870. Feb 07 02:41:39 openwebrx kernel: libphy: Fixed MDIO Bus: probed Feb 07 02:41:39 openwebrx kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Feb 07 02:41:39 openwebrx kernel: libphy: bcmgenet MII bus: probed Feb 07 02:41:39 openwebrx kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver r8152 Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver lan78xx Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver smsc95xx Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000060000000890 Feb 07 02:41:39 openwebrx kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 Feb 07 02:41:39 openwebrx kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 07 02:41:39 openwebrx kernel: usb usb1: Product: xHCI Host Controller Feb 07 02:41:39 openwebrx kernel: usb usb1: Manufacturer: Linux 5.10.63-v7l+ xhci-hcd Feb 07 02:41:39 openwebrx kernel: usb usb1: SerialNumber: 0000:01:00.0 Feb 07 02:41:39 openwebrx kernel: hub 1-0:1.0: USB hub found Feb 07 02:41:39 openwebrx kernel: hub 1-0:1.0: 1 port detected Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Feb 07 02:41:39 openwebrx kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Feb 07 02:41:39 openwebrx kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 Feb 07 02:41:39 openwebrx kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 07 02:41:39 openwebrx kernel: usb usb2: Product: xHCI Host Controller Feb 07 02:41:39 openwebrx kernel: usb usb2: Manufacturer: Linux 5.10.63-v7l+ xhci-hcd Feb 07 02:41:39 openwebrx kernel: usb usb2: SerialNumber: 0000:01:00.0 Feb 07 02:41:39 openwebrx kernel: hub 2-0:1.0: USB hub found Feb 07 02:41:39 openwebrx kernel: hub 2-0:1.0: 4 ports detected Feb 07 02:41:39 openwebrx kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 07 02:41:39 openwebrx kernel: dwc_otg: FIQ enabled Feb 07 02:41:39 openwebrx kernel: dwc_otg: NAK holdoff enabled Feb 07 02:41:39 openwebrx kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 07 02:41:39 openwebrx kernel: Module dwc_common_port init Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver uas Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver usb-storage Feb 07 02:41:39 openwebrx kernel: mousedev: PS/2 mouse device common for all mice Feb 07 02:41:39 openwebrx kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 07 02:41:39 openwebrx kernel: sdhci: Secure Digital Host Controller Interface driver Feb 07 02:41:39 openwebrx kernel: sdhci: Copyright(c) Pierre Ossman Feb 07 02:41:39 openwebrx kernel: mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe Feb 07 02:41:39 openwebrx kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 07 02:41:39 openwebrx kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 07 02:41:39 openwebrx kernel: hid: raw HID events driver (C) Jiri Kosina Feb 07 02:41:39 openwebrx kernel: usbcore: registered new interface driver usbhid Feb 07 02:41:39 openwebrx kernel: usbhid: USB HID core driver Feb 07 02:41:39 openwebrx kernel: Initializing XFRM netlink socket Feb 07 02:41:39 openwebrx kernel: NET: Registered protocol family 17 Feb 07 02:41:39 openwebrx kernel: Key type dns_resolver registered Feb 07 02:41:39 openwebrx kernel: Registering SWP/SWPB emulation handler Feb 07 02:41:39 openwebrx kernel: registered taskstats version 1 Feb 07 02:41:39 openwebrx kernel: Loading compiled-in X.509 certificates Feb 07 02:41:39 openwebrx kernel: Key type ._fscrypt registered Feb 07 02:41:39 openwebrx kernel: Key type .fscrypt registered Feb 07 02:41:39 openwebrx kernel: Key type fscrypt-provisioning registered Feb 07 02:41:39 openwebrx kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Feb 07 02:41:39 openwebrx kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Feb 07 02:41:39 openwebrx kernel: fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 Feb 07 02:41:39 openwebrx kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 07 02:41:39 openwebrx kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Feb 07 02:41:39 openwebrx kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Feb 07 02:41:39 openwebrx kernel: of_cfs_init Feb 07 02:41:39 openwebrx kernel: of_cfs_init: OK Feb 07 02:41:39 openwebrx kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Feb 07 02:41:39 openwebrx kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 07 02:41:39 openwebrx kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 07 02:41:39 openwebrx kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Feb 07 02:41:39 openwebrx kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Feb 07 02:41:39 openwebrx kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Feb 07 02:41:39 openwebrx kernel: Waiting for root device PARTUUID=bd50336f-02... Feb 07 02:41:39 openwebrx kernel: mmc1: new high speed SDIO card at address 0001 Feb 07 02:41:39 openwebrx kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa Feb 07 02:41:39 openwebrx kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB Feb 07 02:41:39 openwebrx kernel: mmcblk0: p1 p2 Feb 07 02:41:39 openwebrx kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Feb 07 02:41:39 openwebrx kernel: VFS: Mounted root (ext4 filesystem) readonly on device 179:2. Feb 07 02:41:39 openwebrx kernel: devtmpfs: mounted Feb 07 02:41:39 openwebrx kernel: Freeing unused kernel memory: 2048K Feb 07 02:41:39 openwebrx kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Feb 07 02:41:39 openwebrx kernel: Run /sbin/init as init process Feb 07 02:41:39 openwebrx kernel: with arguments: Feb 07 02:41:39 openwebrx kernel: /sbin/init Feb 07 02:41:39 openwebrx kernel: with environment: Feb 07 02:41:39 openwebrx kernel: HOME=/ Feb 07 02:41:39 openwebrx kernel: TERM=linux Feb 07 02:41:39 openwebrx kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Feb 07 02:41:39 openwebrx kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Feb 07 02:41:39 openwebrx kernel: usb 1-1: Product: USB2.0 Hub Feb 07 02:41:39 openwebrx kernel: hub 1-1:1.0: USB hub found Feb 07 02:41:39 openwebrx kernel: hub 1-1:1.0: 4 ports detected Feb 07 02:41:39 openwebrx systemd[1]: System time before build time, advancing clock. Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: new high-speed USB device number 3 using xhci_hcd Feb 07 02:41:39 openwebrx kernel: NET: Registered protocol family 10 Feb 07 02:41:39 openwebrx kernel: Segment Routing with IPv6 Feb 07 02:41:39 openwebrx systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN Feb 07 02:41:39 openwebrx systemd[1]: Detected architecture arm. Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: New USB device found, idVendor=0bda, idProduct=2838, bcdDevice= 1.00 Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: Product: RTL2838UHIDIR Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: Manufacturer: Realtek Feb 07 02:41:39 openwebrx kernel: usb 1-1.2: SerialNumber: 00000001 Feb 07 02:41:39 openwebrx systemd[1]: Set hostname to . Feb 07 02:41:39 openwebrx kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 07 02:41:39 openwebrx kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 07 02:41:39 openwebrx systemd[1]: Started Forward Password Requests to Wall Directory Watch. Feb 07 02:41:39 openwebrx kernel: random: systemd: uninitialized urandom read (16 bytes read) Feb 07 02:41:39 openwebrx systemd[1]: Listening on Journal Socket. Feb 07 02:41:39 openwebrx systemd[1]: Starting Set the console keyboard layout... Feb 07 02:41:39 openwebrx systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 07 02:41:39 openwebrx systemd[1]: Listening on Syslog Socket. Feb 07 02:41:39 openwebrx systemd[1]: Starting Restore / save the current clock... Feb 07 02:41:39 openwebrx systemd[1]: Listening on udev Kernel Socket. Feb 07 02:41:39 openwebrx systemd-journald[127]: Journal started Feb 07 02:41:39 openwebrx systemd-journald[127]: Runtime journal (/run/log/journal/27a82923e3a44f388c3355df0c4e81d6) is 8.0M, max 394.9M, 386.9M free. Feb 07 02:41:39 openwebrx fake-hwclock[114]: Mon 7 Feb 02:41:39 UTC 2022 Feb 07 02:41:39 openwebrx systemd[1]: Started File System Check on Root Device. Feb 07 02:41:39 openwebrx systemd-fsck[136]: e2fsck 1.44.5 (15-Dec-2018) Feb 07 02:41:39 openwebrx systemd-fsck[136]: rootfs: clean, 89380/934128 files, 800783/3822976 blocks Feb 07 02:41:39 openwebrx systemd[1]: Starting Remount Root and Kernel File Systems... Feb 07 02:41:39 openwebrx systemd[1]: Started Set the console keyboard layout. Feb 07 02:41:39 openwebrx kernel: EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) Feb 07 02:41:39 openwebrx systemd[1]: Started Remount Root and Kernel File Systems. Feb 07 02:41:39 openwebrx systemd[1]: Starting Flush Journal to Persistent Storage... Feb 07 02:41:39 openwebrx systemd[1]: Starting Load/Save Random Seed... Feb 07 02:41:39 openwebrx systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 07 02:41:39 openwebrx systemd[1]: Starting Create System Users... Feb 07 02:41:39 openwebrx systemd[1]: Started udev Coldplug all Devices. Feb 07 02:41:39 openwebrx systemd[1]: Starting Helper to synchronize boot up for ifupdown... Feb 07 02:41:39 openwebrx systemd[1]: Started Load/Save Random Seed. Feb 07 02:41:39 openwebrx systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 07 02:41:39 openwebrx systemd-journald[127]: Runtime journal (/run/log/journal/27a82923e3a44f388c3355df0c4e81d6) is 8.0M, max 394.9M, 386.9M free. Feb 07 02:41:39 openwebrx systemd[1]: Started Flush Journal to Persistent Storage. Feb 07 02:41:39 openwebrx systemd[1]: Started Create System Users. Feb 07 02:41:39 openwebrx systemd[1]: Starting Create Static Device Nodes in /dev... Feb 07 02:41:39 openwebrx systemd[1]: Started Create Static Device Nodes in /dev. Feb 07 02:41:39 openwebrx systemd[1]: Starting udev Kernel Device Manager... Feb 07 02:41:39 openwebrx systemd[1]: Reached target Local File Systems (Pre). Feb 07 02:41:39 openwebrx systemd[1]: Mounting /tmp/openwebrx... Feb 07 02:41:39 openwebrx systemd[1]: Mounted /tmp/openwebrx. Feb 07 02:41:39 openwebrx systemd[1]: Started udev Kernel Device Manager. Feb 07 02:41:40 openwebrx systemd-udevd[173]: Using default interface naming scheme 'v240'. Feb 07 02:41:40 openwebrx kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 Feb 07 02:41:40 openwebrx kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 Feb 07 02:41:40 openwebrx kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 Feb 07 02:41:40 openwebrx kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 Feb 07 02:41:40 openwebrx kernel: mc: Linux media interface: v0.10 Feb 07 02:41:40 openwebrx kernel: videodev: Linux video capture interface: v2.00 Feb 07 02:41:40 openwebrx kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Feb 07 02:41:40 openwebrx kernel: [vc_sm_connected_init]: start Feb 07 02:41:40 openwebrx kernel: [vc_sm_connected_init]: installed successfully Feb 07 02:41:40 openwebrx kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835_audio bcm2835_audio: card created with 8 channels Feb 07 02:41:40 openwebrx kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Feb 07 02:41:40 openwebrx kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Feb 07 02:41:40 openwebrx kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Feb 07 02:41:40 openwebrx kernel: [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0 Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Feb 07 02:41:40 openwebrx kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Feb 07 02:41:40 openwebrx systemd[1]: Found device /dev/disk/by-partuuid/bd50336f-01. Feb 07 02:41:40 openwebrx kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Feb 07 02:41:40 openwebrx kernel: [drm] No displays found. Consider forcing hotplug if HDMI is attached Feb 07 02:41:40 openwebrx kernel: vc4-drm gpu: bound fe600000.firmwarekms (ops vc4_fkms_ops [vc4]) Feb 07 02:41:40 openwebrx kernel: [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1 Feb 07 02:41:40 openwebrx kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Feb 07 02:41:40 openwebrx mtp-probe[233]: checking bus 1, device 3: "/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2" Feb 07 02:41:40 openwebrx mtp-probe[233]: bus: 1, device: 3 was not an MTP device Feb 07 02:41:40 openwebrx kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Feb 07 02:41:40 openwebrx kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 07 02:41:40 openwebrx kernel: usbcore: registered new interface driver brcmfmac Feb 07 02:41:40 openwebrx kernel: usb 1-1.2: dvb_usb_v2: found a 'Realtek RTL2832U reference design' in warm state Feb 07 02:41:41 openwebrx kernel: usb 1-1.2: dvb_usb_v2: will pass the complete MPEG2 transport stream to the software demuxer Feb 07 02:41:41 openwebrx kernel: dvbdev: DVB: registering new adapter (Realtek RTL2832U reference design) Feb 07 02:41:41 openwebrx kernel: usb 1-1.2: media controller created Feb 07 02:41:41 openwebrx kernel: dvbdev: dvb_create_media_entity: media entity 'dvb-demux' registered. Feb 07 02:41:41 openwebrx kernel: i2c i2c-22: Added multiplexed i2c bus 23 Feb 07 02:41:41 openwebrx kernel: rtl2832 22-0010: Realtek RTL2832 successfully attached Feb 07 02:41:41 openwebrx kernel: usb 1-1.2: DVB: registering adapter 0 frontend 0 (Realtek RTL2832 (DVB-T))... Feb 07 02:41:41 openwebrx kernel: dvbdev: dvb_create_media_entity: media entity 'Realtek RTL2832 (DVB-T)' registered. Feb 07 02:41:41 openwebrx kernel: r820t 23-001a: creating new instance Feb 07 02:41:41 openwebrx kernel: r820t 23-001a: Rafael Micro r820t successfully identified Feb 07 02:41:41 openwebrx kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 07 02:41:41 openwebrx kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 07 02:41:41 openwebrx kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan 4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e Feb 07 02:41:41 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: Registered as swradio0 Feb 07 02:41:41 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: Realtek RTL2832 SDR attached Feb 07 02:41:41 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: SDR API is still slightly experimental and functionality changes may follow Feb 07 02:41:41 openwebrx kernel: Registered IR keymap rc-empty Feb 07 02:41:41 openwebrx kernel: rc rc0: Realtek RTL2832U reference design as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/rc/rc0 Feb 07 02:41:41 openwebrx kernel: rc rc0: lirc_dev: driver dvb_usb_rtl28xxu registered at minor = 0, raw IR receiver, no transmitter Feb 07 02:41:41 openwebrx kernel: input: Realtek RTL2832U reference design as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/rc/rc0/input0 Feb 07 02:41:41 openwebrx kernel: usb 1-1.2: dvb_usb_v2: schedule remote query interval to 200 msecs Feb 07 02:41:41 openwebrx kernel: usb 1-1.2: dvb_usb_v2: 'Realtek RTL2832U reference design' successfully initialized and connected Feb 07 02:41:41 openwebrx kernel: usbcore: registered new interface driver dvb_usb_rtl28xxu Feb 07 02:41:41 openwebrx systemd-udevd[160]: Using default interface naming scheme 'v240'. Feb 07 02:41:41 openwebrx systemd-udevd[161]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 07 02:41:41 openwebrx systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 07 02:41:41 openwebrx systemd[1]: Condition check resulted in FUSE Control File System being skipped. Feb 07 02:41:41 openwebrx systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 07 02:41:41 openwebrx systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 07 02:41:41 openwebrx systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 07 02:41:41 openwebrx systemd[1]: Starting File System Check on /dev/disk/by-partuuid/bd50336f-01... Feb 07 02:41:41 openwebrx systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 07 02:41:41 openwebrx systemd[1]: Started Load/Save RF Kill Switch Status. Feb 07 02:41:42 openwebrx systemd-fsck[307]: fsck.fat 4.1 (2017-01-24) Feb 07 02:41:42 openwebrx systemd-fsck[307]: /dev/mmcblk0p1: 379 files, 100640/516190 clusters Feb 07 02:41:42 openwebrx systemd[1]: Started File System Check on /dev/disk/by-partuuid/bd50336f-01. Feb 07 02:41:42 openwebrx systemd[1]: Mounting /boot... Feb 07 02:41:42 openwebrx systemd[1]: Mounted /boot. Feb 07 02:41:42 openwebrx systemd[1]: Reached target Local File Systems. Feb 07 02:41:42 openwebrx systemd[1]: Starting Raise network interfaces... Feb 07 02:41:42 openwebrx systemd[1]: Starting Set console font and keymap... Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Starting Create Volatile Files and Directories... Feb 07 02:41:42 openwebrx systemd[1]: Starting Preprocess NFS configuration... Feb 07 02:41:42 openwebrx systemd[1]: Started Set console font and keymap. Feb 07 02:41:42 openwebrx systemd[1]: nfs-config.service: Succeeded. Feb 07 02:41:42 openwebrx systemd[1]: Started Preprocess NFS configuration. Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Reached target NFS client services. Feb 07 02:41:42 openwebrx systemd[1]: Reached target Remote File Systems (Pre). Feb 07 02:41:42 openwebrx systemd[1]: Reached target Remote File Systems. Feb 07 02:41:42 openwebrx systemd[1]: Started Create Volatile Files and Directories. Feb 07 02:41:42 openwebrx systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 07 02:41:42 openwebrx systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 07 02:41:42 openwebrx systemd[1]: Reached target System Initialization. Feb 07 02:41:42 openwebrx systemd[1]: Started Daily man-db regeneration. Feb 07 02:41:42 openwebrx systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 07 02:41:42 openwebrx systemd[1]: Started Daily rotation of log files. Feb 07 02:41:42 openwebrx systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 07 02:41:42 openwebrx systemd[1]: Started Daily apt download activities. Feb 07 02:41:42 openwebrx systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 07 02:41:42 openwebrx systemd[1]: Listening on triggerhappy.socket. Feb 07 02:41:42 openwebrx systemd[1]: Reached target Sockets. Feb 07 02:41:42 openwebrx systemd[1]: Reached target Basic System. Feb 07 02:41:42 openwebrx systemd[1]: Started D-Bus System Message Bus. Feb 07 02:41:42 openwebrx systemd[1]: Starting WPA supplicant... Feb 07 02:41:42 openwebrx systemd[1]: Starting dphys-swapfile - set up, mount/unmount, and delete a swap file... Feb 07 02:41:42 openwebrx systemd[1]: Started Varnish HTTP accelerator. Feb 07 02:41:42 openwebrx systemd[1]: Starting Varnish HTTP accelerator log daemon... Feb 07 02:41:42 openwebrx systemd[1]: Starting Login Service... Feb 07 02:41:42 openwebrx systemd[1]: Starting rng-tools.service... Feb 07 02:41:42 openwebrx systemd[1]: Starting Check for Raspberry Pi EEPROM updates... Feb 07 02:41:42 openwebrx systemd[1]: Started CodecServer. Feb 07 02:41:42 openwebrx systemd[1]: Starting System Logging Service... Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in Turn on SSH if /boot/ssh is present being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Starting Configure Bluetooth Modems connected by UART... Feb 07 02:41:42 openwebrx rng-tools[373]: Starting Hardware RNG entropy gatherer daemon: rngd. Feb 07 02:41:42 openwebrx systemd[1]: Starting LSB: Switch to ondemand cpu governor (unless shift key is pressed)... Feb 07 02:41:42 openwebrx rngd[386]: rngd 2-unofficial-mt.14 starting up... Feb 07 02:41:42 openwebrx systemd[1]: Starting triggerhappy global hotkey daemon... Feb 07 02:41:42 openwebrx systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 07 02:41:42 openwebrx systemd[1]: Starting dhcpcd on all interfaces... Feb 07 02:41:42 openwebrx systemd[1]: Started Daily apt upgrade and clean activities. Feb 07 02:41:42 openwebrx rngd[386]: entropy feed to the kernel ready Feb 07 02:41:42 openwebrx kernel: random: crng init done Feb 07 02:41:42 openwebrx kernel: random: 7 urandom warning(s) missed due to ratelimiting Feb 07 02:41:42 openwebrx systemd[1]: Reached target Timers. Feb 07 02:41:42 openwebrx systemd[1]: Started Regular background program processing daemon. Feb 07 02:41:42 openwebrx systemd-logind[372]: New seat seat0. Feb 07 02:41:42 openwebrx wpa_supplicant[355]: Successfully initialized wpa_supplicant Feb 07 02:41:42 openwebrx systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 07 02:41:42 openwebrx systemd[1]: Started Manage Sound Card State (restore and store). Feb 07 02:41:42 openwebrx thd[396]: Found socket passed from systemd Feb 07 02:41:42 openwebrx systemd[1]: Starting Save/Restore Sound Card State... Feb 07 02:41:42 openwebrx cron[413]: (CRON) INFO (pidfile fd = 3) Feb 07 02:41:42 openwebrx systemd[1]: Started OpenWebRX WebSDR receiver. Feb 07 02:41:42 openwebrx systemd[1]: Started triggerhappy global hotkey daemon. Feb 07 02:41:42 openwebrx systemd[1]: Started Raise network interfaces. Feb 07 02:41:42 openwebrx systemd[1]: Started rng-tools.service. Feb 07 02:41:42 openwebrx dbus-daemon[348]: [system] Successfully activated service 'org.freedesktop.systemd1' Feb 07 02:41:42 openwebrx alsactl[416]: alsactl 1.1.8 daemon started Feb 07 02:41:43 openwebrx systemd[1]: Started Login Service. Feb 07 02:41:43 openwebrx dhcpcd[397]: dev: loaded udev Feb 07 02:41:43 openwebrx systemd[1]: Started WPA supplicant. Feb 07 02:41:43 openwebrx systemd[1]: Started Save/Restore Sound Card State. Feb 07 02:41:43 openwebrx cron[413]: (CRON) INFO (Running @reboot jobs) Feb 07 02:41:43 openwebrx rsyslogd[383]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.1901.0] Feb 07 02:41:43 openwebrx rsyslogd[383]: [origin software="rsyslogd" swVersion="8.1901.0" x-pid="383" x-info="https://www.rsyslog.com"] start Feb 07 02:41:43 openwebrx dphys-swapfile[356]: want /var/swap=100MByte, checking existing: keeping it Feb 07 02:41:43 openwebrx avahi-daemon[415]: Found user 'avahi' (UID 108) and group 'avahi' (GID 113). Feb 07 02:41:43 openwebrx avahi-daemon[415]: Successfully dropped root privileges. Feb 07 02:41:43 openwebrx avahi-daemon[415]: avahi-daemon 0.7 starting up. Feb 07 02:41:43 openwebrx systemd[1]: Started System Logging Service. Feb 07 02:41:43 openwebrx kernel: uart-pl011 fe201000.serial: no DMA platform data Feb 07 02:41:43 openwebrx avahi-daemon[415]: Successfully called chroot(). Feb 07 02:41:43 openwebrx avahi-daemon[415]: Successfully dropped remaining capabilities. Feb 07 02:41:43 openwebrx avahi-daemon[415]: No service file found in /etc/avahi/services. Feb 07 02:41:43 openwebrx avahi-daemon[415]: Network interface enumeration completed. Feb 07 02:41:43 openwebrx avahi-daemon[415]: Server startup complete. Host name is openwebrx.local. Local service cookie is 33281492. Feb 07 02:41:43 openwebrx kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 07 02:41:43 openwebrx systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 07 02:41:43 openwebrx systemd[1]: Reached target Sound Card. Feb 07 02:41:43 openwebrx kernel: Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS Feb 07 02:41:43 openwebrx systemd[1]: Started dphys-swapfile - set up, mount/unmount, and delete a swap file. Feb 07 02:41:43 openwebrx dhcpcd[397]: wlan0: starting wpa_supplicant Feb 07 02:41:43 openwebrx dhcpcd-run-hooks[483]: wlan0: starting wpa_supplicant Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: BOOTLOADER: up to date Feb 07 02:41:43 openwebrx dhcpcd[397]: wlan0: connected to Access Point `' Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: CURRENT: Tue 25 Jan 14:30:41 UTC 2022 (1643121041) Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: LATEST: Tue 25 Jan 14:30:41 UTC 2022 (1643121041) Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: RELEASE: default (/lib/firmware/raspberrypi/bootloader/default) Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: Use raspi-config to change the release. Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: VL805_FW: Using bootloader EEPROM Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: VL805: up to date Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: CURRENT: 000138a1 Feb 07 02:41:43 openwebrx rpi-eeprom-update[376]: LATEST: 000138a1 Feb 07 02:41:43 openwebrx systemd[1]: Started Check for Raspberry Pi EEPROM updates. Feb 07 02:41:43 openwebrx dhcpcd[397]: eth0: waiting for carrier Feb 07 02:41:43 openwebrx dhcpcd[397]: dhcpcd_prestartinterface: wlan0: Operation not possible due to RF-kill Feb 07 02:41:43 openwebrx dhcpcd[397]: dhcpcd_prestartinterface: wlan0: Operation not possible due to RF-kill Feb 07 02:41:43 openwebrx dhcpcd[397]: wlan0: waiting for carrier Feb 07 02:41:43 openwebrx kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Feb 07 02:41:43 openwebrx kernel: bcmgenet fd580000.ethernet eth0: Link is Down Feb 07 02:41:44 openwebrx raspi-config[392]: Checking if shift key is held down: No. Switching to ondemand scaling governor. Feb 07 02:41:44 openwebrx systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed). Feb 07 02:41:45 openwebrx openwebrx[418]: 2022-02-07 02:41:45,105 - owrx.main - INFO - OpenWebRX version v1.1.0 starting up... Feb 07 02:41:45 openwebrx openwebrx[418]: 2022-02-07 02:41:45,119 - owrx.config.migration - DEBUG - migrating config from version 1 Feb 07 02:41:45 openwebrx varnishd[359]: Debug: Version: varnish-6.1.1 revision efc2f6c1536cf2272e471f5cff5f145239b19460 Feb 07 02:41:45 openwebrx varnishd[359]: Debug: Platform: Linux,5.10.63-v7l+,armv7l,-junix,-smalloc,-sdefault,-hcritbit Feb 07 02:41:45 openwebrx varnishd[359]: Version: varnish-6.1.1 revision efc2f6c1536cf2272e471f5cff5f145239b19460 Feb 07 02:41:45 openwebrx varnishd[359]: Platform: Linux,5.10.63-v7l+,armv7l,-junix,-smalloc,-sdefault,-hcritbit Feb 07 02:41:45 openwebrx varnishd[359]: Debug: Child (523) Started Feb 07 02:41:45 openwebrx varnishd[359]: Child (523) Started Feb 07 02:41:45 openwebrx varnishncsa[361]: .. Feb 07 02:41:45 openwebrx systemd[1]: Started Varnish HTTP accelerator log daemon. Feb 07 02:41:45 openwebrx varnishd[359]: Info: Child (523) said Child starts Feb 07 02:41:45 openwebrx varnishd[359]: Child (523) said Child starts Feb 07 02:41:45 openwebrx openwebrx[418]: 2022-02-07 02:41:45,407 - owrx.source - WARNING - start_freq for profile "2m" is out of range Feb 07 02:41:46 openwebrx openwebrx[418]: 2022-02-07 02:41:46,251 - owrx.source - WARNING - start_freq for profile "b4cfd95d-78af-47ae-900c-ba4fd71dbf5b" is out of range Feb 07 02:41:46 openwebrx systemd[1]: systemd-rfkill.service: Succeeded. Feb 07 02:41:48 openwebrx dhcpcd[397]: eth0: carrier acquired Feb 07 02:41:48 openwebrx dhcpcd[397]: DUID 00:01:00:01:28:9c:10:17:dc:a6:32:d1:a1:b5 Feb 07 02:41:48 openwebrx kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Feb 07 02:41:48 openwebrx kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Feb 07 02:41:48 openwebrx dhcpcd[397]: eth0: IAID 32:d1:a1:b5 Feb 07 02:41:48 openwebrx dhcpcd[397]: eth0: adding address fe80::6643:ba3b:9c25:3546 Feb 07 02:41:48 openwebrx avahi-daemon[415]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::6643:ba3b:9c25:3546. Feb 07 02:41:48 openwebrx avahi-daemon[415]: New relevant interface eth0.IPv6 for mDNS. Feb 07 02:41:48 openwebrx avahi-daemon[415]: Registering new address record for fe80::6643:ba3b:9c25:3546 on eth0.*. Feb 07 02:41:48 openwebrx dhcpcd[397]: eth0: rebinding lease of 192.168.168.151 Feb 07 02:41:48 openwebrx dhcpcd[397]: eth0: soliciting an IPv6 router Feb 07 02:41:49 openwebrx kernel: Bluetooth: Core ver 2.22 Feb 07 02:41:49 openwebrx kernel: NET: Registered protocol family 31 Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI device and connection manager initialized Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI socket layer initialized Feb 07 02:41:49 openwebrx kernel: Bluetooth: L2CAP socket layer initialized Feb 07 02:41:49 openwebrx kernel: Bluetooth: SCO socket layer initialized Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI UART driver ver 2.3 Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI UART protocol H4 registered Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Feb 07 02:41:49 openwebrx kernel: Bluetooth: HCI UART protocol Broadcom registered Feb 07 02:41:49 openwebrx btuart[385]: bcm43xx_init Feb 07 02:41:49 openwebrx btuart[385]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd Feb 07 02:41:49 openwebrx btuart[385]: Set Controller UART speed to 3000000 bit/s Feb 07 02:41:49 openwebrx btuart[385]: Device setup complete Feb 07 02:41:49 openwebrx systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 07 02:41:49 openwebrx systemd[1]: Started Configure Bluetooth Modems connected by UART. Feb 07 02:41:49 openwebrx systemd[1]: Started Load/Save RF Kill Switch Status. Feb 07 02:41:50 openwebrx systemd[1]: Created slice system-bthelper.slice. Feb 07 02:41:50 openwebrx systemd[1]: Starting Raspberry Pi bluetooth helper... Feb 07 02:41:50 openwebrx bthelper[755]: Raspberry Pi BDADDR already set Feb 07 02:41:50 openwebrx systemd[1]: Started Raspberry Pi bluetooth helper. Feb 07 02:41:50 openwebrx systemd[1]: Starting Bluetooth service... Feb 07 02:41:50 openwebrx bluetoothd[765]: Bluetooth daemon 5.50 Feb 07 02:41:50 openwebrx systemd[1]: Started Bluetooth service. Feb 07 02:41:50 openwebrx systemd[1]: Reached target Bluetooth. Feb 07 02:41:50 openwebrx bluetoothd[765]: Starting SDP server Feb 07 02:41:50 openwebrx dbus-daemon[348]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=765 comm="/usr/lib/b Feb 07 02:41:50 openwebrx bluetoothd[765]: Bluetooth management interface 1.18 initialized Feb 07 02:41:50 openwebrx kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 07 02:41:50 openwebrx kernel: Bluetooth: BNEP filters: protocol multicast Feb 07 02:41:50 openwebrx kernel: Bluetooth: BNEP socket layer initialized Feb 07 02:41:50 openwebrx bluetoothd[765]: Sap driver initialization failed. Feb 07 02:41:50 openwebrx bluetoothd[765]: sap-server: Operation not permitted (1) Feb 07 02:41:50 openwebrx systemd[1]: Starting Hostname Service... Feb 07 02:41:50 openwebrx dbus-daemon[348]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 07 02:41:50 openwebrx systemd[1]: Started Hostname Service. Feb 07 02:41:50 openwebrx bluetoothd[765]: Failed to set privacy: Rejected (0x0b) Feb 07 02:41:51 openwebrx dhcpcd[397]: eth0: probing address 192.168.168.151/24 Feb 07 02:41:54 openwebrx systemd[1]: systemd-rfkill.service: Succeeded. Feb 07 02:41:55 openwebrx bthelper[755]: Changing power off succeeded Feb 07 02:41:55 openwebrx bthelper[755]: Changing power on succeeded Feb 07 02:41:55 openwebrx bthelper[755]: [CHG] Controller DC:A6:32:D1:A1:B7 Powered: yes Feb 07 02:41:56 openwebrx dhcpcd[397]: eth0: leased 192.168.168.151 for 86400 seconds Feb 07 02:41:56 openwebrx avahi-daemon[415]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.168.151. Feb 07 02:41:56 openwebrx avahi-daemon[415]: New relevant interface eth0.IPv4 for mDNS. Feb 07 02:41:56 openwebrx avahi-daemon[415]: Registering new address record for 192.168.168.151 on eth0.IPv4. Feb 07 02:41:56 openwebrx dhcpcd[397]: eth0: adding route to 192.168.168.0/24 Feb 07 02:41:56 openwebrx dhcpcd[397]: eth0: adding default route via 192.168.168.1 Feb 07 02:41:56 openwebrx dhcpcd[397]: forked to background, child pid 821 Feb 07 02:41:56 openwebrx systemd[1]: Started dhcpcd on all interfaces. Feb 07 02:41:56 openwebrx systemd[1]: Reached target Network. Feb 07 02:41:56 openwebrx systemd[1]: Started SDRplay API Service. Feb 07 02:41:56 openwebrx systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 07 02:41:56 openwebrx systemd[1]: Starting OpenBSD Secure Shell server... Feb 07 02:41:56 openwebrx systemd[1]: Starting Permit User Sessions... Feb 07 02:41:56 openwebrx systemd[1]: Starting /etc/rc.local Compatibility... Feb 07 02:41:56 openwebrx sdrplay_apiService[822]: [822]: sdrplay_apiService: sdrplay_apiServiceWorkerThread: Entry Feb 07 02:41:56 openwebrx sdrplay_apiService[822]: [826]: sdrplay_apiService_device: heartBeatThread: Entry Feb 07 02:41:56 openwebrx systemd[1]: Starting Network Time Service... Feb 07 02:41:56 openwebrx systemd[1]: Starting A high performance web server and a reverse proxy server... Feb 07 02:41:56 openwebrx systemd[1]: Started /etc/rc.local Compatibility. Feb 07 02:41:56 openwebrx systemd[1]: Started Permit User Sessions. Feb 07 02:41:56 openwebrx systemd[1]: Started Getty on tty1. Feb 07 02:41:56 openwebrx systemd[1]: Reached target Login Prompts. Feb 07 02:41:56 openwebrx ntpd[827]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 07 02:41:56 openwebrx ntpd[827]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 109:114 Feb 07 02:41:57 openwebrx systemd[1]: Started Network Time Service. Feb 07 02:41:57 openwebrx ntpd[836]: proto: precision = 0.759 usec (-20) Feb 07 02:41:57 openwebrx ntpd[836]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 07 02:41:57 openwebrx ntpd[836]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 07 02:41:57 openwebrx ntpd[836]: Listen and drop on 0 v6wildcard [::]:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listen normally on 2 lo 127.0.0.1:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listen normally on 3 eth0 192.168.168.151:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listen normally on 4 lo [::1]:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listen normally on 5 eth0 [fe80::6643:ba3b:9c25:3546%2]:123 Feb 07 02:41:57 openwebrx ntpd[836]: Listening on routing socket on fd #22 for interface updates Feb 07 02:41:57 openwebrx ntpd[836]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 07 02:41:57 openwebrx ntpd[836]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 07 02:41:57 openwebrx sshd[837]: Server listening on 0.0.0.0 port 22. Feb 07 02:41:57 openwebrx sshd[837]: Server listening on :: port 22. Feb 07 02:41:57 openwebrx systemd[1]: Started OpenBSD Secure Shell server. Feb 07 02:41:57 openwebrx nginx[829]: nginx: [warn] conflicting server name "adsb.vk2.net" on 0.0.0.0:80, ignored Feb 07 02:41:57 openwebrx nginx[829]: nginx: [warn] conflicting server name "share.vk2.net" on 0.0.0.0:80, ignored Feb 07 02:41:57 openwebrx nginx[829]: nginx: [warn] conflicting server name "adsb.vk2.net" on 0.0.0.0:443, ignored Feb 07 02:41:57 openwebrx nginx[829]: nginx: [warn] conflicting server name "share.vk2.net" on 0.0.0.0:443, ignored Feb 07 02:41:57 openwebrx nginx[839]: nginx: [warn] conflicting server name "adsb.vk2.net" on 0.0.0.0:80, ignored Feb 07 02:41:57 openwebrx nginx[839]: nginx: [warn] conflicting server name "share.vk2.net" on 0.0.0.0:80, ignored Feb 07 02:41:57 openwebrx nginx[839]: nginx: [warn] conflicting server name "adsb.vk2.net" on 0.0.0.0:443, ignored Feb 07 02:41:57 openwebrx nginx[839]: nginx: [warn] conflicting server name "share.vk2.net" on 0.0.0.0:443, ignored Feb 07 02:41:57 openwebrx systemd[1]: Started A high performance web server and a reverse proxy server. Feb 07 02:41:57 openwebrx systemd[1]: Reached target Multi-User System. Feb 07 02:41:57 openwebrx systemd[1]: Reached target Graphical Interface. Feb 07 02:41:57 openwebrx systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 07 02:41:57 openwebrx systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 07 02:41:57 openwebrx systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 07 02:41:57 openwebrx systemd[1]: Startup finished in 2.071s (kernel) + 19.519s (userspace) = 21.590s. Feb 07 02:41:58 openwebrx ntpd[836]: Soliciting pool server 162.159.200.123 Feb 07 02:41:59 openwebrx ntpd[836]: Soliciting pool server 220.158.215.20 Feb 07 02:41:59 openwebrx ntpd[836]: Soliciting pool server 203.14.0.250 Feb 07 02:42:00 openwebrx ntpd[836]: Soliciting pool server 27.124.125.251 Feb 07 02:42:00 openwebrx ntpd[836]: Soliciting pool server 203.14.0.251 Feb 07 02:42:00 openwebrx ntpd[836]: Soliciting pool server 112.213.34.20 Feb 07 02:42:01 openwebrx ntpd[836]: Soliciting pool server 27.124.125.250 Feb 07 02:42:01 openwebrx ntpd[836]: Soliciting pool server 103.38.121.36 Feb 07 02:42:01 openwebrx ntpd[836]: Soliciting pool server 13.55.50.68 Feb 07 02:42:01 openwebrx ntpd[836]: Soliciting pool server 162.159.200.1 Feb 07 02:42:01 openwebrx dhcpcd[821]: eth0: no IPv6 Routers available Feb 07 02:42:02 openwebrx ntpd[836]: Soliciting pool server 45.76.113.31 Feb 07 02:42:02 openwebrx ntpd[836]: Soliciting pool server 103.38.120.36 Feb 07 02:42:02 openwebrx ntpd[836]: Soliciting pool server 103.38.120.36 Feb 07 02:42:03 openwebrx ntpd[836]: Soliciting pool server 150.101.186.50 Feb 07 02:42:03 openwebrx ntpd[836]: Soliciting pool server 2402:1f00:8100:400::174 Feb 07 02:42:19 openwebrx ntpd[836]: receive: Unexpected origin timestamp 0xe5ab057e.007fe251 does not match aorg 0000000000.00000000 from server@103.38.121.36 xmt 0xe5ab058a.ff56f0ac Feb 07 02:42:19 openwebrx ntpd[836]: receive: Unexpected origin timestamp 0xe5ab057e.0088c96c does not match aorg 0000000000.00000000 from server@203.14.0.251 xmt 0xe5ab058b.934a2717 Feb 07 02:42:19 openwebrx ntpd[836]: receive: Unexpected origin timestamp 0xe5ab057e.0071df97 does not match aorg 0000000000.00000000 from server@103.38.120.36 xmt 0xe5ab058b.93c70721 Feb 07 02:42:19 openwebrx ntpd[836]: receive: Unexpected origin timestamp 0xe5ab057e.0069936a does not match aorg 0000000000.00000000 from server@150.101.186.50 xmt 0xe5ab058b.959f5c37 Feb 07 02:42:19 openwebrx ntpd[836]: receive: Unexpected origin timestamp 0xe5ab057e.007b070f does not match aorg 0000000000.00000000 from server@27.124.125.250 xmt 0xe5ab058b.99554707 Feb 07 02:42:25 openwebrx systemd[1]: systemd-fsckd.service: Succeeded. Feb 07 02:42:33 openwebrx systemd[1]: systemd-hostnamed.service: Succeeded. Feb 07 02:42:44 openwebrx sshd[848]: Accepted password for pi from 192.168.44.152 port 50882 ssh2 Feb 07 02:42:44 openwebrx sshd[848]: pam_unix(sshd:session): session opened for user pi by (uid=0) Feb 07 02:42:44 openwebrx systemd-logind[372]: New session 1 of user pi. Feb 07 02:42:44 openwebrx systemd[1]: Created slice User Slice of UID 1000. Feb 07 02:42:44 openwebrx systemd[1]: Starting User Runtime Directory /run/user/1000... Feb 07 02:42:44 openwebrx systemd[1]: Started User Runtime Directory /run/user/1000. Feb 07 02:42:44 openwebrx systemd[1]: Starting User Manager for UID 1000... Feb 07 02:42:44 openwebrx systemd[851]: pam_unix(systemd-user:session): session opened for user pi by (uid=0) Feb 07 02:42:44 openwebrx systemd[851]: Reached target Paths. Feb 07 02:42:44 openwebrx systemd[851]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Feb 07 02:42:44 openwebrx systemd[851]: Starting D-Bus User Message Bus Socket. Feb 07 02:42:44 openwebrx systemd[851]: Reached target Timers. Feb 07 02:42:44 openwebrx systemd[851]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Feb 07 02:42:44 openwebrx systemd[851]: Listening on GnuPG cryptographic agent and passphrase cache. Feb 07 02:42:44 openwebrx systemd[851]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Feb 07 02:42:44 openwebrx systemd[851]: Listening on GnuPG network certificate management daemon. Feb 07 02:42:44 openwebrx systemd[851]: Listening on D-Bus User Message Bus Socket. Feb 07 02:42:44 openwebrx systemd[851]: Reached target Sockets. Feb 07 02:42:44 openwebrx systemd[851]: Reached target Basic System. Feb 07 02:42:44 openwebrx systemd[851]: Reached target Default. Feb 07 02:42:44 openwebrx systemd[851]: Startup finished in 200ms. Feb 07 02:42:44 openwebrx systemd[1]: Started User Manager for UID 1000. Feb 07 02:42:44 openwebrx systemd[1]: Started Session 1 of user pi. Feb 07 02:43:22 openwebrx ntpd[836]: Soliciting pool server 203.57.51.100 Feb 07 02:50:48 openwebrx openwebrx[418]: 2022-02-07 02:50:48,060 - owrx.connection - DEBUG - client connection initialized Feb 07 02:50:48 openwebrx openwebrx[418]: 2022-02-07 02:50:48,089 - owrx.source - INFO - Started sdr source: rtl_connector -g auto -s 2400000 -f 439000000 -p 59699 -c 40913 Feb 07 02:50:48 openwebrx openwebrx[418]: setting up control socket... Feb 07 02:50:48 openwebrx openwebrx[418]: control socket started on 40913 Feb 07 02:50:48 openwebrx openwebrx[418]: socket setup complete, waiting for connections Feb 07 02:50:48 openwebrx openwebrx[418]: Found 1 device(s): Feb 07 02:50:48 openwebrx openwebrx[418]: 0: Realtek, RTL2838UHIDIR, SN: 00000001 Feb 07 02:50:48 openwebrx openwebrx[418]: client connection established Feb 07 02:50:48 openwebrx openwebrx[418]: 2022-02-07 02:50:48,192 - owrx.source.connector - DEBUG - opening control socket... Feb 07 02:50:48 openwebrx openwebrx[418]: control connection established Feb 07 02:50:48 openwebrx thd[396]: Error reading device '/dev/input/event0' Feb 07 02:50:48 openwebrx openwebrx[418]: Detached kernel driver Feb 07 02:50:48 openwebrx kernel: r820t 23-001a: destroying instance Feb 07 02:50:48 openwebrx kernel: dvb_usb_v2: 'Realtek RTL2832U reference design:1-1.2' successfully deinitialized and disconnected Feb 07 02:50:48 openwebrx openwebrx[418]: Found Rafael Micro R820T tuner Feb 07 02:50:48 openwebrx kernel: process '/usr/bin/jt9' started with executable stack Feb 07 02:50:48 openwebrx openwebrx[418]: Allocating 2 zero-copy buffers Feb 07 02:50:48 openwebrx openwebrx[418]: closing client socket Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,504 - owrx.dsp - DEBUG - received STATE_RUNNING, attempting DspSource restart Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,585 - owrx.bands - DEBUG - reloading bands from disk due to file modification Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,596 - owrx.bands - WARNING - Frequency for wspr on 4m is not within band limits: 70091000 Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,598 - owrx.bands - WARNING - Frequency for q65 on 13cm is not within band limits: 2301065000 Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,598 - owrx.bands - WARNING - Frequency for q65 on 13cm is not within band limits: 2304065000 Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,601 - owrx.bookmarks - DEBUG - reloading bookmarks from disk due to file modification Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,950 - owrx.fft - DEBUG - Spectrum thread initialized successfully. Feb 07 02:50:49 openwebrx openwebrx[418]: 2022-02-07 02:50:49,951 - csdr - DEBUG - Command = nc -v 127.0.0.1 59699 | csdr fft_cc 4096 2867.383512544803 | csdr logaveragepower_cf -70 4096 93 | csdr fft_exchange_sides Feb 07 02:50:49 openwebrx openwebrx[418]: client connection established Feb 07 02:50:49 openwebrx openwebrx[418]: Connection to 127.0.0.1 59699 port [tcp/] succeeded! Feb 07 02:50:50 openwebrx openwebrx[418]: 2022-02-07 02:50:50,722 - owrx.cpu - DEBUG - cpu usage thread starting up Feb 07 02:50:50 openwebrx openwebrx[418]: 2022-02-07 02:50:50,723 - owrx.connection - DEBUG - handshake complete, handing off to OpenWebRxReceiverClient Feb 07 02:50:50 openwebrx openwebrx[418]: 2022-02-07 02:50:50,770 - csdr - DEBUG - Command = nc -v 127.0.0.1 59699 | csdr shift_addfast_cc --fifo /tmp/openwebrx/openwebrx_pipe_shift_pipe_3038973648 | csdr fir_decima Feb 07 02:50:50 openwebrx openwebrx[418]: 2022-02-07 02:50:50,780 - owrx.dsp - DEBUG - adding new output of type audio Feb 07 02:50:50 openwebrx openwebrx[418]: 2022-02-07 02:50:50,782 - owrx.dsp - DEBUG - adding new output of type smeter Feb 07 02:50:50 openwebrx openwebrx[418]: csdr shift_addfast_cc: fifo control mode on Feb 07 02:50:50 openwebrx openwebrx[418]: fir_decimate_cc: taps_length = 5333 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr fir_decimate_cc: taps_length = 5333 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr fir_decimate_cc: padded_taps_length = 5336 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr fir_decimate_cc: taps = 282168 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr fir_decimate_cc: NEON aligned taps = 282180 Feb 07 02:50:50 openwebrx openwebrx[418]: client connection established Feb 07 02:50:50 openwebrx openwebrx[418]: Connection to 127.0.0.1 59699 port [tcp/] succeeded! Feb 07 02:50:50 openwebrx openwebrx[418]: AGC PARAMS: Feb 07 02:50:50 openwebrx openwebrx[418]: hang_time = 600 Feb 07 02:50:50 openwebrx openwebrx[418]: reference = 0.800000 Feb 07 02:50:50 openwebrx openwebrx[418]: attack_rate = 0.010000 Feb 07 02:50:50 openwebrx openwebrx[418]: decay_rate = 0.000100 Feb 07 02:50:50 openwebrx openwebrx[418]: max_gain = 3.000000 Feb 07 02:50:50 openwebrx openwebrx[418]: initial_gain = 1.000000 Feb 07 02:50:50 openwebrx openwebrx[418]: attack_wait_time = 0 Feb 07 02:50:50 openwebrx openwebrx[418]: gain_filter_alpha = 1.500000 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr squelch_and_smeter_cc: fifo control mode on Feb 07 02:50:50 openwebrx openwebrx[418]: csdr bandpass_fir_fft_cc: fifo control mode on Feb 07 02:50:50 openwebrx openwebrx[418]: csdr bandpass_fir_fft_cc: (fft_size = 512) = (taps_length = 149) + (input_size = 364) - 1 Feb 07 02:50:50 openwebrx openwebrx[418]: (overlap_length = 148) = taps_length - 1 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr shift_addfast_cc: reinitialized to 0.177083 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr bandpass_fir_fft_cc: filter initialized, low_cut = -0.333333, high_cut = 0.333333 Feb 07 02:50:50 openwebrx openwebrx[418]: csdr squelch_and_smeter_cc: initial squelch level is 1e-06 Feb 07 02:50:54 openwebrx openwebrx[418]: 2022-02-07 02:50:54,032 - owrx.users - DEBUG - reloading users from disk due to file modification Feb 07 02:50:54 openwebrx kernel: Under-voltage detected! (0x00050005) Feb 07 02:51:04 openwebrx openwebrx[418]: 2022-02-07 02:51:04,330 - owrx.websocket - DEBUG - websocket close frame received; closing connection Feb 07 02:51:04 openwebrx openwebrx[418]: 2022-02-07 02:51:04,330 - owrx.websocket - DEBUG - websocket loop ended; shutting down Feb 07 02:51:04 openwebrx openwebrx[418]: 2022-02-07 02:51:04,333 - csdr - DEBUG - dsp thread ended with rc=-15 Feb 07 02:51:04 openwebrx openwebrx[418]: 2022-02-07 02:51:04,334 - csdr - DEBUG - dsp thread ended with rc=-15 Feb 07 02:51:04 openwebrx openwebrx[418]: closing client socket Feb 07 02:51:04 openwebrx openwebrx[418]: received signal: 15 Feb 07 02:51:04 openwebrx openwebrx[418]: closing client socket Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: dvb_usb_v2: found a 'Realtek RTL2832U reference design' in warm state Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: dvb_usb_v2: will pass the complete MPEG2 transport stream to the software demuxer Feb 07 02:51:05 openwebrx kernel: dvbdev: DVB: registering new adapter (Realtek RTL2832U reference design) Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: media controller created Feb 07 02:51:05 openwebrx kernel: dvbdev: dvb_create_media_entity: media entity 'dvb-demux' registered. Feb 07 02:51:05 openwebrx kernel: i2c i2c-22: Added multiplexed i2c bus 23 Feb 07 02:51:05 openwebrx kernel: rtl2832 22-0010: Realtek RTL2832 successfully attached Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: DVB: registering adapter 0 frontend 0 (Realtek RTL2832 (DVB-T))... Feb 07 02:51:05 openwebrx kernel: dvbdev: dvb_create_media_entity: media entity 'Realtek RTL2832 (DVB-T)' registered. Feb 07 02:51:05 openwebrx kernel: r820t 23-001a: creating new instance Feb 07 02:51:05 openwebrx kernel: r820t 23-001a: Rafael Micro r820t successfully identified Feb 07 02:51:05 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: Registered as swradio0 Feb 07 02:51:05 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: Realtek RTL2832 SDR attached Feb 07 02:51:05 openwebrx kernel: rtl2832_sdr rtl2832_sdr.0.auto: SDR API is still slightly experimental and functionality changes may follow Feb 07 02:51:05 openwebrx kernel: Registered IR keymap rc-empty Feb 07 02:51:05 openwebrx kernel: rc rc0: Realtek RTL2832U reference design as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/rc/rc0 Feb 07 02:51:05 openwebrx kernel: rc rc0: lirc_dev: driver dvb_usb_rtl28xxu registered at minor = 0, raw IR receiver, no transmitter Feb 07 02:51:05 openwebrx kernel: input: Realtek RTL2832U reference design as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/rc/rc0/input1 Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: dvb_usb_v2: schedule remote query interval to 200 msecs Feb 07 02:51:05 openwebrx openwebrx[418]: Reattached kernel driver Feb 07 02:51:05 openwebrx kernel: usb 1-1.2: dvb_usb_v2: 'Realtek RTL2832U reference design' successfully initialized and connected Feb 07 02:51:05 openwebrx openwebrx[418]: 2022-02-07 02:51:05,545 - owrx.source - DEBUG - shut down with RC=0 Feb 07 02:51:05 openwebrx openwebrx[418]: 2022-02-07 02:51:05,547 - owrx.websocket - DEBUG - websocket loop ended; sending close frame Feb 07 02:51:05 openwebrx openwebrx[418]: 2022-02-07 02:51:05,548 - owrx.cpu - DEBUG - cpu usage thread shut down Feb 07 02:51:05 openwebrx systemd-udevd[992]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 07 02:51:07 openwebrx kernel: Voltage normalised (0x00000000) Feb 07 02:51:14 openwebrx openwebrx[418]: 2022-02-07 02:51:14,338 - owrx.service.schedule - DEBUG - no active schedule, scheduler standing by for external events.

fventuri commented 2 years ago

@alastair-bor - thanks for the detailed report.

I have a Raspberry Pi too (model 4); tomorrow I'll try the installation of OpenWebRX + CodecServer from the official Raspberry Pi image (the only difference with you is that I'll be trying with the SDRplay RSPdx, since I do not have an RTL-SDR dongle), and I'll let you know how it goes.

Franco

fventuri commented 2 years ago

@alastair-bor I downloaded the official Raspberry Pi image from the link you mentioned in your comment (https://www.openwebrx.de/download/rpi.php), and I noticed that it already contains Codec Server, so some of the instructions from the README (which I wrote based on my own OpenWebRx installation on my desktop) do not apply in this case.

I followed roughly the steps discussed in a previous issue in this repository (https://github.com/fventuri/codecserver-mbelib-module/issues/2) and I was able to get Codec Server to see this module and OpenWebRX to use it to decode digital voice traffic.

Here are exactly all the commands I ran on my Raspberry Pi after booting it with the image 2021-08-03-OpenWebRX-full.img:

(assign IP address)
(enable SSH)
(remote login as user pi)

sudo apt update
sudo apt full-upgrade
sudo reboot

(after reboot)

git clone https://github.com/szechyjs/mbelib.git
cd mbelib
mkdir build
cd build
cmake ..
make
sudo make install
cd
sudo ldconfig

sudo apt install libcodecserver-dev libprotobuf-dev protobuf-compiler

git clone https://github.com/fventuri/codecserver-mbelib-module.git
cd codecserver-mbelib-module
mkdir build
cd build
cmake -DCMAKE_INSTALL_LIBDIR='/usr/lib/arm-linux-gnueabihf' ..
make
sudo make install
cd
sudo ldconfig

{ echo; echo '[device:mbelib]'; echo 'driver=mbelib'; echo 'unvoiced_quality=3'; } | sudo tee -a /etc/codecserver/codecserver.conf
sudo systemctl restart codecserver

I then connected to OpenWebRX on port 8073, saw that it showed the digital voice decoders options; to test this module, I set up a simple profile for a local D-Star repeater on 2m, and I was able to decode the D-Star traffic there (I didn't try DMR or YSF but I imagine they should work too).

Please give it a try using the instructions above (starting from a fresh Raspberry Pi image) and let me know how it goes; if these commands work for you too, I'll add the detailed instructions to the README.

Franco

PS: I too saw that signal 15 here in the logs from journalctl when I restarted Codec Server, and I think it is just systemd terminating the codecserver process before restarting it, so it is nothing to worry about; sorry for pointing you in the wrong direction earlier.

alastair-bor commented 2 years ago

Excellent! I built it out on a brand new RPi3 test device and it worked per your instructions. Thank you very much. I haven't yet tested the DMR because there is nothing active at the moment, but the menu item appears. Will test it tonight and report back.

I'll have a little play with why my existing system (which shouldn't be too far off the base config) isn't working... I tried your instructions as an overlay on the existing system and it didn't fix it.

alastair-bor commented 2 years ago

@fventuri - I can confirm that this fully works for DMR! Thanks for the support.

fventuri commented 2 years ago

@alastair-bor - glad to hear the instructions worked for you.

I just added a section with those same instructions to the README file: https://github.com/fventuri/codecserver-mbelib-module#how-to-build---openwebrx-raspberry-pi-images

Franco