nisargjhaveri / WirelessAndroidAutoDongle

Use Wireless Android Auto with a car that supports only wired Android Auto using a Raspberry Pi.
MIT License
706 stars 82 forks source link

Frequent disconnections with ATOTO headunit #7

Closed nu00 closed 7 months ago

nu00 commented 1 year ago

Hi, I have an ATOTO YS102SL (now out of production) with a "Linux" proprietary OS. I tried your project on an RPi4, but it didn't work at all. The head unit didn't even recognize the device. So, I built this fork https://github.com/BluemediaGER/AAWirelessDongle, and it recognizes the RPi, but it doesn't start Android Auto. On the phone (Pixel 8), I get a notification saying "Looking for Android Auto..." and that's all. I also tried the fork on a Peugeot car, and after some tries, it worked fine. Here are some photos I took of the head unit and the log on a monitor connected to the Pi. Note that every time I tap "Reconnect" on the head unit, I get a new address. PXL_20231022_211730527 PXL_20231022_211738242

I'm available for further testing of the project with my head unit; I just need some guidance on what to adjust.

BluemediaGER commented 1 year ago

My fork contains special customizations for my own headunit, which may break functionality for others. Try the main branch of this repo, now that #3 has been merged. If there are still problems that your headunit doesn't recognize the Pi, you can try this branch of my fork.

nu00 commented 1 year ago

I tried both the main branch of this repository and the feature/device-ids branch of your repository, but the head unit still doesn't recognize it. The main branch doesn't even activate Bluetooth, while the feature/device-ids branch activates Bluetooth, labeling it as "OnePlus Nord," but it doesn't accept connections. Unfortunately, I didn't have the display with me today, so I don't know what is actually happening on the pi. Is it possible to connect via SSH to the RPi for debugging? I tried, but it asks for a username and password...

danihidayatx commented 1 year ago

I tried both the main branch of this repository and the feature/device-ids branch of your repository, but the head unit still doesn't recognize it. The main branch doesn't even activate Bluetooth, while the feature/device-ids branch activates Bluetooth, labeling it as "OnePlus Nord," but it doesn't accept connections. Unfortunately, I didn't have the display with me today, so I don't know what is actually happening on the pi. Is it possible to connect via SSH to the RPi for debugging? I tried, but it asks for a username and password...

yes you can, connect it through the wifi that raspberry pi created, then for the authentication is username = "root" password = "password"

nisargjhaveri commented 1 year ago

I tried both the main branch of this repository and the feature/device-ids branch of your repository, but the head unit still doesn't recognize it. The main branch doesn't even activate Bluetooth

The main branch currently only activates bluetooth after the headunit initiates Android Auto connection, that is the headunit sends the accessory start command, and from your description that might not be happening.

Currently, "restarting" from the headunit won't have much effect. Unfortunately it is not handled very well yet. Best way to retry as of now is to disconnect the RPi and reconnect to cause a reboot.

It might also help to look at the /var/log/messages after doing SSH into the RPi.

nu00 commented 1 year ago

Here's the logs of an attempt to use my ATOTO headunit. I'm using a build updated at 8f12cf0b8b395d514dc956ae19c2f98192fe9af9

