MatsE
Posts: 1
Joined: Sat Sep 14, 2019 11:34 am

USB not detected

Sat Sep 14, 2019 12:17 pm

I've got a Z-Stick Gen5 which does not leave any mark in dmesg or lsusb when connecting/disconnecting. I need some guidence in what to test further. Details on what I've tested so far below, and further down details on setup.

Tested:
(with Ethernet and power connected - no other connected devices, bluetooth is on, but no connected devices)
  • Z-stick in all four USB ports - same result = not detected *
  • Z-stick on other laptops - working
  • Connected some other USB device (a Corsair Flash Voyager USB memory stick - really super old) - this was detected and working
* during early stages of looking into this, it briefly connected (lsusb showed up, and dmesg showed something) - I did not save the dmesg values though, it disconnected almost immediately and I've rebooted and done some dmesg -C .

From the above I made the conclusion that most likely there is not enough power to drive the Z-stick. Hence I used a standard multimeter to measure voltages with/without USB stick inserted. I've tested between TP1/2/3 and TP 7/8 - all show up as 5.19V regardless if Z-stick is inserted or not. From this I think that the power in is sufficient for the pi, do you agree?

I've also looked at results from vcgencmd measure_volts:
  • core: volt=0.8666V
  • sdram_c: volt=1.1000V
  • sdram_i: volt=1.1000V
  • sdram_p: volt=1.1000V
Here my main concern is that the voltage seems to be too low throughout, especially the core voltage seems to low. Could this be related?
Using vcgencmd the core temperature is 53.0C.

Setup
I'm on a fresh out of the box Raspberry Pi 4 /4G and downloaded/flashed recent build of raspian from there to a 128GB SanDisk Extreme A2/160MB/90MB microSD card.
I've downloaded and built Open z-wave and tried with both downloaded version of domoticz and a version where I built the same. During this I noted a discepancy of time between how much time the build would take me towards the tutorial/guide suggested. That is - when the guide I followed said "this build would take quite some time - 20 minutes on my setup" (etc).... This would take significantly longer on my setup (not clocked - but say around x2-x3).
Let me know if any relevant information is missing. Is it a faulty board? A bad setup? What? I'm out of ideas on how to proceed. My next alternative would probably be to take another new pi4 board and test the z-stick on that. (possibly test on another knowingly working pi4 board.) I do however not have access to any other pies.

output of uname -v: #1253 SMP Thu Aug 15 12:02:08 BST 2019
output of lsusb (adding -v version further down):
  • Bus 003 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
  • Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
  • Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
  • Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

Code: Select all

Bus 003 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Couldn't open device, some information will be missing
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               2.00
  bDeviceClass            9 Hub
  bDeviceSubClass         0
  bDeviceProtocol         1 Single TT
  bMaxPacketSize0        64
  idVendor           0x1d6b Linux Foundation
  idProduct          0x0002 2.0 root hub
  bcdDevice            4.19
  iManufacturer           3
  iProduct                2
  iSerial                 1
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength       0x0019
    bNumInterfaces          1
    bConfigurationValue     1
    iConfiguration          0
    bmAttributes         0xe0
      Self Powered
      Remote Wakeup
    MaxPower                0mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         9 Hub
      bInterfaceSubClass      0
      bInterfaceProtocol      0 Full speed (or root) hub
            iInterface              0
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0004  1x 4 bytes
        bInterval              12

Bus 002 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Couldn't open device, some information will be missing
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               3.00
  bDeviceClass            9 Hub
  bDeviceSubClass         0
  bDeviceProtocol         3
  bMaxPacketSize0         9
  idVendor           0x1d6b Linux Foundation
  idProduct          0x0003 3.0 root hub
  bcdDevice            4.19
  iManufacturer           3
  iProduct                2
  iSerial                 1
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength       0x001f
    bNumInterfaces          1
    bConfigurationValue     1
    iConfiguration          0
    bmAttributes         0xe0
      Self Powered
      Remote Wakeup
    MaxPower                0mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         9 Hub
      bInterfaceSubClass      0
      bInterfaceProtocol      0 Full speed (or root) hub
      iInterface              0
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0004  1x 4 bytes
        bInterval              12
        bMaxBurst               0

