al177 / esp8089

Linux kernel module driver for the ESP8089 WiFi chip
GNU General Public License v2.0
180 stars 114 forks source link

Raspberry Pi Compute Module 3 / Jessie Lite #11

Closed keabarnes closed 7 years ago

keabarnes commented 7 years ago

I've made multiple attempts to get this up and running and can't seem to get it right.

I'd just like to confirm, is there any reason why this would not work on a Raspberry Pi Compute Module 3 running the latest Jessie Lite?

I'm getting the -110 error on boot and there's occasionally a kernal panic dump even when I'm not doing anything.

I'll be trying another fresh install tomorrow using the instructions on https://hackaday.io/project/8678/instructions

As far as I can tell, I don't think it's the ESP8266 module, I've connected the module to a RPi 1 Model B and it worked.

keabarnes commented 7 years ago

For reference, my dmesg after boot on a fresh install of "2017-04-10-raspbian-jessie-lite" on CM3 (with eMMC option): dmesg.txt

[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.4.50-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #970 SMP Mon Feb 20 19:18:29 GMT 2017
[    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: Raspberry Pi Compute Module 3 Rev 1.0
[    0.000000] cma: Reserved 8 MiB at 0x3a800000
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] On node 0 totalpages: 241664
[    0.000000] free_area_init_node: node 0, pgdat 808c5040, node_mem_map b9fa6000
[    0.000000]   Normal zone: 2124 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 241664 pages, LIFO batch:31
[    0.000000] [bcm2709_smp_init_cpus] enter (9520->f3003010)
[    0.000000] [bcm2709_smp_init_cpus] ncores=4
[    0.000000] PERCPU: Embedded 13 pages/cpu @b9f62000 s22592 r8192 d22464 u53248
[    0.000000] pcpu-alloc: s22592 r8192 d22464 u53248 alloc=13*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 239540
[    0.000000] Kernel command line: bcm2708_fb.fbwidth=1824 bcm2708_fb.fbheight=984 bcm2708_fb.fbswap=1 dma.dmachans=0x7f35 bcm2709.boardrev=0xa020a0 bcm2709.serial=0x2a2373f0 bcm2709.uart_clock=48000000 smsc95xx.macaddr=B8:27:EB:23:73:F0 vc_mem.mem_base=0x3dc00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyAMA0,115200 console=tty1 root=PARTUUID=b3ba6501-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    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: 939064K/966656K available (6357K kernel code, 432K rwdata, 1716K rodata, 476K init, 764K bss, 19400K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
    vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    vmalloc : 0xbb800000 - 0xff800000   (1088 MB)
    lowmem  : 0x80000000 - 0xbb000000   ( 944 MB)
    modules : 0x7f000000 - 0x80000000   (  16 MB)
      .text : 0x80008000 - 0x807ea73c   (8074 kB)
      .init : 0x807eb000 - 0x80862000   ( 476 kB)
      .data : 0x80862000 - 0x808ce350   ( 433 kB)
       .bss : 0x808d1000 - 0x809901ec   ( 765 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000]  Build-time adjustment of leaf fanout to 32.
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] Architected cp15 timer(s) running at 19.20MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000009] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000027] Switching to timer-based delay loop, resolution 52ns
[    0.000288] Console: colour dummy device 80x30
[    0.001345] console [tty1] enabled
[    0.001390] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.001459] pid_max: default: 32768 minimum: 301
[    0.001796] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.001838] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002792] Disabling cpuset control group subsystem
[    0.002850] Initializing cgroup subsys io
[    0.002901] Initializing cgroup subsys memory
[    0.002968] Initializing cgroup subsys devices
[    0.003011] Initializing cgroup subsys freezer
[    0.003054] Initializing cgroup subsys net_cls
[    0.003125] CPU: Testing write buffer coherency: ok
[    0.003210] ftrace: allocating 21246 entries in 63 pages
[    0.052448] CPU0: update cpu_capacity 1024
[    0.052513] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.052545] [bcm2709_smp_prepare_cpus] enter
[    0.052699] Setting up static identity map for 0x8240 - 0x8274
[    0.054343] [bcm2709_boot_secondary] cpu:1 started (0) 18
[    0.054533] [bcm2709_secondary_init] enter cpu:1
[    0.054577] CPU1: update cpu_capacity 1024
[    0.054583] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.054958] [bcm2709_boot_secondary] cpu:2 started (0) 17
[    0.055120] [bcm2709_secondary_init] enter cpu:2
[    0.055141] CPU2: update cpu_capacity 1024
[    0.055147] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[    0.055506] [bcm2709_boot_secondary] cpu:3 started (0) 18
[    0.055636] [bcm2709_secondary_init] enter cpu:3
[    0.055656] CPU3: update cpu_capacity 1024
[    0.055662] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[    0.055723] Brought up 4 CPUs
[    0.055822] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.055851] CPU: All CPU(s) started in HYP mode.
[    0.055877] CPU: Virtualization extensions available.
[    0.056513] devtmpfs: initialized
[    0.067194] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
[    0.067560] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.068285] pinctrl core: initialized pinctrl subsystem
[    0.068841] NET: Registered protocol family 16
[    0.073988] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[    0.080796] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.080845] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.081016] Serial: AMBA PL011 UART driver
[    0.081275] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
[    0.580622] console [ttyAMA0] enabled
[    0.584745] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.653365] bcm2835-dma 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0x1
[    0.661911] SCSI subsystem initialized
[    0.665849] usbcore: registered new interface driver usbfs
[    0.671460] usbcore: registered new interface driver hub
[    0.676878] usbcore: registered new device driver usb
[    0.692008] raspberrypi-firmware soc:firmware: Attached to firmware from 2017-04-05 11:49
[    0.727319] clocksource: Switched to clocksource arch_sys_counter
[    0.778224] FS-Cache: Loaded
[    0.781390] CacheFiles: Loaded
[    0.796760] NET: Registered protocol family 2
[    0.802006] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.809204] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    0.815843] TCP: Hash tables configured (established 8192 bind 8192)
[    0.822339] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.828334] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.834928] NET: Registered protocol family 1
[    0.839714] RPC: Registered named UNIX socket transport module.
[    0.845655] RPC: Registered udp transport module.
[    0.850399] RPC: Registered tcp transport module.
[    0.855120] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.862620] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
[    0.872093] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.891521] VFS: Disk quotas dquot_6.6.0
[    0.895755] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.905004] FS-Cache: Netfs 'nfs' registered for caching
[    0.911242] NFS: Registering the id_resolver key type
[    0.916343] Key type id_resolver registered
[    0.920561] Key type id_legacy registered
[    0.926969] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.934544] io scheduler noop registered
[    0.938541] io scheduler deadline registered (default)
[    0.943742] io scheduler cfq registered
[    0.950189] BCM2708FB: allocated DMA memory fac10000
[    0.955189] BCM2708FB: allocated DMA channel 0 @ f3007000
[    1.010622] Console: switching to colour frame buffer device 228x61
[    1.046927] bcm2835-rng 3f104000.rng: hwrng registered
[    1.052316] vc-cma: Videocore CMA driver
[    1.056346] vc-cma: vc_cma_base      = 0x00000000
[    1.061192] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
[    1.066737] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
[    1.072497] vc-mem: phys_addr:0x00000000 mem_base=0x3dc00000 mem_size:0x3f000000(1008 MiB)
[    1.096185] brd: module loaded
[    1.108150] loop: module loaded
[    1.112335] vchiq: vchiq_init_state: slot_zero = 0xbac80000, is_master = 0
[    1.120996] Loading iSCSI transport class v2.0-870.
[    1.126712] usbcore: registered new interface driver smsc95xx
[    1.132696] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.338896] Core Release: 2.80a
[    1.342132] Setting default values for core params
[    1.347075] Finished setting default values for core params
[    1.553205] Using Buffer DMA mode
[    1.556616] Periodic Transfer Interrupt Enhancement - disabled
[    1.562620] Multiprocessor Interrupt Enhancement - disabled
[    1.568354] OTG VER PARAM: 0, OTG VER FLAG: 0
[    1.572832] Dedicated Tx FIFOs mode
[    1.576743] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbac04000 dma = 0xfac04000 len=9024
[    1.586870] FIQ FSM acceleration enabled for :
Non-periodic Split Transactions
Periodic Split Transactions
High-Speed Isochronous Endpoints
Interrupt/Control Split Transaction hack enabled
[    1.616640] dwc_otg: Microframe scheduler enabled
[    1.616720] WARN::hcd_init_fiq:415: FIQ on core 1 at 0x80448d28
[    1.629646] WARN::hcd_init_fiq:416: FIQ ASM at 0x80449098 length 36
[    1.642892] WARN::hcd_init_fiq:441: MPHI regs_base at 0xbb87e000
[    1.655827] dwc_otg 3f980000.usb: DWC OTG Controller
[    1.667704] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    1.681998] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
[    1.694489] Init: Port Power? op_state=1
[    1.705183] Init: Power Port (0)
[    1.715347] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    1.729025] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.743106] usb usb1: Product: DWC OTG Controller
[    1.754706] usb usb1: Manufacturer: Linux 4.4.50-v7+ dwc_otg_hcd
[    1.767715] usb usb1: SerialNumber: 3f980000.usb
[    1.780047] hub 1-0:1.0: USB hub found
[    1.790651] hub 1-0:1.0: 1 port detected
[    1.801888] dwc_otg: FIQ enabled
[    1.801897] dwc_otg: NAK holdoff enabled
[    1.801906] dwc_otg: FIQ split-transaction FSM enabled
[    1.801941] Module dwc_common_port init
[    1.802250] usbcore: registered new interface driver usb-storage
[    1.815349] mousedev: PS/2 mouse device common for all mice
[    1.828474] bcm2835-cpufreq: min=600000 max=1200000
[    1.840291] sdhci: Secure Digital Host Controller Interface driver
[    1.853167] sdhci: Copyright(c) Pierre Ossman
[    1.866462] sdhost: log_buf @ bac07000 (fac07000)
[    1.937355] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[    1.972105] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    1.984653] mmc-bcm2835 3f300000.mmc: DMA channel allocated
[    1.997417] Indeed it is in host mode hprt0 = 00021501
[    2.027435] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.041320] ledtrig-cpu: registered to indicate activity on CPUs
[    2.054679] hidraw: raw HID events driver (C) Jiri Kosina
[    2.067022] mmc0: MAN_BKOPS_EN bit is not set
[    2.078458] usbcore: registered new interface driver usbhid
[    2.079945] mmc0: new high speed MMC card at address 0001
[    2.080550] mmcblk0: mmc0:0001 4FPD3R 3.64 GiB
[    2.080825] mmcblk0boot0: mmc0:0001 4FPD3R partition 1 4.00 MiB
[    2.081073] mmcblk0boot1: mmc0:0001 4FPD3R partition 2 4.00 MiB
[    2.081332] mmcblk0rpmb: mmc0:0001 4FPD3R partition 3 512 KiB
[    2.091552]  mmcblk0: p1 p2
[    2.122146] mmc1: queuing unknown CIS tuple 0x01 (3 bytes)
[    2.129514] mmc1: queuing unknown CIS tuple 0x1a (5 bytes)
[    2.132721] mmc1: queuing unknown CIS tuple 0x1b (8 bytes)
[    2.135435] mmc1: queuing unknown CIS tuple 0x80 (1 bytes)
[    2.135516] mmc1: queuing unknown CIS tuple 0x81 (1 bytes)
[    2.135605] mmc1: queuing unknown CIS tuple 0x82 (1 bytes)
[    2.135646] mmc1: new high speed SDIO card at address 0001
[    2.197370] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    2.198025] Indeed it is in host mode hprt0 = 00001101
[    2.270191] usbhid: USB HID core driver
[    2.280946] Initializing XFRM netlink socket
[    2.291558] NET: Registered protocol family 17
[    2.302361] Key type dns_resolver registered
[    2.313342] Registering SWP/SWPB emulation handler
[    2.325148] registered taskstats version 1
[    2.335383] vc-sm: Videocore shared memory driver
[    2.346142] [vc_sm_connected_init]: start
[    2.356709] [vc_sm_connected_init]: end - returning 0
[    2.368057] of_cfs_init
[    2.376532] of_cfs_init: OK
[    2.396127] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[    2.410436] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    2.417572] usb 1-1: New USB device found, idVendor=8564, idProduct=4000
[    2.417582] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    2.417589] usb 1-1: Product: USB2.0 Hub
[    2.417596] usb 1-1: Manufacturer: Transcend
[    2.419462] hub 1-1:1.0: USB hub found
[    2.421132] hub 1-1:1.0: 4 ports detected
[    2.496799] devtmpfs: mounted
[    2.506494] Freeing unused kernel memory: 476K (807eb000 - 80862000)
[    2.697361] usb 1-1.1: new low-speed USB device number 3 using dwc_otg
[    2.767064] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available)
[    2.786463] systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR)
[    2.806867] systemd[1]: Detected architecture 'arm'.
[    2.831635] usb 1-1.1: New USB device found, idVendor=413c, idProduct=2113
[    2.831645] usb 1-1.1: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[    2.831653] usb 1-1.1: Product: Dell KB216 Wired Keyboard
[    2.861683] input: Dell KB216 Wired Keyboard as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1:1.0/0003:413C:2113.0001/input/input0
[    2.918204] hid-generic 0003:413C:2113.0001: input,hidraw0: USB HID v1.11 Keyboard [Dell KB216 Wired Keyboard] on usb-3f980000.usb-1.1/input0
[    2.949509] input: Dell KB216 Wired Keyboard as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1:1.1/0003:413C:2113.0002/input/input1
[    3.027775] hid-generic 0003:413C:2113.0002: input,hidraw1: USB HID v1.11 Device [Dell KB216 Wired Keyboard] on usb-3f980000.usb-1.1/input1
[    3.034249] NET: Registered protocol family 10
[    3.061156] systemd[1]: Inserted module 'ipv6'
[    3.074686] systemd[1]: Set hostname to <raspberrypi>.
[    3.087576] random: systemd: uninitialized urandom read (16 bytes read, 69 bits of entropy available)
[    3.104620] systemd[1]: Initializing machine ID from random generator.
[    3.119139] systemd[1]: Installed transient /etc/machine-id file.
[    3.147383] usb 1-1.2: new high-speed USB device number 4 using dwc_otg
[    3.200307] uart-pl011 3f201000.uart: no DMA platform data
[    3.233128] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 70 bits of entropy available)
[    3.268831] usb 1-1.2: New USB device found, idVendor=7392, idProduct=7811
[    3.284003] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    3.299529] usb 1-1.2: Product: 802.11n WLAN Adapter
[    3.312634] usb 1-1.2: Manufacturer: Realtek
[    3.325058] usb 1-1.2: SerialNumber: 00e04c000001
[    3.378651] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.397803] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.417003] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.448366] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.466996] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.484779] random: systemd: uninitialized urandom read (16 bytes read, 73 bits of entropy available)
[    3.527637] random: systemd: uninitialized urandom read (16 bytes read, 74 bits of entropy available)
[    3.642767] systemd[1]: Cannot add dependency job for unit regenerate_ssh_host_keys.service, ignoring: Unit regenerate_ssh_host_keys.service failed to load: No such file or directory.
[    3.668371] systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory.
[    3.695096] systemd[1]: Expecting device dev-ttyAMA0.device...
[    3.719489] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[    3.736304] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.752939] systemd[1]: Starting Remote File Systems (Pre).
[    3.777281] systemd[1]: Reached target Remote File Systems (Pre).
[    3.792484] systemd[1]: Starting Encrypted Volumes.
[    3.816243] systemd[1]: Reached target Encrypted Volumes.
[    3.830816] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[    3.859166] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.877941] systemd[1]: Starting Swap.
[    3.901066] systemd[1]: Reached target Swap.
[    3.914825] systemd[1]: Expecting device dev-disk-by\x2dpartuuid-b3ba6501\x2d01.device...
[    3.943023] systemd[1]: Starting Root Slice.
[    3.967099] systemd[1]: Created slice Root Slice.
[    3.981147] systemd[1]: Starting User and Session Slice.
[    4.005658] systemd[1]: Created slice User and Session Slice.
[    4.020597] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[    4.046500] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[    4.062753] systemd[1]: Starting Delayed Shutdown Socket.
[    4.086917] systemd[1]: Listening on Delayed Shutdown Socket.
[    4.101459] systemd[1]: Starting Journal Socket (/dev/log).
[    4.124947] systemd[1]: Listening on Journal Socket (/dev/log).
[    4.139188] systemd[1]: Starting udev Control Socket.
[    4.161693] systemd[1]: Listening on udev Control Socket.
[    4.175395] systemd[1]: Starting udev Kernel Socket.
[    4.197358] systemd[1]: Listening on udev Kernel Socket.
[    4.210899] systemd[1]: Starting Journal Socket.
[    4.232344] systemd[1]: Listening on Journal Socket.
[    4.245336] systemd[1]: Starting System Slice.
[    4.266273] systemd[1]: Created slice System Slice.
[    4.279129] systemd[1]: Starting File System Check on Root Device...
[    4.337946] systemd[1]: Starting system-systemd\x2dfsck.slice.
[    4.362214] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    4.376962] systemd[1]: Starting system-getty.slice.
[    4.400327] systemd[1]: Created slice system-getty.slice.
[    4.414852] systemd[1]: Starting system-serial\x2dgetty.slice.
[    4.438559] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    4.453270] systemd[1]: Starting Increase datagram queue length...
[    4.479484] systemd[1]: Starting Restore / save the current clock...
[    4.508857] systemd[1]: Mounting POSIX Message Queue File System...
[    4.534895] systemd[1]: Mounted Huge Pages File System.
[    4.549375] systemd[1]: Mounting Debug File System...
[    4.576336] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[    4.608352] systemd[1]: Started Set Up Additional Binary Formats.
[    4.622806] systemd[1]: Starting udev Coldplug all Devices...
[    4.653986] systemd[1]: Starting Load Kernel Modules...
[    4.680266] systemd[1]: Starting Slices.
[    4.702291] systemd[1]: Reached target Slices.
[    4.727523] systemd[1]: Mounted Debug File System.
[    4.748755] systemd[1]: Mounted POSIX Message Queue File System.
[    4.772304] systemd[1]: Started File System Check on Root Device.
[    4.804709] systemd[1]: Started Increase datagram queue length.
[    4.828284] systemd[1]: Started Restore / save the current clock.
[    4.853301] systemd[1]: Started Create list of required static device nodes for the current kernel.
[    4.918786] systemd[1]: Started Load Kernel Modules.
[    4.936639] systemd[1]: Time has been changed
[    4.968270] systemd[1]: Started udev Coldplug all Devices.
[    5.121698] systemd[1]: Mounting Configuration File System...
[    5.177805] systemd[1]: Starting Apply Kernel Variables...
[    5.203711] systemd[1]: Mounted FUSE Control File System.
[    5.218094] systemd[1]: Starting Create Static Device Nodes in /dev...
[    5.245905] systemd[1]: Starting Syslog Socket.
[    5.255868] systemd[1]: Listening on Syslog Socket.
[    5.256069] systemd[1]: Starting Journal Service...
[    5.278990] systemd[1]: Started Journal Service.
[    5.457049] systemd-udevd[139]: starting version 215
[    5.656214] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
[    5.677881] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[    6.177696] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[    6.459503] systemd-journald[137]: Received request to flush runtime journal from PID 1
[    7.070599] random: nonblocking pool is initialized
[    7.100477] cfg80211: World regulatory domain updated:
[    7.100507] cfg80211:  DFS Master region: unset
[    7.100518] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    7.100537] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    7.100551] cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    7.100566] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[    7.100581] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    7.100596] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[    7.100609] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[    7.100621] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[    7.100635] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[    7.118458] usbcore: registered new interface driver rtl8192cu
[    8.080975] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[    8.151987] cfg80211: Regulatory domain changed to country: GB
[    8.152011] cfg80211:  DFS Master region: ETSI
[    8.152021] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[    8.152036] cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[    8.152050] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[    8.152065] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[    8.152077] cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
[    8.152090] cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
[    9.633226] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   13.823289] Adding 102396k swap on /var/swap.  Priority:-1 extents:5 across:200700k SSFS
[  337.596051] 
***** EAGLE DRIVER VER:bdf5087c3deb*****