# cat /var/log/messages
Jan  1 00:00:01 buildroot syslog.info syslogd started: BusyBox v1.36.0
Jan  1 00:00:01 buildroot kern.notice kernel: klogd started: BusyBox v1.36.0 (2023-10-23 20:51:38 CEST)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Booting Linux on physical CPU 0x0
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Linux version 5.10.92-v7l (REDACTED) (arm-buildroot-linux-gnueabihf-gcc.br_real (Buildroot 2023.02) 11.3.0, GNU ld (GNU Binutils) 2.38) #1 SMP Mon Oct 23 21:07:06 CEST 2023
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: div instructions available: patching division code
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: fast init done
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory policy: Data cache writealloc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Zone ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   Normal   empty
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   HighMem  [mem 0x0000000030000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Movable zone start for each node
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Early memory node ranges
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x0000000039bfffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] On node 0 totalpages: 1006592
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 1728 pages used for memmap
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 0 pages reserved
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 196608 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   HighMem zone: 809984 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] percpu: Embedded 15 pages/cpu s31628 r8192 d21620 u61440
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: s31628 r8192 d21620 u61440 alloc=15*4096
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1004864
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=0 bcm2708_fb.fbheight=0 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:46:60:BE vc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] software IO TLB: mapped [mem 0x0000000024890000-0x0000000028890000] (64MB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory: 3840468K/4026368K available (10240K kernel code, 731K rwdata, 2476K rodata, 2048K init, 567K bss, 120364K reserved, 65536K cma-reserved, 3239936K highmem)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]      Tracing variant of Tasks RCU enabled.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x32c/0x500 with crng_init=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000035] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000096] bcm2835: system timer (irq = 25)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000693] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000713] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000733] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000749] Switching to timer-based delay loop, resolution 18ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000990] Console: colour dummy device 80x30
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001530] printk: console [tty1] enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001577] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001615] pid_max: default: 32768 minimum: 301
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001730] LSM: Security Framework initializing
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001801] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001836] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.002891] cgroup: Disabling memory control group subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003071] CPU: Testing write buffer coherency: ok
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003348] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003918] Setting up static identity map for 0x200000 - 0x20003c
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004028] rcu: Hierarchical SRCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004519] smp: Bringing up secondary CPUs ...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.005248] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006027] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006774] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006876] smp: Brought up 1 node, 4 CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006934] SMP: Total of 4 processors activated (432.00 BogoMIPS).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006955] CPU: All CPU(s) started in HYP mode.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006972] CPU: Virtualization extensions available.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.007544] devtmpfs: initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018391] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018568] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018606] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020280] pinctrl core: initialized pinctrl subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020945] NET: Registered protocol family 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.022952] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jan  1 00:00:01 buildroot kern.info kernel: [    0.023610] audit: initializing netlink subsys (disabled)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024196] thermal_sys: Registered thermal governor 'step_wise'
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.024425] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024555] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024581] hw-breakpoint: maximum watchpoint size is 8 bytes.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024894] Serial: AMBA PL011 UART driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.040731] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.060768] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-17T19:20:34, variant start
Jan  1 00:00:01 buildroot kern.info kernel: [    0.070772] raspberrypi-firmware soc:firmware: Firmware hash is bd34f55ef7b01b0a367f131060b561a2a58b80bb
Jan  1 00:00:01 buildroot kern.info kernel: [    0.104415] Kprobes globally optimized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.107336] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.109650] vgaarb: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.110026] SCSI subsystem initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110213] usbcore: registered new interface driver usbfs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110273] usbcore: registered new interface driver hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110328] usbcore: registered new device driver usb
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.110490] usb_phy_generic phy: supply vcc not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    0.111814] clocksource: Switched to clocksource arch_sys_counter
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.112023] VFS: Disk quotas dquot_6.6.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112094] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.112209] FS-Cache: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112348] CacheFiles: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119653] NET: Registered protocol family 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119859] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121319] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121372] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121441] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121514] TCP: Hash tables configured (established 8192 bind 8192)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121638] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121683] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121877] NET: Registered protocol family 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122343] RPC: Registered named UNIX socket transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122367] RPC: Registered udp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122385] RPC: Registered tcp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122404] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122430] PCI: CLS 0 bytes, default 64
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.123579] Initialise system trusted keyrings
Jan  1 00:00:01 buildroot kern.info kernel: [    0.123718] workingset: timestamp_bits=14 max_order=20 bucket_order=6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.128349] zbud: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129487] FS-Cache: Netfs 'nfs' registered for caching
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129953] NFS: Registering the id_resolver key type
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129991] Key type id_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130010] Key type id_legacy registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130114] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130137] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130849] Key type asymmetric registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130871] Asymmetric key parser 'x509' registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130946] bounce: pool size: 64 pages
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130998] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131137] io scheduler mq-deadline registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131159] io scheduler kyber registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133386] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133426] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133477] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133529] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.193897] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194104] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194131] pci_bus 0000:00: root bus resource [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194158] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194223] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194325] pci 0000:00:00.0: PME# supported from D0 D3hot
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197301] PCI: bus0: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197516] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197620] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197898] pci 0000:01:00.0: PME# supported from D0 D3cold
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200847] PCI: bus1: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200898] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200927] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201004] pci 0000:00:00.0: PCI bridge to [bus 01]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201029] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201233] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201386] pcieport 0000:00:00.0: PME: Signaling with IRQ 63
Jan  1 00:00:01 buildroot kern.err kernel: [    0.201902] bcm2708_fb soc:fb: Unable to determine number of FBs. Disabling driver.
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.201940] bcm2708_fb: probe of soc:fb failed with error -2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.205924] iproc-rng200 fe104000.rng: hwrng registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206080] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206717] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.214901] brd: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.219937] loop: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.220907] Loading iSCSI transport class v2.0-870.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.223327] libphy: Fixed MDIO Bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.224324] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.241827] libphy: bcmgenet MII bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.331886] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332764] usbcore: registered new interface driver r8152
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332836] usbcore: registered new interface driver lan78xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332897] usbcore: registered new interface driver smsc95xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334285] xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334413] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334453] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336528] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337003] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337033] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337058] usb usb1: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337078] usb usb1: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337099] usb usb1: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337614] hub 1-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337696] hub 1-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338135] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338168] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338201] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338470] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338499] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338524] usb usb2: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338543] usb usb2: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338563] usb usb2: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339024] hub 2-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339075] hub 2-0:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340117] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340238] dwc_otg: FIQ enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340247] dwc_otg: NAK holdoff enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340255] dwc_otg: FIQ split-transaction FSM enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340266] Module dwc_common_port init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340530] usbcore: registered new interface driver uas
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340625] usbcore: registered new interface driver usb-storage
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340781] mousedev: PS/2 mouse device common for all mice
Jan  1 00:00:01 buildroot kern.info kernel: [    0.341616] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344264] sdhci: Secure Digital Host Controller Interface driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344287] sdhci: Copyright(c) Pierre Ossman
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344660] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344915] sdhci-pltfm: SDHCI platform and OF driver helper
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347703] ledtrig-cpu: registered to indicate activity on CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347967] hid: raw HID events driver (C) Jiri Kosina
Jan  1 00:00:01 buildroot kern.info kernel: [    0.348075] usbcore: registered new interface driver usbhid
Jan  1 00:00:01 buildroot kern.info kernel: [    0.348105] usbhid: USB HID core driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351448] Initializing XFRM netlink socket
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351485] NET: Registered protocol family 17
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351577] Key type dns_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351679] Registering SWP/SWPB emulation handler
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351736] registered taskstats version 1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351759] Loading compiled-in X.509 certificates
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.352159] Key type ._fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.352181] Key type .fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.352200] Key type fscrypt-provisioning registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353685] uart-pl011 fe201000.serial: there is not valid maps for state default
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353858] uart-pl011 fe201000.serial: cts_event_workaround enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353923] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.354102] serial serial0: tty port ttyAMA0 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.360098] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.360630] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.360655] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Jan  1 00:00:01 buildroot kern.info kernel: [    0.385511] of_cfs_init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.386225] of_cfs_init: OK
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.405058] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.406611] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.408166] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.410940] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.412498] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.421847] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Jan  1 00:00:01 buildroot kern.info kernel: [    0.422670] Waiting for root device /dev/mmcblk0p2...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.474667] mmc1: new high speed SDIO card at address 0001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.520496] mmc0: new ultra high speed DDR50 SDHC card at address 5048
Jan  1 00:00:01 buildroot kern.info kernel: [    0.521099] mmcblk0: mmc0:5048 SD32G 29.7 GiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.522814]  mmcblk0: p1 p2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.545073] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.545107] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
Jan  1 00:00:01 buildroot kern.info kernel: [    0.609227] EXT4-fs (mmcblk0p2): recovery complete
Jan  1 00:00:01 buildroot kern.info kernel: [    0.610679] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.610756] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.611261] devtmpfs: mounted
Jan  1 00:00:01 buildroot kern.info kernel: [    0.613790] Freeing unused kernel memory: 2048K
Jan  1 00:00:01 buildroot kern.info kernel: [    0.614069] Run /sbin/init as init process
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.614088]   with arguments:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.614096]     /sbin/init
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.614103]   with environment:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.614111]     HOME=/
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.614118]     TERM=linux
Jan  1 00:00:01 buildroot kern.info kernel: [    0.631852] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.692437] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.786524] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jan  1 00:00:01 buildroot kern.info kernel: [    0.814428] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Jan  1 00:00:01 buildroot kern.info kernel: [    0.814467] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.814492] usb 1-1: Product: USB2.0 Hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.816620] hub 1-1:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.816961] hub 1-1:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.890783] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.928765] brcmfmac: F1 signature read @0x18000000=0x15264345
Jan  1 00:00:01 buildroot kern.info kernel: [    0.934611] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.935130] usbcore: registered new interface driver brcmfmac
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985342] Bluetooth: Core ver 2.22
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985403] NET: Registered protocol family 31
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985424] Bluetooth: HCI device and connection manager initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985456] Bluetooth: HCI socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985482] Bluetooth: L2CAP socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.985507] Bluetooth: SCO socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.991957] Bluetooth: HCI UART driver ver 2.3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.991988] Bluetooth: HCI UART protocol H4 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.992058] Bluetooth: HCI UART protocol Three-wire (H5) registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.992230] Bluetooth: HCI UART protocol Broadcom registered
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.993692] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.993820] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.114414] uart-pl011 fe201000.serial: no DMA platform data
Jan  1 00:00:01 buildroot kern.info kernel: [    1.168912] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.169027] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.175834] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.281340] dwc2 fe980000.usb: supply vusb_d not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.281482] dwc2 fe980000.usb: supply vusb_a not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.362393] Bluetooth: hci0: BCM: chip id 107
Jan  1 00:00:01 buildroot kern.info kernel: [    1.362689] Bluetooth: hci0: BCM: features 0x2f
Jan  1 00:00:01 buildroot kern.info kernel: [    1.363789] Bluetooth: hci0: BCM4345C0
Jan  1 00:00:01 buildroot kern.info kernel: [    1.363814] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.368632] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch
Jan  1 00:00:01 buildroot kern.info kernel: [    1.501877] dwc2 fe980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502315] dwc2 fe980000.usb: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502357] dwc2 fe980000.usb: new USB bus registered, assigned bus number 3
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502403] dwc2 fe980000.usb: irq 37, io mem 0xfe980000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502582] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502612] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502638] usb usb3: Product: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502658] usb usb3: Manufacturer: Linux 5.10.92-v7l dwc2_hsotg
Jan  1 00:00:01 buildroot kern.info kernel: [    1.502679] usb usb3: SerialNumber: fe980000.usb
Jan  1 00:00:01 buildroot kern.info kernel: [    1.503232] hub 3-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    1.503281] hub 3-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot daemon.notice haveged: haveged starting up
Jan  1 00:00:01 buildroot daemon.info rngd: Initializing available sources
Jan  1 00:00:01 buildroot daemon.info rngd: [hwrng ]: Initialized
Jan  1 00:00:01 buildroot daemon.info rngd: [jitter]: JITTER timeout set to 5 sec
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.718723] random: dbus-uuidgen: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.718798] random: dbus-uuidgen: uninitialized urandom read (8 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.746046] random: dbus-daemon: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Bluetooth daemon 5.65
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Starting SDP server
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[163]: profiles/network/bnep.c:bnep_init() kernel lacks bnep-protocol support
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[163]: src/plugin.c:plugin_init() System does not support network plugin
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Bluetooth management interface 1.18 initialized
Jan  1 00:00:02 buildroot kern.info kernel: [    2.063604] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+
Jan  1 00:00:02 buildroot kern.info kernel: [    2.063648] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342
Jan  1 00:00:02 buildroot kern.info kernel: [    2.143471] NET: Registered protocol family 10
Jan  1 00:00:02 buildroot authpriv.info dropbear[191]: Running in background
Jan  1 00:00:02 buildroot kern.info kernel: [    2.152311] Segment Routing with IPv6
Jan  1 00:00:02 buildroot kern.info kernel: [    2.161358] NET: Registered protocol family 38
Jan  1 00:00:02 buildroot daemon.info dnsmasq[197]: started, version 2.89 cachesize 150
Jan  1 00:00:02 buildroot daemon.info dnsmasq[197]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP no-conntrack ipset no-nftset auth no-cryptohash no-DNSSEC loop-detect inotify dumpfile
Jan  1 00:00:02 buildroot daemon.info dnsmasq-dhcp[197]: DHCP, IP range 10.0.0.2 -- 10.0.0.20, lease time 12h
Jan  1 00:00:02 buildroot daemon.info dnsmasq[197]: read /etc/hosts - 2 names
Jan  1 00:00:02 buildroot kern.info kernel: [    2.276248] cryptd: max_cpu_qlen set to 1000
Jan  1 00:00:02 buildroot kern.notice kernel: [    2.371190] random: crng init done
Jan  1 00:00:02 buildroot kern.notice kernel: [    2.371228] random: 5 urandom warning(s) missed due to ratelimiting
Jan  1 00:00:02 buildroot daemon.info rngd: [jitter]: Initializing AES buffer
Jan  1 00:00:02 buildroot kern.info kernel: [    2.486511] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jan  1 00:00:02 buildroot kern.info kernel: [    2.496933] file system registered
Jan  1 00:00:02 buildroot kern.info kernel: [    2.532396] read descriptors
Jan  1 00:00:02 buildroot kern.info kernel: [    2.532436] read strings
Jan  1 00:00:03 buildroot kern.info kernel: [    3.525660] dwc2 fe980000.usb: bound driver configfs-gadget
Jan  1 00:00:03 buildroot user.info usb_gadget: Enabled default usb gadget
Jan  1 00:00:03 buildroot daemon.info : starting pid 284, tty '/dev/tty1': '/sbin/getty -L  tty1 0 vt100 '
Jan  1 00:00:06 buildroot daemon.info rngd: [jitter]: Unable to obtain AES key, disabling JITTER source
Jan  1 00:00:06 buildroot daemon.err rngd: [jitter]: Initialization Failed
Jan  1 00:00:30 buildroot kern.info kernel: [   30.551848] cam-dummy-reg: disabling
Jan  1 00:00:30 buildroot kern.info kernel: [   30.551884] cam1-reg: disabling
BluemediaGER commented 1 year ago