Bus 001 Device 002: ID 2109:3431 VIA Labs, Inc. Hub
Couldn't open device, some information will be missing
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               2.10
  bDeviceClass            9 Hub
  bDeviceSubClass         0
  bDeviceProtocol         1 Single TT
  bMaxPacketSize0        64
  idVendor           0x2109 VIA Labs, Inc.
  idProduct          0x3431 Hub
  bcdDevice            4.20
  iManufacturer           0
  iProduct                1
  iSerial                 0
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength       0x0019
    bNumInterfaces          1
    bConfigurationValue     1
    iConfiguration          0
    bmAttributes         0xe0
      Self Powered
      Remote Wakeup
    MaxPower              100mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         9 Hub
      bInterfaceSubClass      0
      bInterfaceProtocol      0 Full speed (or root) hub
      iInterface              0
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0001  1x 1 bytes
        bInterval              12

Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Couldn't open device, some information will be missing
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               2.00
  bDeviceClass            9 Hub
  bDeviceSubClass         0
  bDeviceProtocol         1 Single TT
  bMaxPacketSize0        64
  idVendor           0x1d6b Linux Foundation
  idProduct          0x0002 2.0 root hub
  bcdDevice            4.19
  iManufacturer           3
  iProduct                2
  iSerial                 1
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength       0x0019
    bNumInterfaces          1
    bConfigurationValue     1
    iConfiguration          0
    bmAttributes         0xe0
      Self Powered
      Remote Wakeup
    MaxPower                0mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         9 Hub
      bInterfaceSubClass      0
      bInterfaceProtocol      0 Full speed (or root) hub
      iInterface              0
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0004  1x 4 bytes
        bInterval              12
output from dmesg:

Code: Select all

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.19.66-v7l+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1253 SMP Thu Aug 15 12:02:08 BST 2019
[    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
[    0.000000] CPU: div instructions available: patching division code
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] cma: Reserved 256 MiB at 0x000000001ec00000
[    0.000000] On node 0 totalpages: 1012736
[    0.000000]   DMA zone: 1728 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 196608 pages, LIFO batch:63
[    0.000000]   HighMem zone: 816128 pages, LIFO batch:63
[    0.000000] random: get_random_bytes called from start_kernel+0xc0/0x4e8 with crng_init=0
[    0.000000] percpu: Embedded 17 pages/cpu s39488 r8192 d21952 u69632
[    0.000000] pcpu-alloc: s39488 r8192 d21952 u69632 alloc=17*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1011008
[    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 cma=64M cma=256M  smsc95xx.macaddr=DC:A6:32:20:07:C2 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=PARTUUID=4253612b-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 3735592K/4050944K available (8192K kernel code, 661K rwdata, 2348K rodata, 2048K init, 850K bss, 53208K reserved, 262144K cma-reserved, 3264512K highmem)
[    0.000000] Virtual kernel memory layout:
                   vector  : 0xffff0000 - 0xffff1000   (   4 kB)
                   fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
                   vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
                   lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
                   pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
                   modules : 0xbf000000 - 0xbfe00000   (  14 MB)
                     .text : 0x(ptrval) - 0x(ptrval)   (10208 kB)
                     .init : 0x(ptrval) - 0x(ptrval)   (2048 kB)
                     .data : 0x(ptrval) - 0x(ptrval)   ( 662 kB)
                      .bss : 0x(ptrval) - 0x(ptrval)   ( 851 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 28118 entries in 83 pages
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000005] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000017] Switching to timer-based delay loop, resolution 18ns
[    0.000236] Console: colour dummy device 80x30
[    0.000260] console [tty1] enabled
[    0.000301] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
[    0.000323] pid_max: default: 32768 minimum: 301
[    0.000585] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000603] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001345] CPU: Testing write buffer coherency: ok
[    0.001748] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.002387] Setting up static identity map for 0x200000 - 0x20003c
[    0.002543] rcu: Hierarchical SRCU implementation.
[    0.003403] smp: Bringing up secondary CPUs ...
[    0.004202] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.005128] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.006014] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.006146] smp: Brought up 1 node, 4 CPUs
[    0.006159] SMP: Total of 4 processors activated (432.00 BogoMIPS).
[    0.006168] CPU: All CPU(s) started in HYP mode.
[    0.006177] CPU: Virtualization extensions available.
[    0.006952] devtmpfs: initialized
[    0.017256] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
[    0.017458] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.017477] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.024769] pinctrl core: initialized pinctrl subsystem
[    0.025608] NET: Registered protocol family 16
[    0.028546] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[    0.030051] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.030062] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.030253] Serial: AMBA PL011 UART driver
[    0.033294] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.068982] bcm2835-dma fe007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
[    0.071421] vgaarb: loaded
[    0.071781] SCSI subsystem initialized
[    0.071975] usbcore: registered new interface driver usbfs
[    0.072026] usbcore: registered new interface driver hub
[    0.072122] usbcore: registered new device driver usb
[    0.090391] raspberrypi-firmware soc:firmware: Attached to firmware from 2019-08-15 12:03, variant start
[    0.100124] raspberrypi-firmware soc:firmware: Firmware hash is 9f8431fb7839c7f00f52b81f5822ddab2b31d0db
[    0.111644] clocksource: Switched to clocksource arch_sys_counter
[    0.189170] VFS: Disk quotas dquot_6.6.0
[    0.189245] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.189394] FS-Cache: Loaded
[    0.189576] CacheFiles: Loaded
[    0.190077] simple-framebuffer: probe of 0.framebuffer failed with error -12
[    0.198882] NET: Registered protocol family 2
[    0.199524] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[    0.199550] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.199620] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.199691] TCP: Hash tables configured (established 8192 bind 8192)
[    0.199808] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.199836] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.200131] NET: Registered protocol family 1
[    0.200658] RPC: Registered named UNIX socket transport module.
[    0.200668] RPC: Registered udp transport module.
[    0.200677] RPC: Registered tcp transport module.
[    0.200686] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.200701] PCI: CLS 0 bytes, default 64
[    0.203796] Initialise system trusted keyrings
[    0.203971] workingset: timestamp_bits=14 max_order=20 bucket_order=6
[    0.212884] FS-Cache: Netfs 'nfs' registered for caching
[    0.213368] NFS: Registering the id_resolver key type
[    0.213391] Key type id_resolver registered
[    0.213400] Key type id_legacy registered
[    0.213419] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.215619] Key type asymmetric registered
[    0.215629] Asymmetric key parser 'x509' registered
[    0.215739] bounce: pool size: 64 pages
[    0.215784] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[    0.215934] io scheduler noop registered
[    0.215945] io scheduler deadline registered (default)
[    0.216102] io scheduler cfq registered
[    0.216113] io scheduler mq-deadline registered (default)
[    0.216123] io scheduler kyber registered
[    0.244812] brcm-pcie fd500000.pcie: dmabounce: initialised - 32768 kB, threshold 0x00000000c0000000
[    0.244830] brcm-pcie fd500000.pcie: could not get clock
[    0.244889] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    0.244926] brcm-pcie fd500000.pcie:   MEM 0x600000000..0x603ffffff -> 0xf8000000
[    0.311677] brcm-pcie fd500000.pcie: link up, 5.0 Gbps x1 (!SSC)
[    0.311943] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    0.311958] pci_bus 0000:00: root bus resource [bus 00-01]
[    0.311975] pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
[    0.312017] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    0.312156] pci 0000:00:00.0: PME# supported from D0 D3hot
[    0.314877] PCI: bus0: Fast back to back transfers disabled
[    0.314894] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    0.315051] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    0.315111] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    0.315279] pci 0000:01:00.0: PME# supported from D0 D3cold
[    0.317910] PCI: bus1: Fast back to back transfers disabled
[    0.317926] pci_bus 0000:01: busn_res: [bus 01] end is updated to 01
[    0.317971] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    0.317991] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    0.318020] pci 0000:00:00.0: PCI bridge to [bus 01]
[    0.318038] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    0.318242] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
[    0.318423] pcieport 0000:00:00.0: Signaling PME with IRQ 55
[    0.318580] pcieport 0000:00:00.0: AER enabled with IRQ 55
[    0.318717] pci 0000:01:00.0: enabling device (0140 -> 0142)
[    0.321911] iproc-rng200 fe104000.rng: hwrng registered
[    0.322125] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
[    0.322619] vc-sm: Videocore shared memory driver
[    0.323017] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    0.332965] brd: module loaded
[    0.342528] loop: module loaded
[    0.343247] Loading iSCSI transport class v2.0-870.
[    0.344893] libphy: Fixed MDIO Bus: probed
[    0.345300] bcmgenet fd580000.genet: failed to get enet clock
[    0.345315] bcmgenet fd580000.genet: GENET 5.0 EPHY: 0x0000
[    0.345332] bcmgenet fd580000.genet: failed to get enet-wol clock
[    0.345348] bcmgenet fd580000.genet: failed to get enet-eee clock
[    0.345370] bcmgenet: Skipping UMAC reset
[    0.345598] unimac-mdio unimac-mdio.-19: DMA mask not set
[    0.371674] libphy: bcmgenet MII bus: probed
[    0.412173] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus at 0x(ptrval)
[    0.413057] usbcore: registered new interface driver r8152
[    0.413119] usbcore: registered new interface driver lan78xx
[    0.413171] usbcore: registered new interface driver smsc95xx
[    0.413366] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    0.413396] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    0.415462] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000001000000890
[    0.415627] genirq: irq_chip Brcm_MSI did not update eff. affinity mask of irq 56
[    0.416239] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[    0.416253] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.416265] usb usb1: Product: xHCI Host Controller
[    0.416276] usb usb1: Manufacturer: Linux 4.19.66-v7l+ xhci-hcd
[    0.416287] usb usb1: SerialNumber: 0000:01:00.0
[    0.416796] hub 1-0:1.0: USB hub found
[    0.416853] hub 1-0:1.0: 1 port detected
[    0.417260] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    0.417282] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    0.417301] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    0.417635] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.19
[    0.417649] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.417660] usb usb2: Product: xHCI Host Controller
[    0.417671] usb usb2: Manufacturer: Linux 4.19.66-v7l+ xhci-hcd
[    0.417681] usb usb2: SerialNumber: 0000:01:00.0
[    0.418164] hub 2-0:1.0: USB hub found
[    0.418215] hub 2-0:1.0: 4 ports detected
[    0.419295] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    0.444855] dwc_otg fe980000.usb: base=(ptrval)
[    0.645186] Core Release: 2.80a
[    0.645199] Setting default values for core params
[    0.645226] Finished setting default values for core params
[    0.845545] Using Buffer DMA mode
[    0.845555] Periodic Transfer Interrupt Enhancement - disabled
[    0.845564] Multiprocessor Interrupt Enhancement - disabled
[    0.845575] OTG VER PARAM: 0, OTG VER FLAG: 0
[    0.845632] Dedicated Tx FIFOs mode
[    0.846227] WARN::dwc_otg_hcd_init:1045: FIQ DMA bounce buffers: virt = ded34000 dma = 0x00000000ded34000 len=9024
[    0.846250] FIQ FSM acceleration enabled for :
               Non-periodic Split Transactions
               Periodic Split Transactions
               High-Speed Isochronous Endpoints
               Interrupt/Control Split Transaction hack enabled