[  337.596140] ESP8089 reset via GPIO 0
[  337.797453] eagle_sdio_dummy: probe of mmc1:0001:1 failed with error -110
[  338.137544] mmc1: card 0001 removed
[  338.201960] mmc1: queuing unknown CIS tuple 0x01 (3 bytes)
[  338.209088] mmc1: queuing unknown CIS tuple 0x1a (5 bytes)
[  338.212176] mmc1: queuing unknown CIS tuple 0x1b (8 bytes)
[  338.214132] mmc1: queuing unknown CIS tuple 0x80 (1 bytes)
[  338.214184] mmc1: queuing unknown CIS tuple 0x81 (1 bytes)
[  338.214234] mmc1: queuing unknown CIS tuple 0x82 (1 bytes)
[  338.214263] mmc1: new high speed SDIO card at address 0001
[  338.214557] esp_sdio_dummy_probe enter
[  338.417334] esp_sdio_init power up OK
[  348.677354] resetting event timeout
[  348.677380] esp_init_all failed: -110
[  348.677389] first error exit
al177 commented 7 years ago

I have not tested on BCM2837, and I do know the RPi3 has the SDIO controller mapped to different pins by default for the onboard WiFi.

al177 commented 7 years ago

Looking at your logs, the ESP is showing up on the SDIO bus (at least the SD_CMD is), so it's not a port routing issue. One problem I've discovered along the way is that the CH_PD signal pullup on the ESP8266 is inconsistent from chip to chip.

Try putting a 4.7K pullup resistor between CH_PD and 3.3V and see if this goes away.

Failing that, you'll need to scope the SDIO signals at the module and see if there's a decent eye. You may need to add or remove termination resistance, or you might have a wiring problem. SD/SDIO is difficult in that the device can respond properly to a probe as long as SD_CS, SD_CMD, and SD_CLK are correctly connected, even if SD_D[3:0] are not.

keabarnes commented 7 years ago

Thanks for taking the time to reply. I'd read that about the CH_PD pull-up as well and have already added a 3.9k resistor to 3v3, which unfortunately hasn't helped.

Hooking up the scope to check the eye is a good idea, I'll try that out. Do you know if the SD_D[3:0] lines are active during the esp8089 driver load stage?

al177 commented 7 years ago

For the SD bus, SD_CMD carries device probe requests/responses, commands to the device, and device ID. SD_D[3:0] is purely data going to/from the device. If you think about it like a classic A/D bus, SD_CMD is address (ignoring the out-of-band stuff) and SD_D[3:0] is data.

When the firmware load happens, SD_CMD sets up the card to receive firmware, then the firmware is sent across SD_D[3:0].