The main branch currently only activates bluetooth after the headunit initiates Android Auto connection, that is the headunit sends the accessory start command, and from your description that might not be happening.

The log looks exactly like this is what happens. The head unit doesn't even try to start Android Auto (by sending a accessory start request).

The main branch doesn't even activate Bluetooth, while the feature/device-ids branch activates Bluetooth, labeling it as "OnePlus Nord," but it doesn't accept connections.

@nisargjhaveri Looks like this head unit also needs "real" vendor and device IDs.

nisargjhaveri commented 1 year ago

Looks like this head unit also needs "real" vendor and device IDs.

Right, looks like it. Any idea if there are vendor and device IDs that we can use freely? Any idea on what some of the legitimate dongles are using?

nu00 commented 1 year ago

Right, looks like it. Any idea if there are vendor and device IDs that we can use freely? Any idea on what some of the legitimate dongles are using?

looking here (https://source.android.com/docs/core/interaction/accessories/aoa2) the only Product ID for Accessory Mode is 0x2D00. The device ID could be the Google one (0x18d1) since my phone (pixel 8) have the same and it works. Maybe is for the MTP part to be changed (for example use the Nexus/Pixel Device (MTP) 0x4ee1)? Should the headunit have the ability to look to files on the device in MTP? If so I don't think it's actually showing some files the rpi...

nu00 commented 1 year ago

I don't know if it's related, but connecting the rpi to my PC, windows give me an error (USB\DEVICE_DESCRIPTOR_FAILURE), and looking for the VID and PID it shows USB\VID_0000&PID_0002\5&86C20F0&0&2. Maybe this is the problem? Does the main fork start MTP at first?

BluemediaGER commented 1 year ago

Right, looks like it. Any idea if there are vendor and device IDs that we can use freely? Any idea on what some of the legitimate dongles are using?

Depends on what you define as "legitimate", I guess :D I tested two cheap ones from Amazon, and they both showed up as a Xiaomi phone on the head unit. For more expensive models like the Motorola MA1, my guess would be that they simply use their own IDs.

I don't know if it's related, but connecting the rpi to my PC, windows give me an error (USB\DEVICE_DESCRIPTOR_FAILURE), and looking for the VID and PID it shows USB\VID_0000&PID_0002\5&86C20F0&0&2. Maybe this is the problem? Does the main fork start MTP at first?

If this happens with the main branch of this repo, I would kind of expected that. It's not a real device, so Windows probably doesn't know how to handle it. My branch with the OnePlus device IDs shoud get detected by Windows just fine, but it will report in device manager that there are no drivers for it. It's enough to trick the head units into thinking that it is a MTP device. (Updated) I will do some more tests tomorrow. I might have an idea...

nu00 commented 1 year ago

Yes, I've tested your device-ids branch, and it displays the correct VID and PID in Windows. What I was thinking is that before entering gadget mode, it needs to be recognized as an MTP device with an MTP PID. Correct me if I'm wrong...

nisargjhaveri commented 1 year ago

Yeah, it does make sense that we need to use some well-known MTP vid/pid, I was misunderstanding something till now. We can use 18d1/4ee1, should work.

I've pushed a change in device_id branch. Have a look in case I missed anything. We can merge this in main soon, just that I don't have a way to test if these changes will work for these head units.

It is essentially the same change as https://github.com/BluemediaGER/AAWirelessDongle/commit/213d305d279ed38e79d3289ba93d7e1ec5c5052f except I've not changed the manufacturer and product name, I guess that should not be relevant. Also, I've changed the class/subclass/protocol for MTP interface to match better.

nu00 commented 1 year ago

I've tried the your device_id brach and it's still not working on my ATOTO, but we have some progress:

# cat /var/log/messages
Jan  1 00:00:01 buildroot syslog.info syslogd started: BusyBox v1.36.0
Jan  1 00:00:01 buildroot kern.notice kernel: klogd started: BusyBox v1.36.0 (2023-10-26 11:52:43 CEST)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Booting Linux on physical CPU 0x0
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Linux version 5.10.92-v7l [REDACTED]) (arm-buildroot-linux-gnueabihf-gcc.br_real (Buildroot 2023.02) 11.3.0, GNU ld (GNU Binutils) 2.38) #1 SMP Thu Oct 26 12:09:50 CEST 2023
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: div instructions available: patching division code
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: fast init done
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory policy: Data cache writealloc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Zone ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   Normal   empty
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   HighMem  [mem 0x0000000030000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Movable zone start for each node
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Early memory node ranges
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x0000000039bfffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] On node 0 totalpages: 1006592
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 1728 pages used for memmap
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 0 pages reserved
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 196608 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   HighMem zone: 809984 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] percpu: Embedded 15 pages/cpu s31628 r8192 d21620 u61440
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: s31628 r8192 d21620 u61440 alloc=15*4096
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1004864
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=0 bcm2708_fb.fbheight=0 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:46:60:BE vc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] software IO TLB: mapped [mem 0x0000000024890000-0x0000000028890000] (64MB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory: 3840468K/4026368K available (10240K kernel code, 731K rwdata, 2476K rodata, 2048K init, 567K
bss, 120364K reserved, 65536K cma-reserved, 3239936K highmem)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]      Tracing variant of Tasks RCU enabled.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x32c/0x500 with crng_init=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000036] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000099] bcm2835: system timer (irq = 25)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000692] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000712] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000733] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000749] Switching to timer-based delay loop, resolution 18ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000994] Console: colour dummy device 80x30
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001534] printk: console [tty1] enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001581] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001618] pid_max: default: 32768 minimum: 301
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001733] LSM: Security Framework initializing
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001804] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001838] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.002891] cgroup: Disabling memory control group subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003070] CPU: Testing write buffer coherency: ok
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003347] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003916] Setting up static identity map for 0x200000 - 0x20003c
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004026] rcu: Hierarchical SRCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004517] smp: Bringing up secondary CPUs ...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.005236] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006013] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006758] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006852] smp: Brought up 1 node, 4 CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006911] SMP: Total of 4 processors activated (432.00 BogoMIPS).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006932] CPU: All CPU(s) started in HYP mode.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006949] CPU: Virtualization extensions available.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.007523] devtmpfs: initializedJan  1 00:00:01 buildroot kern.info kernel: [    0.018365] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018543] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018582] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020250] pinctrl core: initialized pinctrl subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020915] NET: Registered protocol family 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.022999] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jan  1 00:00:01 buildroot kern.info kernel: [    0.023656] audit: initializing netlink subsys (disabled)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024246] thermal_sys: Registered thermal governor 'step_wise'
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.024474] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024605] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024631] hw-breakpoint: maximum watchpoint size is 8 bytes.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024944] Serial: AMBA PL011 UART driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.040786] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.060741] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-17T19:20:34, variant start
Jan  1 00:00:01 buildroot kern.info kernel: [    0.070744] raspberrypi-firmware soc:firmware: Firmware hash is bd34f55ef7b01b0a367f131060b561a2a58b80bb
Jan  1 00:00:01 buildroot kern.info kernel: [    0.104349] Kprobes globally optimized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.107320] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.109645] vgaarb: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.110020] SCSI subsystem initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110206] usbcore: registered new interface driver usbfs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110265] usbcore: registered new interface driver hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110321] usbcore: registered new device driver usb
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.110481] usb_phy_generic phy: supply vcc not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    0.111791] clocksource: Switched to clocksource arch_sys_counter
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.111999] VFS: Disk quotas dquot_6.6.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112070] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.112185] FS-Cache: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112327] CacheFiles: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119598] NET: Registered protocol family 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119809] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121266] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121318] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121387] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121461] TCP: Hash tables configured (established 8192 bind 8192)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121587] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121631] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121824] NET: Registered protocol family 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122271] RPC: Registered named UNIX socket transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122294] RPC: Registered udp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122313] RPC: Registered tcp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122332] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122358] PCI: CLS 0 bytes, default 64
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.123504] Initialise system trusted keyrings
Jan  1 00:00:01 buildroot kern.info kernel: [    0.123642] workingset: timestamp_bits=14 max_order=20 bucket_order=6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.128272] zbud: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129411] FS-Cache: Netfs 'nfs' registered for caching
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129874] NFS: Registering the id_resolver key type
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129908] Key type id_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129927] Key type id_legacy registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130031] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130054] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130769] Key type asymmetric registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130791] Asymmetric key parser 'x509' registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130867] bounce: pool size: 64 pages
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130919] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131057] io scheduler mq-deadline registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131079] io scheduler kyber registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133320] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133360] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133412] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133464] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.193874] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194080] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194108] pci_bus 0000:00: root bus resource [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194134] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194199] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194300] pci 0000:00:00.0: PME# supported from D0 D3hot
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197282] PCI: bus0: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197496] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197600] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197880] pci 0000:01:00.0: PME# supported from D0 D3cold
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200839] PCI: bus1: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200890] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200919] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200997] pci 0000:00:00.0: PCI bridge to [bus 01]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201021] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201225] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201376] pcieport 0000:00:00.0: PME: Signaling with IRQ 63
Jan  1 00:00:01 buildroot kern.err kernel: [    0.201892] bcm2708_fb soc:fb: Unable to determine number of FBs. Disabling driver.
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.201930] bcm2708_fb: probe of soc:fb failed with error -2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.205902] iproc-rng200 fe104000.rng: hwrng registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206059] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206695] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.214920] brd: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.219986] loop: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.220955] Loading iSCSI transport class v2.0-870.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.223388] libphy: Fixed MDIO Bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.224389] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.241805] libphy: bcmgenet MII bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.331864] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332742] usbcore: registered new interface driver r8152
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332816] usbcore: registered new interface driver lan78xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332878] usbcore: registered new interface driver smsc95xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334261] xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334391] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.334431] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336388] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336865] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336895] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336921] usb usb1: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336941] usb usb1: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336961] usb usb1: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337473] hub 1-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337555] hub 1-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.337995] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338028] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338060] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338331] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338360] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338386] usb usb2: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338405] usb usb2: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338426] usb usb2: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338886] hub 2-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.338937] hub 2-0:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339970] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340092] dwc_otg: FIQ enabledJan  1 00:00:01 buildroot kern.debug kernel: [    0.340101] dwc_otg: NAK holdoff enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340109] dwc_otg: FIQ split-transaction FSM enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.340120] Module dwc_common_port init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340387] usbcore: registered new interface driver uas
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340481] usbcore: registered new interface driver usb-storage
Jan  1 00:00:01 buildroot kern.info kernel: [    0.340643] mousedev: PS/2 mouse device common for all mice
Jan  1 00:00:01 buildroot kern.info kernel: [    0.341471] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jan  1 00:00:01 buildroot kern.info kernel: [    0.343928] sdhci: Secure Digital Host Controller Interface driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.343951] sdhci: Copyright(c) Pierre Ossman
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344326] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Jan  1 00:00:01 buildroot kern.info kernel: [    0.344579] sdhci-pltfm: SDHCI platform and OF driver helper
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347369] ledtrig-cpu: registered to indicate activity on CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347633] hid: raw HID events driver (C) Jiri Kosina
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347738] usbcore: registered new interface driver usbhid
Jan  1 00:00:01 buildroot kern.info kernel: [    0.347768] usbhid: USB HID core driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351109] Initializing XFRM netlink socket
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351146] NET: Registered protocol family 17
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351235] Key type dns_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351336] Registering SWP/SWPB emulation handler
Jan  1 00:00:01 buildroot kern.info kernel: [    0.351392] registered taskstats version 1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351416] Loading compiled-in X.509 certificates
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351826] Key type ._fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351848] Key type .fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.351867] Key type fscrypt-provisioning registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353355] uart-pl011 fe201000.serial: there is not valid maps for state default
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353531] uart-pl011 fe201000.serial: cts_event_workaround enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353597] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.353777] serial serial0: tty port ttyAMA0 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.359856] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.360386] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.360410] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Jan  1 00:00:01 buildroot kern.info kernel: [    0.387722] of_cfs_init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.387919] of_cfs_init: OK
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.407987] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.409544] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.411101] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.413896] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.415466] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.424478] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Jan  1 00:00:01 buildroot kern.info kernel: [    0.424920] Waiting for root device /dev/mmcblk0p2...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.477584] mmc1: new high speed SDIO card at address 0001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.527473] mmc0: new ultra high speed DDR50 SDHC card at address 5048
Jan  1 00:00:01 buildroot kern.info kernel: [    0.528078] mmcblk0: mmc0:5048 SD32G 29.7 GiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.529470]  mmcblk0: p1 p2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.546877] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.546950] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.547470] devtmpfs: mounted
Jan  1 00:00:01 buildroot kern.info kernel: [    0.549972] Freeing unused kernel memory: 2048K
Jan  1 00:00:01 buildroot kern.info kernel: [    0.582082] Run /sbin/init as init process
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582103]   with arguments:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582111]     /sbin/init
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582118]   with environment:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582126]     HOME=/
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582134]     TERM=linux
Jan  1 00:00:01 buildroot kern.info kernel: [    0.621839] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.662428] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.756009] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jan  1 00:00:01 buildroot kern.info kernel: [    0.824448] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Jan  1 00:00:01 buildroot kern.info kernel: [    0.824487] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.824512] usb 1-1: Product: USB2.0 Hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.826194] hub 1-1:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.826469] hub 1-1:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.859480] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.898425] brcmfmac: F1 signature read @0x18000000=0x15264345
Jan  1 00:00:01 buildroot kern.info kernel: [    0.903909] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.904422] usbcore: registered new interface driver brcmfmac
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953181] Bluetooth: Core ver 2.22
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953238] NET: Registered protocol family 31
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953258] Bluetooth: HCI device and connection manager initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953290] Bluetooth: HCI socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953314] Bluetooth: L2CAP socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.953337] Bluetooth: SCO socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.960023] Bluetooth: HCI UART driver ver 2.3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.960054] Bluetooth: HCI UART protocol H4 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.960128] Bluetooth: HCI UART protocol Three-wire (H5) registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.960529] Bluetooth: HCI UART protocol Broadcom registered
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.961754] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.961907] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.067559] uart-pl011 fe201000.serial: no DMA platform data
Jan  1 00:00:01 buildroot kern.info kernel: [    1.147428] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.147547] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.154414] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.229600] dwc2 fe980000.usb: supply vusb_d not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.229742] dwc2 fe980000.usb: supply vusb_a not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.302359] Bluetooth: hci0: BCM: chip id 107
Jan  1 00:00:01 buildroot kern.info kernel: [    1.302650] Bluetooth: hci0: BCM: features 0x2f
Jan  1 00:00:01 buildroot kern.info kernel: [    1.303766] Bluetooth: hci0: BCM4345C0
Jan  1 00:00:01 buildroot kern.info kernel: [    1.303792] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.306408] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch
Jan  1 00:00:01 buildroot kern.info kernel: [    1.451889] dwc2 fe980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452371] dwc2 fe980000.usb: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452427] dwc2 fe980000.usb: new USB bus registered, assigned bus number 3
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452488] dwc2 fe980000.usb: irq 37, io mem 0xfe980000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452758] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452800] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452826] usb usb3: Product: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452847] usb usb3: Manufacturer: Linux 5.10.92-v7l dwc2_hsotg
Jan  1 00:00:01 buildroot kern.info kernel: [    1.452867] usb usb3: SerialNumber: fe980000.usb
Jan  1 00:00:01 buildroot kern.info kernel: [    1.453492] hub 3-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    1.453558] hub 3-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot daemon.notice haveged: haveged starting up
Jan  1 00:00:01 buildroot daemon.info rngd: Initializing available sources
Jan  1 00:00:01 buildroot daemon.info rngd: [hwrng ]: Initialized
Jan  1 00:00:01 buildroot daemon.info rngd: [jitter]: JITTER timeout set to 5 sec
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.652363] random: dbus-uuidgen: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.652437] random: dbus-uuidgen: uninitialized urandom read (8 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.679177] random: dbus-daemon: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot daemon.info bluetoothd[160]: Bluetooth daemon 5.65
Jan  1 00:00:01 buildroot daemon.info bluetoothd[160]: Starting SDP server
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[160]: profiles/network/bnep.c:bnep_init() kernel lacks bnep-protocol support
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[160]: src/plugin.c:plugin_init() System does not support network plugin
Jan  1 00:00:01 buildroot daemon.info bluetoothd[160]: Bluetooth management interface 1.18 initialized
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.908605] random: crng init done
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.908640] random: 3 urandom warning(s) missed due to ratelimiting
Jan  1 00:00:01 buildroot kern.info kernel: [    1.993592] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+
Jan  1 00:00:01 buildroot kern.info kernel: [    1.993634] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342
Jan  1 00:00:02 buildroot kern.info kernel: [    2.077063] NET: Registered protocol family 38
Jan  1 00:00:02 buildroot kern.info kernel: [    2.152300] cryptd: max_cpu_qlen set to 1000
Jan  1 00:00:02 buildroot kern.info kernel: [    2.166936] NET: Registered protocol family 10
Jan  1 00:00:02 buildroot authpriv.info dropbear[203]: Running in background
Jan  1 00:00:02 buildroot kern.info kernel: [    2.178430] Segment Routing with IPv6
Jan  1 00:00:02 buildroot daemon.info dnsmasq[207]: started, version 2.89 cachesize 150
Jan  1 00:00:02 buildroot daemon.info dnsmasq[207]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP no-conntrack ipset no-nftset auth no-cryptohash no-DNSSEC loop-detect inotify dumpfile
Jan  1 00:00:02 buildroot daemon.info dnsmasq-dhcp[207]: DHCP, IP range 10.0.0.2 -- 10.0.0.20, lease time 12h
Jan  1 00:00:02 buildroot daemon.info dnsmasq[207]: read /etc/hosts - 2 names
Jan  1 00:00:02 buildroot kern.info kernel: [    2.440452] file system registered
Jan  1 00:00:02 buildroot kern.info kernel: [    2.470743] read descriptors
Jan  1 00:00:02 buildroot kern.info kernel: [    2.470784] read strings
Jan  1 00:00:02 buildroot daemon.info rngd: [jitter]: Initializing AES buffer
Jan  1 00:00:03 buildroot user.info usb_gadget: Enabled default usb gadget
Jan  1 00:00:03 buildroot daemon.info : starting pid 259, tty '/dev/tty1': '/sbin/getty -L  tty1 0 vt100 '
Jan  1 00:00:03 buildroot user.info aawgd[258]: AA Wireless Dongle
Jan  1 00:00:03 buildroot user.info aawgd[258]: Starting uevent monitoring
Jan  1 00:00:03 buildroot user.info aawgd[258]: Uevent monitoring started
Jan  1 00:00:03 buildroot user.info aawgd[258]: Initializing USB Manager
Jan  1 00:00:03 buildroot user.info aawgd[258]: USB Manager: Disabled all USB gadgets
Jan  1 00:00:03 buildroot user.info aawgd[258]: USB Manager: Found UDC fe980000.usb
Jan  1 00:00:03 buildroot user.info aawgd[258]: Unique Name: :1.2
Jan  1 00:00:03 buildroot user.info aawgd[258]: Using bluetooth adapter at path: /org/bluez/hci0
Jan  1 00:00:03 buildroot user.info aawgd[258]: Bluetooth AA Wireless profile active
Jan  1 00:00:03 buildroot user.info aawgd[258]: HSP Handset profile active
Jan  1 00:00:03 buildroot kern.info kernel: [    3.721851] Bluetooth: RFCOMM TTY layer initialized
Jan  1 00:00:03 buildroot kern.info kernel: [    3.721902] Bluetooth: RFCOMM socket layer initialized
Jan  1 00:00:03 buildroot kern.info kernel: [    3.721924] Bluetooth: RFCOMM ver 1.11
Jan  1 00:00:03 buildroot kern.info kernel: [    3.729626] dwc2 fe980000.usb: bound driver configfs-gadget
Jan  1 00:00:03 buildroot user.info aawgd[258]: USB Manager: Enabled default gadget
Jan  1 00:00:03 buildroot kern.info kernel: [    3.785009] dwc2 fe980000.usb: new device is high-speed
Jan  1 00:00:03 buildroot kern.info kernel: [    3.955113] android_work: sent uevent USB_STATE=CONNECTED
Jan  1 00:00:04 buildroot kern.info kernel: [    4.014984] dwc2 fe980000.usb: new device is high-speed
Jan  1 00:00:04 buildroot kern.info kernel: [    4.075029] dwc2 fe980000.usb: new address 2
Jan  1 00:00:04 buildroot kern.info kernel: [    4.098186] android_work: sent uevent USB_STATE=CONFIGURED
Jan  1 00:00:06 buildroot daemon.info rngd: [jitter]: Unable to obtain AES key,
disabling JITTER source
Jan  1 00:00:06 buildroot daemon.err rngd: [jitter]: Initialization Failed
Jan  1 00:00:30 buildroot kern.info kernel: [   30.551821] cam-dummy-reg: disabling