[    0.846262] dwc_otg: Microframe scheduler enabled
[    0.846325] WARN::hcd_init_fiq:457: FIQ on core 1
[    0.846341] WARN::hcd_init_fiq:458: FIQ ASM at c07b5a8c length 36
[    0.846358] WARN::hcd_init_fiq:497: MPHI regs_base at f0810200
[    0.846402] dwc_otg fe980000.usb: DWC OTG Controller
[    0.846430] dwc_otg fe980000.usb: new USB bus registered, assigned bus number 3
[    0.846462] dwc_otg fe980000.usb: irq 37, io mem 0x00000000
[    0.846512] Init: Port Power? op_state=1
[    0.846522] Init: Power Port (0)
[    0.846777] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[    0.846791] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.846802] usb usb3: Product: DWC OTG Controller
[    0.846813] usb usb3: Manufacturer: Linux 4.19.66-v7l+ dwc_otg_hcd
[    0.846823] usb usb3: SerialNumber: fe980000.usb
[    0.847334] hub 3-0:1.0: USB hub found
[    0.847383] hub 3-0:1.0: 1 port detected
[    0.847951] dwc_otg: FIQ enabled
[    0.847961] dwc_otg: NAK holdoff enabled
[    0.847969] dwc_otg: FIQ split-transaction FSM enabled
[    0.847982] Module dwc_common_port init
[    0.848187] usbcore: registered new interface driver uas
[    0.848296] usbcore: registered new interface driver usb-storage
[    0.848461] mousedev: PS/2 mouse device common for all mice
[    0.849613] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    0.849796] bcm2835-cpufreq: min=600000 max=1500000
[    0.850386] sdhci: Secure Digital Host Controller Interface driver
[    0.850395] sdhci: Copyright(c) Pierre Ossman
[    0.850779] mmc-bcm2835 fe300000.mmcnr: could not get clk, deferring probe
[    0.851152] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.854180] ledtrig-cpu: registered to indicate activity on CPUs
[    0.854319] hidraw: raw HID events driver (C) Jiri Kosina
[    0.854439] usbcore: registered new interface driver usbhid
[    0.854448] usbhid: USB HID core driver
[    0.855191] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
[    0.856738] [vc_sm_connected_init]: start
[    0.864703] [vc_sm_connected_init]: end - returning 0
[    0.865766] Initializing XFRM netlink socket
[    0.865793] NET: Registered protocol family 17
[    0.865875] Key type dns_resolver registered
[    0.866272] Registering SWP/SWPB emulation handler
[    0.866849] registered taskstats version 1
[    0.866864] Loading compiled-in X.509 certificates
[    0.874606] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    0.874670] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 34, base_baud = 0) is a PL011 rev2
[    0.877583] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    0.878088] brcmstb_thermal fd5d2200.thermal: registered AVS TMON of-sensor driver
[    0.878685] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
[    0.878696] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
[    0.904756] sdhci-iproc fe340000.emmc2: Linked as a consumer to regulator.1
[    0.924988] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
[    0.926595] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    0.928203] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    0.931082] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
[    0.932692] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
[    0.940913] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
[    0.943314] of_cfs_init
[    0.943393] of_cfs_init: OK
[    0.943970] Waiting for root device PARTUUID=4253612b-02...
[    0.988348] random: fast init done
[    0.991735] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    0.999602] mmc1: new high speed SDIO card at address 0001
[    1.049599] mmc0: new ultra high speed DDR50 SDXC card at address aaaa
[    1.050699] mmcblk0: mmc0:aaaa SN128 119 GiB
[    1.052056]  mmcblk0: p1 p2
[    1.077472] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    1.077512] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.078300] devtmpfs: mounted
[    1.084683] Freeing unused kernel memory: 2048K
[    1.111957] Run /sbin/init as init process
[    1.173641] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.20
[    1.173655] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    1.173668] usb 1-1: Product: USB2.0 Hub
[    1.175517] hub 1-1:1.0: USB hub found
[    1.175758] hub 1-1:1.0: 4 ports detected
[    1.537010] systemd[1]: System time before build time, advancing clock.
[    1.624385] NET: Registered protocol family 10
[    1.625584] Segment Routing with IPv6
[    1.660919] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[    1.661579] systemd[1]: Detected architecture arm.
[    1.669355] systemd[1]: Set hostname to <raspberrypi>.
[    1.674903] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
[    1.968518] systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
[    1.968539] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[    2.339072] random: systemd: uninitialized urandom read (16 bytes read)
[    2.347825] random: systemd: uninitialized urandom read (16 bytes read)
[    2.353093] systemd[1]: Created slice system-getty.slice.
[    2.353341] random: systemd: uninitialized urandom read (16 bytes read)
[    2.354558] systemd[1]: Created slice User and Session Slice.
[    2.374606] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[    2.375334] systemd[1]: Listening on udev Control Socket.
[    2.487671] i2c /dev entries driver
[    3.074233] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    3.170946] systemd-journald[113]: Received request to flush runtime journal from PID 1
[    3.688611] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x0000ffff
[    3.689813] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00000fff
[    3.690372] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x0000ffff
[    3.690852] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x0000ffff
[    3.729769] media: Linux media interface: v0.10
[    3.771106] videodev: Linux video capture interface: v2.00
[    3.796881] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    3.797709] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    3.798916] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    3.798931] [vc_sm_connected_init]: start
[    3.803063] [vc_sm_connected_init]: installed successfully
[    3.805516] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    3.820836] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    3.829778] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    3.844897] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    3.844911] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    3.852864] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    3.852879] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    3.860357] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    3.860370] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    3.874301] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    3.894838] bcm2835_audio soc:audio: card created with 8 channels
[    4.143586] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    4.226570] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0
[    4.258923] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    4.426079] [drm] No displays found. Consider forcing hotplug if HDMI is attached
[    4.426176] vc4-drm soc:gpu: bound fe600000.firmwarekms (ops vc4_fkms_ops [vc4])
[    4.428316] [drm] Initialized vc4 0.0.0 20140616 for soc:gpu on minor 1
[    4.428329] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    4.428338] [drm] No driver support for vblank timestamp query.
[    4.428347] [drm] Setting vblank_disable_immediate to false because get_vblank_timestamp == NULL
[    4.430144] brcmfmac: F1 signature read @0x18000000=0x15264345
[    4.442218] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    4.442851] usbcore: registered new interface driver brcmfmac
[    4.660659] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
[    4.674464] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Feb 27 2018 03:15:32 version 7.45.154 (r684107 CY) FWID 01-4fbe0b04
[    6.308307] uart-pl011 fe201000.serial: no DMA platform data
[    6.385677] random: crng init done
[    6.385692] random: 7 urandom warning(s) missed due to ratelimiting
[    6.431057] 8021q: 802.1Q VLAN Support v1.8
[    6.700387] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
[    6.755962] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[    6.755971] brcmfmac: power management disabled
[    7.026872] bcmgenet: Skipping UMAC reset
[    7.122333] bcmgenet fd580000.genet: configuring instance for external RGMII (no delay)
[    7.122468] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    8.151759] bcmgenet fd580000.genet eth0: Link is Down
[   12.311805] bcmgenet fd580000.genet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[   12.311830] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   12.906633] Bluetooth: Core ver 2.22
[   12.906680] NET: Registered protocol family 31
[   12.906684] Bluetooth: HCI device and connection manager initialized
[   12.907595] Bluetooth: HCI socket layer initialized
[   12.907614] Bluetooth: L2CAP socket layer initialized
[   12.907643] Bluetooth: SCO socket layer initialized
[   12.915833] Bluetooth: HCI UART driver ver 2.3
[   12.915841] Bluetooth: HCI UART protocol H4 registered
[   12.915879] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   12.915990] Bluetooth: HCI UART protocol Broadcom registered
[   13.110610] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   13.110617] Bluetooth: BNEP filters: protocol multicast
[   13.110629] Bluetooth: BNEP socket layer initialized
[   13.140913] Bluetooth: RFCOMM TTY layer initialized
[   13.140925] Bluetooth: RFCOMM socket layer initialized
[   13.140940] Bluetooth: RFCOMM ver 1.11

trejan
Posts: 2238
Joined: Tue Jul 02, 2019 2:28 pm

Re: USB not detected

Sat Sep 14, 2019 1:36 pm

You need to put a USB hub between the Pi 4 and the Aeotech Z-Stick. The Z-Stick does something non-compliant with USB and confuses the USB controller. Read https://github.com/raspberrypi/linux/issues/3027 for more information and some hubs that other people have tested. Not all USB hubs work.

Andyroo

Re: USB not detected

Sat Sep 14, 2019 1:49 pm

You could try adding

Code: Select all

max_usb_current=1
to config.txt and rebooting.

Note this tests the power supply as it allows 1.2A over the USB compared to the default 600mA

Though incoming voltage is important, minor spikes will not show up on a multimeter so you need an oscilloscope and track current drain at the same time. The only real use for a multimeter for power is checking the GPIO 5v and 3v3 pins if you think you have fried the Pi power protection circuits...

trejan
Posts: 2238
Joined: Tue Jul 02, 2019 2:28 pm

Re: USB not detected

Sat Sep 14, 2019 2:10 pm

Andyroo wrote:
Sat Sep 14, 2019 1:49 pm
You could try adding

Code: Select all

max_usb_current=1
to config.txt and rebooting.

Note this tests the power supply as it allows 1.2A over the USB compared to the default 600mA
They're using a Pi 4. max_usb_current only did something on the Pi 2. The 3, 3+ and 4 are always set for 1.2A so completely ignore that option.

Return to “Troubleshooting”