It says USB_STATE=CONNECTED and USB_STATE=CONFIGURED, something has changed..... Still, I don't get anything on the headunit... Note that, since it's a new build, I've remove the bluetooth connection on my phone. I've also tried on the peugeot and it still works as before

nisargjhaveri commented 1 year ago

while the feature/device-ids branch activates Bluetooth, labeling it as "OnePlus Nord," but it doesn't accept connections.

This is interesting. Can you please share the logs with feature/device-ids branch from @BluemediaGER's fork as well?

nu00 commented 1 year ago

Tomorrow I will do it, since I've to build it again. It's possible that, since I've done that test at work in the parking lot during lunch break, that was someone's phone passing by and coincidentally it only showed up when I had the rpi plugged in...

nu00 commented 1 year ago

Ok, it was just a coincidence. Just tried and it dosen't bring Bluetooth up.

Here the logs:


# cat /var/log/messages
Jan  1 00:00:01 buildroot syslog.info syslogd started: BusyBox v1.36.0
Jan  1 00:00:01 buildroot kern.notice kernel: klogd started: BusyBox v1.36.0 (2023-10-23 23:50:28 CEST)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Booting Linux on physical CPU 0x0
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Linux version 5.10.92-v7l ([REDACTED]) (arm-buildroot-linux-gnueabihf-gcc.br_real (Buildroot 2023.02) 11.3.0, GNU ld (GNU Binutils) 2.38) #1 SMP Tue Oct 24 00:07:51 CEST 2023
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: div instructions available: patching division code
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: fast init done
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory policy: Data cache writealloc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Zone ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   Normal   empty
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   HighMem  [mem 0x0000000030000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Movable zone start for each node
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Early memory node ranges
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x0000000039bfffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] On node 0 totalpages: 1006592
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 1728 pages used for memmap
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 0 pages reserved
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   DMA zone: 196608 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000]   HighMem zone: 809984 pages, LIFO batch:63
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] percpu: Embedded 15 pages/cpu s31628 r8192 d21620 u61440
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: s31628 r8192 d21620 u61440 alloc=15*4096
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1004864
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=0 bcm2708_fb.fbheight=0 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:46:60:BE vc
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] software IO TLB: mapped [mem 0x0000000024890000-0x0000000028890000] (64MB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] Memory: 3840468K/4026368K available (10240K kernel code, 731K rwdata, 2476K rodata, 2048K init, 567K bss, 120364K reserved, 65536K cma-reserved, 3239936K highmem)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000]      Tracing variant of Tasks RCU enabled.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x32c/0x500 with crng_init=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000036] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000097] bcm2835: system timer (irq = 25)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000693] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000713] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000733] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000749] Switching to timer-based delay loop, resolution 18ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.000993] Console: colour dummy device 80x30
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001533] printk: console [tty1] enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001580] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001617] pid_max: default: 32768 minimum: 301
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001732] LSM: Security Framework initializing
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001803] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.001837] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.002900] cgroup: Disabling memory control group subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003083] CPU: Testing write buffer coherency: ok
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003358] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.003930] Setting up static identity map for 0x200000 - 0x20003c
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004040] rcu: Hierarchical SRCU implementation.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.004533] smp: Bringing up secondary CPUs ...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.005259] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006040] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006795] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006890] smp: Brought up 1 node, 4 CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006948] SMP: Total of 4 processors activated (432.00 BogoMIPS).
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006969] CPU: All CPU(s) started in HYP mode.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.006986] CPU: Virtualization extensions available.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.007565] devtmpfs: initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018398] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018573] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan  1 00:00:01 buildroot kern.info kernel: [    0.018613] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020290] pinctrl core: initialized pinctrl subsystem
Jan  1 00:00:01 buildroot kern.info kernel: [    0.020954] NET: Registered protocol family 16
Jan  1 00:00:01 buildroot kern.info kernel: [    0.022958] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jan  1 00:00:01 buildroot kern.info kernel: [    0.023612] audit: initializing netlink subsys (disabled)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024196] thermal_sys: Registered thermal governor 'step_wise'
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.024425] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024556] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024582] hw-breakpoint: maximum watchpoint size is 8 bytes.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.024894] Serial: AMBA PL011 UART driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.040734] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.060738] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-17T19:20:34, variant start
Jan  1 00:00:01 buildroot kern.info kernel: [    0.070742] raspberrypi-firmware soc:firmware: Firmware hash is bd34f55ef7b01b0a367f131060b561a2a58b80bb
Jan  1 00:00:01 buildroot kern.info kernel: [    0.104350] Kprobes globally optimized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.107289] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.109613] vgaarb: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.109989] SCSI subsystem initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110171] usbcore: registered new interface driver usbfs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110230] usbcore: registered new interface driver hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.110285] usbcore: registered new device driver usb
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.110444] usb_phy_generic phy: supply vcc not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    0.111770] clocksource: Switched to clocksource arch_sys_counter
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.111978] VFS: Disk quotas dquot_6.6.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112049] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.112163] FS-Cache: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.112303] CacheFiles: Loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119569] NET: Registered protocol family 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.119777] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121236] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121289] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121358] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121431] TCP: Hash tables configured (established 8192 bind 8192)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121556] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121600] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.121795] NET: Registered protocol family 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122253] RPC: Registered named UNIX socket transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122277] RPC: Registered udp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122296] RPC: Registered tcp transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122314] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.122341] PCI: CLS 0 bytes, default 64
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.123488] Initialise system trusted keyrings
Jan  1 00:00:01 buildroot kern.info kernel: [    0.123621] workingset: timestamp_bits=14 max_order=20 bucket_order=6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.128247] zbud: loaded
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129384] FS-Cache: Netfs 'nfs' registered for caching
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129846] NFS: Registering the id_resolver key type
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129880] Key type id_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.129899] Key type id_legacy registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130002] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130025] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130731] Key type asymmetric registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.130753] Asymmetric key parser 'x509' registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130830] bounce: pool size: 64 pages
Jan  1 00:00:01 buildroot kern.info kernel: [    0.130882] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131016] io scheduler mq-deadline registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.131037] io scheduler kyber registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133271] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133311] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133360] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.133412] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.193854] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194060] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194087] pci_bus 0000:00: root bus resource [bus 00-ff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194113] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194179] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Jan  1 00:00:01 buildroot kern.info kernel: [    0.194279] pci 0000:00:00.0: PME# supported from D0 D3hot
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197255] PCI: bus0: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197470] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197574] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.197854] pci 0000:01:00.0: PME# supported from D0 D3cold
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200792] PCI: bus1: Fast back to back transfers disabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200843] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200873] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200950] pci 0000:00:00.0: PCI bridge to [bus 01]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.200975] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201177] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.201330] pcieport 0000:00:00.0: PME: Signaling with IRQ 63
Jan  1 00:00:01 buildroot kern.err kernel: [    0.201844] bcm2708_fb soc:fb: Unable to determine number of FBs. Disabling driver.
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.201882] bcm2708_fb: probe of soc:fb failed with error -2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.205847] iproc-rng200 fe104000.rng: hwrng registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206004] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.206642] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.214774] brd: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.219810] loop: module loaded
Jan  1 00:00:01 buildroot kern.info kernel: [    0.220782] Loading iSCSI transport class v2.0-870.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.223220] libphy: Fixed MDIO Bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.224217] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Jan  1 00:00:01 buildroot kern.info kernel: [    0.241789] libphy: bcmgenet MII bus: probed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.321867] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Jan  1 00:00:01 buildroot kern.info kernel: [    0.322743] usbcore: registered new interface driver r8152
Jan  1 00:00:01 buildroot kern.info kernel: [    0.322816] usbcore: registered new interface driver lan78xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.322878] usbcore: registered new interface driver smsc95xx
Jan  1 00:00:01 buildroot kern.info kernel: [    0.324270] xhci_hcd 0000:01:00.0: enabling device (0140 -> 0142)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.324402] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.324442] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326381] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x00000e0000000890
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326856] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326887] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326913] usb usb1: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326933] usb usb1: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.326953] usb usb1: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.327469] hub 1-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.327550] hub 1-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.327986] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328019] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328051] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328323] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328352] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328377] usb usb2: Product: xHCI Host Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328397] usb usb2: Manufacturer: Linux 5.10.92-v7l xhci-hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328417] usb usb2: SerialNumber: 0000:01:00.0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328876] hub 2-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.328927] hub 2-0:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.info kernel: [    0.329966] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.330087] dwc_otg: FIQ enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.330096] dwc_otg: NAK holdoff enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.330104] dwc_otg: FIQ split-transaction FSM enabled
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.330115] Module dwc_common_port init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.330386] usbcore: registered new interface driver uas
Jan  1 00:00:01 buildroot kern.info kernel: [    0.330479] usbcore: registered new interface driver usb-storage
Jan  1 00:00:01 buildroot kern.info kernel: [    0.330643] mousedev: PS/2 mouse device common for all mice
Jan  1 00:00:01 buildroot kern.info kernel: [    0.331479] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332450] sdhci: Secure Digital Host Controller Interface driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332473] sdhci: Copyright(c) Pierre Ossman
Jan  1 00:00:01 buildroot kern.info kernel: [    0.332845] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
Jan  1 00:00:01 buildroot kern.info kernel: [    0.333100] sdhci-pltfm: SDHCI platform and OF driver helper
Jan  1 00:00:01 buildroot kern.info kernel: [    0.335872] ledtrig-cpu: registered to indicate activity on CPUs
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336137] hid: raw HID events driver (C) Jiri Kosina
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336244] usbcore: registered new interface driver usbhid
Jan  1 00:00:01 buildroot kern.info kernel: [    0.336275] usbhid: USB HID core driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339600] Initializing XFRM netlink socket
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339638] NET: Registered protocol family 17
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.339732] Key type dns_resolver registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.339833] Registering SWP/SWPB emulation handler
Jan  1 00:00:01 buildroot kern.info kernel: [    0.339889] registered taskstats version 1
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.339912] Loading compiled-in X.509 certificates
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.340291] Key type ._fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.340312] Key type .fscrypt registered
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.340331] Key type fscrypt-provisioning registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.341901] uart-pl011 fe201000.serial: there is not valid maps for state default
Jan  1 00:00:01 buildroot kern.info kernel: [    0.342074] uart-pl011 fe201000.serial: cts_event_workaround enabled
Jan  1 00:00:01 buildroot kern.info kernel: [    0.342140] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.342321] serial serial0: tty port ttyAMA0 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.349612] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jan  1 00:00:01 buildroot kern.info kernel: [    0.350142] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.350167] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Jan  1 00:00:01 buildroot kern.info kernel: [    0.375311] of_cfs_init
Jan  1 00:00:01 buildroot kern.info kernel: [    0.375488] of_cfs_init: OK
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.397979] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.399539] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.401093] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.403889] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.405455] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.414458] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Jan  1 00:00:01 buildroot kern.info kernel: [    0.414905] Waiting for root device /dev/mmcblk0p2...
Jan  1 00:00:01 buildroot kern.info kernel: [    0.467577] mmc1: new high speed SDIO card at address 0001
Jan  1 00:00:01 buildroot kern.info kernel: [    0.517468] mmc0: new ultra high speed DDR50 SDHC card at address 5048
Jan  1 00:00:01 buildroot kern.info kernel: [    0.518063] mmcblk0: mmc0:5048 SD32G 29.7 GiB
Jan  1 00:00:01 buildroot kern.info kernel: [    0.519454]  mmcblk0: p1 p2
Jan  1 00:00:01 buildroot kern.info kernel: [    0.546595] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan  1 00:00:01 buildroot kern.info kernel: [    0.546669] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Jan  1 00:00:01 buildroot kern.info kernel: [    0.547140] devtmpfs: mounted
Jan  1 00:00:01 buildroot kern.info kernel: [    0.549653] Freeing unused kernel memory: 2048K
Jan  1 00:00:01 buildroot kern.info kernel: [    0.582076] Run /sbin/init as init process
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582098]   with arguments:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582106]     /sbin/init
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582114]   with environment:
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582122]     HOME=/
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.582129]     TERM=linux
Jan  1 00:00:01 buildroot kern.info kernel: [    0.611833] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Jan  1 00:00:01 buildroot kern.info kernel: [    0.662461] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.756020] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jan  1 00:00:01 buildroot kern.info kernel: [    0.794482] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Jan  1 00:00:01 buildroot kern.info kernel: [    0.794523] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jan  1 00:00:01 buildroot kern.info kernel: [    0.794547] usb 1-1: Product: USB2.0 Hub
Jan  1 00:00:01 buildroot kern.info kernel: [    0.796233] hub 1-1:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    0.796579] hub 1-1:1.0: 4 ports detected
Jan  1 00:00:01 buildroot kern.notice kernel: [    0.859244] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jan  1 00:00:01 buildroot kern.debug kernel: [    0.903444] brcmfmac: F1 signature read @0x18000000=0x15264345
Jan  1 00:00:01 buildroot kern.info kernel: [    0.909238] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    0.909777] usbcore: registered new interface driver brcmfmac
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961116] Bluetooth: Core ver 2.22
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961171] NET: Registered protocol family 31
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961192] Bluetooth: HCI device and connection manager initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961225] Bluetooth: HCI socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961249] Bluetooth: L2CAP socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.961273] Bluetooth: SCO socket layer initialized
Jan  1 00:00:01 buildroot kern.info kernel: [    0.967831] Bluetooth: HCI UART driver ver 2.3
Jan  1 00:00:01 buildroot kern.info kernel: [    0.967864] Bluetooth: HCI UART protocol H4 registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.967937] Bluetooth: HCI UART protocol Three-wire (H5) registered
Jan  1 00:00:01 buildroot kern.info kernel: [    0.968102] Bluetooth: HCI UART protocol Broadcom registered
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.969579] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    0.969750] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.090383] uart-pl011 fe201000.serial: no DMA platform data
Jan  1 00:00:01 buildroot kern.info kernel: [    1.151507] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.151624] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 00:00:01 buildroot kern.info kernel: [    1.158482] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.258556] dwc2 fe980000.usb: supply vusb_d not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.warn kernel: [    1.258697] dwc2 fe980000.usb: supply vusb_a not found, using dummy regulator
Jan  1 00:00:01 buildroot kern.info kernel: [    1.342358] Bluetooth: hci0: BCM: chip id 107
Jan  1 00:00:01 buildroot kern.info kernel: [    1.342658] Bluetooth: hci0: BCM: features 0x2f
Jan  1 00:00:01 buildroot kern.info kernel: [    1.343762] Bluetooth: hci0: BCM4345C0
Jan  1 00:00:01 buildroot kern.info kernel: [    1.343788] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.348624] Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch
Jan  1 00:00:01 buildroot kern.info kernel: [    1.471840] dwc2 fe980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472200] dwc2 fe980000.usb: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472242] dwc2 fe980000.usb: new USB bus registered, assigned bus number 3
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472288] dwc2 fe980000.usb: irq 37, io mem 0xfe980000
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472475] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472505] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472531] usb usb3: Product: DWC OTG Controller
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472551] usb usb3: Manufacturer: Linux 5.10.92-v7l dwc2_hsotg
Jan  1 00:00:01 buildroot kern.info kernel: [    1.472572] usb usb3: SerialNumber: fe980000.usb
Jan  1 00:00:01 buildroot kern.info kernel: [    1.473089] hub 3-0:1.0: USB hub found
Jan  1 00:00:01 buildroot kern.info kernel: [    1.473138] hub 3-0:1.0: 1 port detected
Jan  1 00:00:01 buildroot daemon.notice haveged: haveged starting up
Jan  1 00:00:01 buildroot daemon.info rngd: Initializing available sources
Jan  1 00:00:01 buildroot daemon.info rngd: [hwrng ]: Initialized
Jan  1 00:00:01 buildroot daemon.info rngd: [jitter]: JITTER timeout set to 5 sec
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.677534] random: dbus-uuidgen: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.677610] random: dbus-uuidgen: uninitialized urandom read (8 bytes read)
Jan  1 00:00:01 buildroot kern.notice kernel: [    1.704880] random: dbus-daemon: uninitialized urandom read (12 bytes read)
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Bluetooth daemon 5.65
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Starting SDP server
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[163]: profiles/network/bnep.c:bnep_init() kernel lacks bnep-protocol support
Jan  1 00:00:01 buildroot daemon.warn bluetoothd[163]: src/plugin.c:plugin_init() System does not support network plugin
Jan  1 00:00:01 buildroot daemon.info bluetoothd[163]: Bluetooth management interface 1.18 initialized
Jan  1 00:00:02 buildroot kern.info kernel: [    2.043593] Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+
Jan  1 00:00:02 buildroot kern.info kernel: [    2.043637] Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342
Jan  1 00:00:02 buildroot kern.info kernel: [    2.113425] NET: Registered protocol family 10
Jan  1 00:00:02 buildroot authpriv.info dropbear[194]: Running in background
Jan  1 00:00:02 buildroot kern.info kernel: [    2.122561] Segment Routing with IPv6
Jan  1 00:00:02 buildroot kern.info kernel: [    2.127772] NET: Registered protocol family 38
Jan  1 00:00:02 buildroot daemon.info dnsmasq[201]: started, version 2.89 cachesize 150
Jan  1 00:00:02 buildroot daemon.info dnsmasq[201]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP no-conntrack ipset no-nftset auth no-cryptohash no-DNSSEC loop-detect inotify dumpfile
Jan  1 00:00:02 buildroot daemon.info dnsmasq-dhcp[201]: DHCP, IP range 10.0.0.2 -- 10.0.0.20, lease time 12h
Jan  1 00:00:02 buildroot daemon.info dnsmasq[201]: read /etc/hosts - 2 names
Jan  1 00:00:02 buildroot kern.info kernel: [    2.242177] cryptd: max_cpu_qlen set to 1000
Jan  1 00:00:02 buildroot kern.notice kernel: [    2.306880] random: crng init done
Jan  1 00:00:02 buildroot kern.notice kernel: [    2.306917] random: 5 urandom warning(s) missed due to ratelimiting
Jan  1 00:00:02 buildroot kern.info kernel: [    2.422666] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jan  1 00:00:02 buildroot kern.info kernel: [    2.424708] file system registered
Jan  1 00:00:02 buildroot kern.info kernel: [    2.464793] read descriptors
Jan  1 00:00:02 buildroot kern.info kernel: [    2.464884] read strings
Jan  1 00:00:02 buildroot daemon.info rngd: [jitter]: Initializing AES buffer
Jan  1 00:00:03 buildroot user.info usb_gadget: Enabled default usb gadget
Jan  1 00:00:03 buildroot kern.info kernel: [    3.451896] dwc2 fe980000.usb: bound driver configfs-gadget
Jan  1 00:00:03 buildroot daemon.info : starting pid 288, tty '/dev/tty1': '/sbin/getty -L  tty1 0 vt100 '
Jan  1 00:00:06 buildroot daemon.info rngd: [jitter]: Unable to obtain AES key, disabling JITTER source
Jan  1 00:00:06 buildroot daemon.err rngd: [jitter]: Initialization Failed
Jan  1 00:00:30 buildroot kern.info kernel: [   30.551798] cam-dummy-reg: disabling
Jan  1 00:00:30 buildroot kern.info kernel: [   30.551835] cam1-reg: disabling
nu00 commented 1 year ago

I was thinking: is there any way to sniff the USB traffic between my phone and the head unit? This way, we can better understand what's happening. Do you have any ideas on how to do it?

gamelaster commented 1 year ago

@nu00 for that, you need to have hardware level USB packet sniffer, I don't know about any cheap one. 150$ for Cynthion. But I don't think you need this. The communication is known.

BTW @nu00 Do you still have that Windows USB descriptor issue? Because that would then give a sense why it is problematic.

nu00 commented 1 year ago

No,with @BluemediaGER branch features/device-id in windows it shows up as USB\VID_22D9&PID_2764&REV_0510, but with the device-ids branche of the main build by @nisargjhaveri it shows up as USB\VID_1D6B&PID_0105\0 that are not the 18d1 and 4ee1 @nisargjhaveri set in S92usb_gadget

nisargjhaveri commented 1 year ago

I was thinking: is there any way to sniff the USB traffic between my phone and the head unit? This way, we can better understand what's happening. Do you have any ideas on how to do it?

You may be able to use https://github.com/AristoChen/usb-proxy on a RPi4. I had used it once for something with some modifications. Thought this can be slightly tricky since for AA as the usb resets in the middle and you need to restart the proxy.

We do know how the communication is supposed to happen, but since it is not working on your head unit, might help to know what we're missing.

but with the device-ids branche of the main build by @nisargjhaveri it shows up as USB\VID_1D6B&PID_0105\0 that are not the 18d1 and 4ee1 @nisargjhaveri set in S92usb_gadget

Are you sure the build went through correctly, 1D6B/0105 is the one we're using in the main branch. Also, you might not need a full rebuild, just ssh into RPi and you can make the same changes as ca7859b2e49b1d30afe32467775b2f6caa5ed7e3 directly.

nu00 commented 1 year ago

Okay, something went wrong with the build, so I manually applied the changes from commit ca7859b, and now Windows shows USB\VID_18D1&PID_4EE1\0123456. I'll let my laptop charge up a bit, and then I'm going to try it. EDIT: just noticed that Windows detect the rpi as an MTP device and let's browse it's content (there is anything but it sounds promising ✌️)

nu00 commented 1 year ago

You may be able to use https://github.com/AristoChen/usb-proxy on a RPi4. I had used it once for something with some modifications. Thought this can be slightly tricky since for AA as the usb resets in the middle and you need to restart the proxy.

We do know how the communication is supposed to happen, but since it is not working on your head unit, might help to know what we're missing.

I'm going to give it a try tomorrow, at least we know what's going up...

nu00 commented 1 year ago

@nisargjhaveri, I tried it with the changes from commit ca7859b, and IT WORKS! I apologize for my incompetence with the building; these kinds of projects are new to me, and I'm trying to learn new things. Also, thank you for your work; I've tested it for a while, and I didn't notice any lags in general. I'm going to keep it plugged into my car and try it in the coming days. I'll let you know if something doesn't work.

nisargjhaveri commented 1 year ago

That's great news! I've merged the device_id branch to main now as well.

nu00 commented 1 year ago

Hi, I tested it for a while this weekend, and I found out that sometimes, after a while, it disconnects, and it doesn't accept a reconnection from the head unit because the RPi stays in gadget mode and doesn't go back to MTP. It's sporadic; sometimes it happens after a few minutes, and sometimes after 10/15/20 minutes. The only thing I can do is unplug the RPi from the head unit, reset the head unit with a paperclip (because while I'm driving I can't turn off the car, ahaha), and then plug the RPi in again. Here are the logs when it fails:

Jan  1 00:02:01 buildroot user.info aawgd[257]: -1 bytes read from USB
Jan  1 00:02:01 buildroot user.info aawgd[257]: Read from USB failed: Input/output error
Jan  1 00:02:01 buildroot user.info aawgd[257]: -1 bytes written to USB
Jan  1 00:02:01 buildroot user.info aawgd[257]: Write to USB failed: Input/output error
Jan  1 00:02:01 buildroot user.info aawgd[257]: Forwarding stopped
Jan  1 00:02:01 buildroot daemon.err bluetoothd[161]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down
Jan  1 00:02:01 buildroot kern.info kernel: [  121.711619] android_work: sent uevent USB_STATE=DISCONNECTED
Jan  1 00:02:01 buildroot kern.info kernel: [  121.760862] dwc2 fe980000.usb: new device is full-speed
Jan  1 00:02:01 buildroot daemon.err bluetoothd[161]: src/profile.c:ext_io_disconnected() Unable to get io data for HSP HS: getpeername: Transport endpoint is not connected (107)
Jan  1 00:02:01 buildroot daemon.err bluetoothd[161]: src/profile.c:ext_io_disconnected() Unable to get io data for AA Wireless: getpeername: Transport endpoint is not connected (107)
Jan  1 00:02:01 buildroot user.info aawgd[257]: Bluetooth adapter was powered off
Jan  1 00:02:01 buildroot user.info aawgd[257]: USB Manager: Disabled all USB gadgets
Jan  1 00:02:01 buildroot kern.info kernel: [  121.983283] android_work: did not send uevent (0 0 00000000)
Jan  1 00:02:03 buildroot user.info aawgd[257]: USB Manager: Enabled default gadget
Jan  1 00:02:03 buildroot kern.info kernel: [  123.983586] dwc2 fe980000.usb: bound driver configfs-gadget
Jan  1 00:02:03 buildroot kern.info kernel: [  123.986910] read descriptors
Jan  1 00:02:03 buildroot kern.info kernel: [  123.986943] read strings
Jan  1 00:02:03 buildroot kern.info kernel: [  123.987013] android_work: did not send uevent (0 0 00000000)
gamelaster commented 1 year ago

@nu00 actually, I had issues with dropping of the connection, and I suspect that sometimes, the exact channel is so much busy, that it drops the connection, but it is only suspicion, I don't have this confirmed. Does this happen in cities?

nu00 commented 1 year ago

@gamelaster, to be honest, it happens regardless of where I am. I also noticed that the rpi wifi network is enabled on both 5 GHz and 2.4 GHz. Maybe the phone tries to switch frequencies, and it crashes. However, if you read the logs, it says that it failed reading from USB, so I don't know... A nice workaraund will be to go back to MTP, so we can reconnect easier from the HU

nu00 commented 1 year ago

I've just tried to disconnect Android Auto from the notification on the phone, and the logs are similar, so maybe @gamelaster is right.

Jan  1 00:04:38 buildroot user.info aawgd[255]: -1 bytes written to USB
Jan  1 00:04:38 buildroot user.info aawgd[255]: Write to USB failed: Input/output error
Jan  1 00:04:38 buildroot user.info aawgd[255]: -1 bytes read from USB
Jan  1 00:04:38 buildroot user.info aawgd[255]: Read from USB failed: Input/output error
Jan  1 00:04:38 buildroot user.info aawgd[255]: Forwarding stopped
Jan  1 00:04:38 buildroot daemon.err bluetoothd[161]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down
Jan  1 00:04:38 buildroot kern.info kernel: [  278.474840] android_work: sent uevent USB_STATE=DISCONNECTED
Jan  1 00:04:38 buildroot kern.info kernel: [  278.524080] dwc2 fe980000.usb: new device is full-speed
Jan  1 00:04:38 buildroot kern.info kernel: [  278.871596] dwc2 fe980000.usb: new device is high-speed
Jan  1 00:04:38 buildroot kern.info kernel: [  278.931770] android_work: sent uevent USB_STATE=CONNECTED
Jan  1 00:04:38 buildroot kern.info kernel: [  278.991571] dwc2 fe980000.usb: new device is high-speed
Jan  1 00:04:38 buildroot daemon.err bluetoothd[161]: src/profile.c:ext_io_disconnected() Unable to get io data for HSP HS: getpeername: Transport endpoint is not connected (107)
Jan  1 00:04:38 buildroot daemon.err bluetoothd[161]: src/profile.c:ext_io_disconnected() Unable to get io data for AA Wireless: getpeername: Transport endpoint is not connected (107)
Jan  1 00:04:39 buildroot kern.info kernel: [  279.051602] dwc2 fe980000.usb: new address 7
Jan  1 00:04:39 buildroot kern.info kernel: [  279.080695] android_work: sent uevent USB_STATE=CONFIGURED
Jan  1 00:04:39 buildroot user.info aawgd[255]: Bluetooth adapter was powered off
Jan  1 00:04:39 buildroot user.info aawgd[255]: USB Manager: Disabled all USB gadgets
Jan  1 00:04:39 buildroot kern.info kernel: [  279.085821] android_work: sent uevent USB_STATE=DISCONNECTED
Jan  1 00:04:41 buildroot user.info aawgd[255]: USB Manager: Enabled default gadget
Jan  1 00:04:41 buildroot kern.info kernel: [  281.086395] dwc2 fe980000.usb: bound driver configfs-gadget
Jan  1 00:04:41 buildroot kern.info kernel: [  281.089559] android_work: did not send uevent (0 0 00000000)
Jan  1 00:04:41 buildroot kern.info kernel: [  281.089886] read descriptors
Jan  1 00:04:41 buildroot kern.info kernel: [  281.089916] read strings
Jan  1 00:05:21 buildroot kern.info kernel: [  321.130156] read descriptors
Jan  1 00:05:21 buildroot kern.info kernel: [  321.130196] read strings
nisargjhaveri commented 1 year ago

We do start the MTP again if it fails. Even in the logs, see these lines, which says that the MTP gadget was started again.

Jan  1 00:02:01 buildroot user.info aawgd[257]: Bluetooth adapter was powered off
Jan  1 00:02:01 buildroot user.info aawgd[257]: USB Manager: Disabled all USB gadgets
...
Jan  1 00:02:03 buildroot user.info aawgd[257]: USB Manager: Enabled default gadget

Two things to investigate.

  1. Why is the usb read failing in the first place.
  2. Why is it not reconnecting after we try to reset the gadget to MTP mode.
nu00 commented 1 year ago

I don't know why, but I tried to reboot the RPi via SSH (so no unplug and replug), and after some retries, it started reconnecting to the head unit. Notably, I don't have to touch the reconnect button on the head unit, it makes it worse. It's also hard to debug this issue because it happens randomly

nu00 commented 1 year ago

what about this line? bluetoothd[161]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down

seems like the bluetooth crashes...

nu00 commented 11 months ago

Two things to investigate.

  1. Why is the usb read failing in the first place.
  2. Why is it not reconnecting after we try to reset the gadget to MTP mode.
  1. After some testing, I noticed that it's the HU fault for the usb disconnection, it happen also with the phone connected via usb directly.
  2. For the reconnection, I'm not 100% sure, but I think the phone goes in "charging mode" before going to MTP. I would give it a try but I really don't know how to implement it (some advice pls)
nisargjhaveri commented 11 months ago

For the reconnection, I'm not 100% sure, but I think the phone goes in "charging mode" before going to MTP. I would give it a try but I really don't know how to implement it (some advice pls)

We do disable the gadget completely for 2 seconds, which should be equivalent to the "charging mode" before going into MTP. We can try to tweak with the time limit if that's the issue. https://github.com/nisargjhaveri/AAWirelessDongle/blob/main/aa_wireless_dongle/package/aawg/src/aawgd.cpp#L33C14-L33C14

From the logs above, it looks like we do enable the MTP again, but the headunit never sends the accessory start request

nisargjhaveri commented 7 months ago

We have more robust reconnection now with v0.4.0. Resolving this issue for now, feel free to reopen if it still is an issue.