search

espressif / esp-hosted

Hosted Solution (Linux/MCU) with ESP32 (Wi-Fi + BT + BLE)
Other
641 stars 147 forks source link

ESP32 not responding #210

Closed take-42 closed 1 year ago

take-42 commented 1 year ago

I am currently trying to use the TI SK-AM62 board with the ESP32-WROOM-32E connected via SPI, but it is not responding and I need help.

I have made the following changes to release/fg-v0.0.5.

I have edited the board's dts to enable SPI0 and confirmed that /dev/spidev3.0 appears and I can echo strings from there. At this time, I also enabled GPIO for HandShake, DataReady, and ESP32Reset. Then I changed SPI from dts to disabled as an alternative to spidev_disabler.

Changed HANDSHAKE_PIN and SPI_DATA_READY_PIN in esp_spi.h to the corresponding numbers for this board.

Tried all combinations of SPI_MODE_X set in esp_spi.c and spi_slave_api.c.

Made the following changes to rpi_init.sh Commented out spidev_disabler. Set ARCH and CROSS_COMPILE for make command.

In this state . /rpi_init.sh and use the demo app, you will get the following state.

root@am62xx-evm:~/esp-hosted/esp_hosted_fg/host/linux/host_control# ./rpi_init.sh spi resetppin=432
esp32 module inserted
/dev/esps0 device created
RPi init successfully completed
root@am62xx-evm:~/esp-hosted/esp_hosted_fg/host/linux/host_control# cd c_support/
root@am62xx-evm:~/esp-hosted/esp_hosted_fg/host/linux/host_control/c_support# ./test.out get_softap_mac_addr
Enable heatbeat with duration 20
Control response timed out after 30sec
Response not received
Control response timed out after 30sec
Response not received

Requested operation complete
Sleeping for some time just to showcase heatbeat

/dev/esps0, ethap0, and ethsta0 are present.

mantriyogesh commented 1 year ago

Hello @take-42 ,

Thank you for using the ESP-Hosted & following porting_guide & checking other issues for possible repetition.

Can you please get the

take-42 commented 1 year ago

Hi, @mantriyogesh. Thanks for the reply.

The logs are as follows

ESP Side

minicom ``` I (0) cpu_start: App cpu up. I (494) cpu_start: Pro cpu start user code I (494) cpu_start: cpu freq: 240000000 I (494) cpu_start: Application information: I (499) cpu_start: Project name: network_adapter I (504) cpu_start: App version: release/ng-v1.0.2-10-gfe0b105-d I (511) cpu_start: Compile time: Mar 6 2023 13:34:51 I (518) cpu_start: ELF file SHA256: 08fab8356147d960... I (523) cpu_start: ESP-IDF: v4.4.1-dirty I (529) heap_init: Initializing. RAM available for dynamic allocation: I (536) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM I (542) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM I (548) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM I (554) heap_init: At 3FFCC5C0 len 00013A40 (78 KiB): DRAM I (561) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM I (567) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM I (573) heap_init: At 4009D4EC len 00002B14 (10 KiB): IRAM I (581) spi_flash: detected chip: generic I (584) spi_flash: flash io: dio I (589) cpu_start: Starting scheduler on PRO CPU. I (0) cpu_start: Starting scheduler on APP CPU. I (603) NETWORK_ADAPTER: ********************************************************************* I (609) NETWORK_ADAPTER: ESP-Hosted-FG Firmware version :: 0.0.5 I (617) NETWORK_ADAPTER: Transport used :: SDIO only I (625) NETWORK_ADAPTER: ********************************************************************* I (633) NETWORK_ADAPTER: Supported features are: I (637) NETWORK_ADAPTER: - WLAN over SDIO I (641) ESP_BT: - BT/BLE I (643) ESP_BT: - HCI Over SDIO I (645) ESP_BT: - BT/BLE dual mode I (649) NETWORK_ADAPTER: capabilities: 0x1d I (661) BTDM_INIT: BT controller compile version [5688ed5] I (663) system_api: Base MAC address is not set I (663) system_api: read default base MAC address from EFUSE I (669) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07 I (993) NETWORK_ADAPTER: ESP Bluetooth MAC addr: 8c:4b:14:15:a4:22 I (993) SDIO_SLAVE: Using SDIO interface I (997) wifi:wifi driver task: 3ffdae28, prio:23, stack:6656, core=1 I (999) wifi:wifi firmware version: 63017e0 I (1001) wifi:wifi certification version: v7.0 I (1005) wifi:config NVS flash: disabled I (1007) wifi:config nano formating: disabled I (1011) wifi:Init data frame dynamic rx buffer num: 32 I (1015) wifi:Init management frame dynamic rx buffer num: 32 I (1019) wifi:Init management short buffer num: 32 I (1023) wifi:Init dynamic tx buffer num: 64 I (1027) wifi:Init static rx buffer size: 1600 I (1029) wifi:Init static rx buffer num: 16 I (1033) wifi:Init dynamic rx buffer num: 32 I (1037) wifi_init: rx ba win: 6 I (1039) wifi_init: tcpip mbox: 32 I (1043) wifi_init: udp mbox: 6 I (1045) wifi_init: tcp mbox: 6 I (1049) wifi_init: tcp tx win: 5744 I (1051) wifi_init: tcp rx win: 5744 I (1055) wifi_init: tcp mss: 1440 I (1059) wifi_init: WiFi IRAM OP enabled I (1063) wifi_init: WiFi RX IRAM OP enabled I (1069) wifi:mode : null I (1069) NETWORK_ADAPTER: Initial set up done ```
git diff ``` diff --git a/esp_hosted_fg/esp/esp_driver/network_adapter/main/sdio_slave_api.c b/esp_hosted_fg/esp/esp_driver/network_adapter/main/sdio_slave_api.c index da1fbc5..0a50ab3 100644 --- a/esp_hosted_fg/esp/esp_driver/network_adapter/main/sdio_slave_api.c +++ b/esp_hosted_fg/esp/esp_driver/network_adapter/main/sdio_slave_api.c @@ -192,7 +192,7 @@ static interface_handle_t * sdio_init(void) bus in your real design. */ //.flags = SDIO_SLAVE_FLAG_INTERNAL_PULLUP, - .flags = SDIO_SLAVE_FLAG_DEFAULT_SPEED, + // .flags = SDIO_SLAVE_FLAG_DEFAULT_SPEED, /* Note: Sometimes the SDIO card is detected but gets problem in * Read/Write or handling ISR because of SDIO timing issues. * In these cases, Please tune timing below using value from diff --git a/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c b/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c index f248fab..9e29c2f 100644 --- a/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c +++ b/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c @@ -553,7 +553,7 @@ static interface_handle_t * esp_spi_init(void) /* Configuration for the SPI slave interface */ spi_slave_interface_config_t slvcfg={ - .mode=SPI_MODE_2, + .mode=SPI_MODE_3, .spics_io_num=GPIO_CS, .queue_size=SPI_QUEUE_SIZE, .flags=0, diff --git a/esp_hosted_fg/host/linux/host_control/c_support/Makefile b/esp_hosted_fg/host/linux/host_control/c_support/Makefile index 660482d..f5a5601 100644 --- a/esp_hosted_fg/host/linux/host_control/c_support/Makefile +++ b/esp_hosted_fg/host/linux/host_control/c_support/Makefile @@ -1,6 +1,6 @@ CC = gcc -CROSS_COMPILE := +CROSS_COMPILE := aarch64-linux-gnu- CFLAGS = -C -Wall --sysroot=$(SDKTARGETSYSROOT) diff --git a/esp_hosted_fg/host/linux/host_control/c_support/test_utils.c b/esp_hosted_fg/host/linux/host_control/c_support/test_utils.c index 9d99656..8deb058 100644 --- a/esp_hosted_fg/host/linux/host_control/c_support/test_utils.c +++ b/esp_hosted_fg/host/linux/host_control/c_support/test_utils.c @@ -654,6 +654,7 @@ int test_set_wifi_mode_none(void) int test_get_wifi_mac_addr(int mode) { + printf("tdbg\n"); /* implemented synchronous */ ctrl_cmd_t req = CTRL_CMD_DEFAULT_REQ(); ctrl_cmd_t *resp = NULL; diff --git a/esp_hosted_fg/host/linux/host_control/python_support/Makefile b/esp_hosted_fg/host/linux/host_control/python_support/Makefile index 520f28c..bf59721 100644 --- a/esp_hosted_fg/host/linux/host_control/python_support/Makefile +++ b/esp_hosted_fg/host/linux/host_control/python_support/Makefile @@ -1,6 +1,6 @@ CC = gcc -CROSS_COMPILE := +CROSS_COMPILE :=aarch64-linux-gnu- CFLAGS = -C -Wall diff --git a/esp_hosted_fg/host/linux/host_control/rpi_init.sh b/esp_hosted_fg/host/linux/host_control/rpi_init.sh index 117daa6..76fd590 100755 --- a/esp_hosted_fg/host/linux/host_control/rpi_init.sh +++ b/esp_hosted_fg/host/linux/host_control/rpi_init.sh @@ -62,8 +62,10 @@ wlan_init() # CROSS_COMPILE -> /bin/arm-linux-gnueabihf- # KERNEL -> Place where kernel is checked out and built # ARCH -> Architecture - make -j8 target=$IF_TYPE CROSS_COMPILE=/usr/bin/arm-linux-gnueabihf- KERNEL="/lib/modules/$(uname -r)/build" \ - CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm + # make -j8 target=$IF_TYPE CROSS_COMPILE=/usr/bin/arm-linux-gnueabihf- KERNEL="/lib/modules/$(uname -r)/build" \ + # CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm + make -j8 target=$IF_TYPE CROSS_COMPILE=aarch64-linux-gnu- KERNEL="/lib/modules/$(uname -r)/build" \ + CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm64 if [ "$RESETPIN" = "" ] ; then #By Default, BCM6 is GPIO on host. use resetpin=6 diff --git a/esp_hosted_fg/host/linux/host_driver/esp32/Makefile b/esp_hosted_fg/host/linux/host_driver/esp32/Makefile index ab0e8c5..e22263a 100644 --- a/esp_hosted_fg/host/linux/host_driver/esp32/Makefile +++ b/esp_hosted_fg/host/linux/host_driver/esp32/Makefile @@ -3,11 +3,12 @@ CONFIG_TEST_RAW_TP := n CONFIG_ENABLE_MONITOR_PROCESS = n # Toolchain Path -CROSS_COMPILE := /usr/bin/arm-linux-gnueabihf- +CROSS_COMPILE := aarch64-linux-gnu- # Linux Kernel header -KERNEL := /lib/modules/$(shell uname -r)/build +# KERNEL := /lib/modules/$(shell uname -r)/build +KERNEL := /mnt/c/Users/*****/Documents/AM62\need_on_SK-AM62/board-support/linux-5.10.153+gitAUTOINC+3eee621d16-g3eee621d16_2/build # Architecture -ARCH := arm +ARCH := arm64 #Default interface is sdio MODULE_NAME=esp32_sdio ```
git status ``` On branch master Your branch is up to date with 'origin/master'. Changes not staged for commit: (use "git add ..." to update what will be committed) (use "git restore ..." to discard changes in working directory) modified: main/sdio_slave_api.c modified: main/spi_slave_api.c modified: ../../../host/linux/host_control/c_support/Makefile modified: ../../../host/linux/host_control/c_support/test_utils.c modified: ../../../host/linux/host_control/python_support/Makefile modified: ../../../host/linux/host_control/rpi_init.sh modified: ../../../host/linux/host_driver/esp32/Makefile Untracked files: (use "git add ..." to include in what will be committed) build/ gh210_esp6mar.patch gitstatus.txt sdkconfig ../../../host/linux/host_control/spidev_disabler.dtbo no changes added to commit (use "git add" and/or "git commit -a") ```

Host Side

dmesg ``` [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 5.10.153-g3eee621d16 (root@am62xx-evm) (aarch64-none-linux-gnu-gcc (GCC) 9.2.1 20191025, GNU ld (GNU Binutils) 2.34.0.20200910) #8 SMP PREEMPT Wed Mar 1 18:19:57 UTC 2023 [ 0.000000] Machine model: Texas Instruments AM625 SK [ 0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '') [ 0.000000] printk: bootconsole [ns16550a0] enabled [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB [ 0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB [ 0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000080000000-0x000000009c7fffff] [ 0.000000] node 0: [mem 0x000000009c800000-0x000000009e6fffff] [ 0.000000] node 0: [mem 0x000000009e700000-0x000000009e77ffff] [ 0.000000] node 0: [mem 0x000000009e780000-0x000000009fffffff] [ 0.000000] node 0: [mem 0x00000000a0000000-0x00000000ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] On node 0 totalpages: 524288 [ 0.000000] DMA zone: 8192 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 524288 pages, LIFO batch:63 [ 0.000000] cma: Reserved 512 MiB at 0x00000000dd000000 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] psci: SMC Calling Convention v1.2 [ 0.000000] percpu: Embedded 22 pages/cpu s50008 r8192 d31912 u90112 [ 0.000000] pcpu-alloc: s50008 r8192 d31912 u90112 alloc=22*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 845719 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 root=PARTUUID=609e3af9-02 rw rootfstype=ext4 rootwait [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] Memory: 1456352K/2097152K available (10880K kernel code, 1148K rwdata, 4220K rodata, 1792K init, 432K bss, 116512K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 256 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000 [ 0.000000] ITS [mem 0x01820000-0x0182ffff] [ 0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS [ 0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19 [ 0.000000] ITS@0x0000000001820000: allocated 524288 Devices @80800000 (flat, esz 8, psz 64K, shr 0) [ 0.000000] ITS: using cache flushing for cmd queue [ 0.000000] GICv3: using LPI property table @0x0000000080030000 [ 0.000000] GIC: using cache flushing for LPI property table [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000080040000 [ 0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns [ 0.000004] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns [ 0.008534] Console: colour dummy device 80x25 [ 0.013128] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000) [ 0.023809] pid_max: default: 32768 minimum: 301 [ 0.028617] LSM: Security Framework initializing [ 0.033403] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.040983] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.050750] rcu: Hierarchical SRCU implementation. [ 0.055923] Platform MSI: msi-controller@1820000 domain created [ 0.062231] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created [ 0.071487] EFI services will not be available. [ 0.076401] smp: Bringing up secondary CPUs ... [ 0.089683] Detected VIPT I-cache on CPU1 [ 0.089719] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000 [ 0.089735] GICv3: CPU1: using allocated LPI pending table @0x0000000080050000 [ 0.089799] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.098460] Detected VIPT I-cache on CPU2 [ 0.098484] GICv3: CPU2: found redistributor 2 region 0:0x00000000018c0000 [ 0.098496] GICv3: CPU2: using allocated LPI pending table @0x0000000080060000 [ 0.098535] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.107158] Detected VIPT I-cache on CPU3 [ 0.107181] GICv3: CPU3: found redistributor 3 region 0:0x00000000018e0000 [ 0.107191] GICv3: CPU3: using allocated LPI pending table @0x0000000080070000 [ 0.107226] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.107302] smp: Brought up 1 node, 4 CPUs [ 0.187016] SMP: Total of 4 processors activated. [ 0.191828] CPU features: detected: 32-bit EL0 Support [ 0.197094] CPU features: detected: CRC32 instructions [ 0.209793] CPU: All CPU(s) started at EL2 [ 0.214003] alternatives: patching kernel code [ 0.219704] devtmpfs: initialized [ 0.230210] KASLR disabled due to lack of seed [ 0.234966] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.244945] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.266348] pinctrl core: initialized pinctrl subsystem [ 0.272386] DMI not present or invalid. [ 0.277000] NET: Registered protocol family 16 [ 0.283218] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations [ 0.290563] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.298632] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.307361] thermal_sys: Registered thermal governor 'step_wise' [ 0.307368] thermal_sys: Registered thermal governor 'power_allocator' [ 0.314087] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.327810] ASID allocator initialised with 65536 entries [ 0.357799] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.364680] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.371552] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.378403] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.386318] cryptd: max_cpu_qlen set to 1000 [ 0.393559] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected [ 0.402607] vcc_5v0: supplied by vmain_pd [ 0.407108] vcc_3v3_sys: supplied by vmain_pd [ 0.411994] vcc_1v8: supplied by vcc_3v3_sys [ 0.417377] iommu: Default domain type: Translated [ 0.422719] SCSI subsystem initialized [ 0.426962] mc: Linux media interface: v0.10 [ 0.431350] videodev: Linux video capture interface: v2.00 [ 0.437025] pps_core: LinuxPPS API ver. 1 registered [ 0.442101] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.451450] PTP clock support registered [ 0.455488] EDAC MC: Ver: 3.0.0 [ 0.459352] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100 [ 0.466508] FPGA manager framework [ 0.470077] Advanced Linux Sound Architecture Driver Initialized. [ 0.477230] clocksource: Switched to clocksource arch_sys_counter [ 0.483686] VFS: Disk quotas dquot_6.6.0 [ 0.487756] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.500200] NET: Registered protocol family 2 [ 0.504948] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.513675] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) [ 0.522459] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 0.530663] TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear) [ 0.538390] TCP: Hash tables configured (established 16384 bind 16384) [ 0.545304] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) [ 0.552195] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) [ 0.559676] NET: Registered protocol family 1 [ 0.564611] RPC: Registered named UNIX socket transport module. [ 0.570686] RPC: Registered udp transport module. [ 0.575521] RPC: Registered tcp transport module. [ 0.580334] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.586929] PCI: CLS 0 bytes, default 64 [ 0.591774] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [ 0.603881] Initialise system trusted keyrings [ 0.608661] workingset: timestamp_bits=46 max_order=19 bucket_order=0 [ 0.619056] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.625626] NFS: Registering the id_resolver key type [ 0.630849] Key type id_resolver registered [ 0.635126] Key type id_legacy registered [ 0.639288] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 0.646142] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 0.653906] 9p: Installing v9fs 9p2000 file system support [ 0.694858] Key type asymmetric registered [ 0.699055] Asymmetric key parser 'x509' registered [ 0.704081] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) [ 0.711647] io scheduler mq-deadline registered [ 0.716279] io scheduler kyber registered [ 0.722465] pinctrl-single 4084000.pinctrl: 34 pins, size 136 [ 0.728813] pinctrl-single f4000.pinctrl: 171 pins, size 684 [ 0.742179] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled [ 0.762341] brd: module loaded [ 0.772609] loop: module loaded [ 0.776770] megasas: 07.714.04.00-rc1 [ 0.784272] tun: Universal TUN/TAP device driver, 1.6 [ 0.790025] igbvf: Intel(R) Gigabit Virtual Function Network Driver [ 0.796450] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 0.802559] sky2: driver version 1.30 [ 0.807252] VFIO - User Level meta-driver version: 0.3 [ 0.813582] i2c /dev entries driver [ 0.818876] sdhci: Secure Digital Host Controller Interface driver [ 0.825226] sdhci: Copyright(c) Pierre Ossman [ 0.829997] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.836862] ledtrig-cpu: registered to indicate activity on CPUs [ 0.843372] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 0.851463] optee: probing for conduit method. [ 0.856069] optee: revision 3.19 (d6c5d003) [ 0.856357] optee: dynamic shared memory is enabled [ 0.866005] optee: initialized driver [ 0.871767] NET: Registered protocol family 17 [ 0.876491] 9pnet: Installing 9P2000 support [ 0.880952] Key type dns_resolver registered [ 0.885530] Loading compiled-in X.509 certificates [ 0.900814] ti-sci 44043000.system-controller: ti,ctx-memory-region is required for suspend but not provided. [ 0.910989] ti-sci 44043000.system-controller: ti_sci_init_suspend failed, mem suspend will be non-functional. [ 0.921234] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0008 '8.5.3--v08.05.03 (Chill Capybar') [ 0.986349] davinci-mcasp 2b10000.mcasp: IRQ common not found [ 0.994726] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0 [ 1.001174] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000 [ 1.010410] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz [ 1.018104] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz [ 1.024413] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created [ 1.032769] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created [ 1.042027] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created [ 1.051525] ti-udma 485c0100.dma-controller: Number of rings: 82 [ 1.059610] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18) [ 1.070709] ti-udma 485c0000.dma-controller: Number of rings: 150 [ 1.080619] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15) [ 1.090865] printk: console [ttyS2] disabled [ 1.095315] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 27, base_baud = 3000000) is a 8250 [ 1.104084] printk: console [ttyS2] enabled [ 1.112532] printk: bootconsole [ns16550a0] disabled [ 1.130266] davinci_mdio 8000f00.mdio: Configuring MDIO in manual mode [ 1.173233] davinci_mdio 8000f00.mdio: davinci mdio revision 9.7, bus freq 1000000 [ 1.182907] davinci_mdio 8000f00.mdio: phy[0]: device 8000f00.mdio:00, driver TI DP83867 [ 1.191008] davinci_mdio 8000f00.mdio: phy[1]: device 8000f00.mdio:01, driver TI DP83867 [ 1.199188] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000002 [ 1.212033] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5 [ 1.219162] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512 [ 1.225869] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:0 [ 1.238288] rtc-ti-k3 2b1f0000.rtc: registered as rtc0 [ 1.243488] rtc-ti-k3 2b1f0000.rtc: setting system clock to 1970-01-01T00:00:07 UTC (7) [ 1.356003] mmc0: CQHCI version 5.10 [ 1.357570] pinctrl-single f4000.pinctrl: pin PIN33 already requested by 20100000.spi; cannot claim for 2b10000.mcasp [ 1.370214] pinctrl-single f4000.pinctrl: pin-33 (2b10000.mcasp) status -22 [ 1.377170] pinctrl-single f4000.pinctrl: could not request pin 33 (PIN33) from group main-mcasp1-pins-default on device pinctrl-single [ 1.389408] davinci-mcasp 2b10000.mcasp: Error applying setting, reverse things back [ 1.397157] davinci-mcasp: probe of 2b10000.mcasp failed with error -22 [ 1.405306] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit [ 1.412988] pca953x 1-0022: supply vcc not found, using dummy regulator [ 1.419813] pca953x 1-0022: using AI [ 1.448669] sii902x 1-003b: supply iovcc not found, using dummy regulator [ 1.455594] sii902x 1-003b: supply cvcc12 not found, using dummy regulator [ 1.465372] i2c i2c-1: Added multiplexed i2c bus 2 [ 1.472297] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0 [ 1.480041] tidss 30200000.dss: [drm] Cannot find any crtc or sizes [ 1.489000] vdd_mmc1: supplied by vcc_3v3_sys [ 1.494961] mmc0: Command Queue Engine enabled [ 1.495439] wlan_lten: supplied by vcc_3v3_sys [ 1.499431] mmc0: new HS200 MMC card at address 0001 [ 1.505702] debugfs: Directory 'pd:53' with parent 'pm_genpd' already present! [ 1.509541] mmcblk0: mmc0:0001 S0J56X 14.8 GiB [ 1.516152] wlan_en: supplied by wlan_lten [ 1.516229] debugfs: Directory 'pd:52' with parent 'pm_genpd' already present! [ 1.516285] debugfs: Directory 'pd:51' with parent 'pm_genpd' already present! [ 1.516620] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present! [ 1.516704] mmc1: CQHCI version 5.10 [ 1.520880] mmcblk0boot0: mmc0:0001 S0J56X partition 1 31.5 MiB [ 1.525024] mmc2: CQHCI version 5.10 [ 1.528363] ALSA device list: [ 1.528367] No soundcards found. [ 1.532149] mmcblk0boot1: mmc0:0001 S0J56X partition 2 31.5 MiB [ 1.555896] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit [ 1.556074] mmcblk0rpmb: mmc0:0001 S0J56X partition 3 4.00 MiB, chardev (237:0) [ 1.579839] mmc2: SDHCI controller on fa20000.mmc [fa20000.mmc] using ADMA 64-bit [ 1.589629] mmcblk0: p1 p2 [ 1.599154] sdhci-am654 fa20000.mmc: card claims to support voltages below defined range [ 1.599611] Waiting for root device PARTUUID=609e3af9-02... [ 1.614913] mmc1: new ultra high speed SDR104 SDXC card at address 59b4 [ 1.622265] mmcblk1: mmc1:59b4 EC1S5 59.7 GiB [ 1.624669] mmc2: new high speed SDIO card at address 0001 [ 1.628597] mmcblk1: p1 p2 [ 1.788000] EXT4-fs (mmcblk1p2): recovery complete [ 1.794145] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) [ 1.802315] VFS: Mounted root (ext4 filesystem) on device 179:98. [ 1.809280] devtmpfs: mounted [ 1.813474] Freeing unused kernel memory: 1792K [ 1.818094] Run /sbin/init as init process [ 1.822182] with arguments: [ 1.822185] /sbin/init [ 1.822188] with environment: [ 1.822191] HOME=/ [ 1.822193] TERM=linux [ 1.937189] systemd[1]: System time before build time, advancing clock. [ 2.269051] NET: Registered protocol family 10 [ 2.274628] Segment Routing with IPv6 [ 2.299177] systemd[1]: systemd 244.5+ 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) [ 2.321269] systemd[1]: Detected architecture arm64. [ 2.362023] systemd[1]: Set hostname to . [ 2.576514] systemd[1]: /lib/systemd/system/startwlansta.service:7: Unknown key name 'After' in section 'Service', ignoring. [ 2.588729] systemd[1]: /lib/systemd/system/startwlanap.service:7: Unknown key name 'After' in section 'Service', ignoring. [ 2.624681] systemd[1]: /lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock \xe2\x86\x92 /run/docker.sock; please update the unit file accordingly. [ 2.717541] random: systemd: uninitialized urandom read (16 bytes read) [ 2.724491] systemd[1]: system-getty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [ 2.736837] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [ 2.748556] systemd[1]: Created slice system-getty.slice. [ 2.769421] random: systemd: uninitialized urandom read (16 bytes read) [ 2.777768] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 2.801402] random: systemd: uninitialized urandom read (16 bytes read) [ 2.809437] systemd[1]: Created slice User and Session Slice. [ 2.829720] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 2.853547] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 2.877517] systemd[1]: Reached target Paths. [ 2.893383] systemd[1]: Reached target Remote File Systems. [ 2.913340] systemd[1]: Reached target Slices. [ 2.929355] systemd[1]: Reached target Swap. [ 2.951006] systemd[1]: Listening on RPCbind Server Activation Socket. [ 2.973503] systemd[1]: Reached target RPC Port Mapper. [ 2.997812] systemd[1]: Listening on Process Core Dump Socket. [ 3.021729] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 3.052664] systemd[1]: Condition check resulted in Journal Audit Socket being skipped. [ 3.061612] systemd[1]: Listening on Journal Socket (/dev/log). [ 3.089991] systemd[1]: Listening on Journal Socket. [ 3.106134] systemd[1]: Listening on Network Service Netlink Socket. [ 3.129897] systemd[1]: Listening on udev Control Socket. [ 3.149718] systemd[1]: Listening on udev Kernel Socket. [ 3.174262] systemd[1]: Mounting Huge Pages File System... [ 3.193913] systemd[1]: Mounting POSIX Message Queue File System... [ 3.221945] systemd[1]: Mounting Kernel Debug File System... [ 3.242218] systemd[1]: Mounting Temporary Directory (/tmp)... [ 3.262204] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 3.289951] systemd[1]: Starting Start psplash boot splash screen... [ 3.319063] systemd[1]: Starting RPC Bind... [ 3.333817] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. [ 3.348247] systemd[1]: Starting Journal Service... [ 3.374597] systemd[1]: Starting Load Kernel Modules... [ 3.394517] systemd[1]: Starting Remount Root and Kernel File Systems... [ 3.421998] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null) [ 3.423894] systemd[1]: Starting udev Coldplug all Devices... [ 3.452668] systemd[1]: Started RPC Bind. [ 3.466192] systemd[1]: Started Journal Service. [ 3.606753] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 3.644262] Bridge firewalling registered [ 3.652449] cryptodev: loading out-of-tree module taints kernel. [ 3.660253] cryptodev: driver 1.10 loaded. [ 3.683110] systemd-journald[194]: Received client request to flush runtime journal. [ 3.770418] random: systemd: uninitialized urandom read (16 bytes read) [ 3.793578] random: systemd: uninitialized urandom read (16 bytes read) [ 3.807028] random: systemd-journal: uninitialized urandom read (16 bytes read) [ 4.349731] random: crng init done [ 4.353184] random: 64 urandom warning(s) missed due to ratelimiting [ 4.645625] k3-m4-rproc 5000000.m4fss: assigned reserved memory node m4f-dma-memory@9cb00000 [ 4.684005] k3-m4-rproc 5000000.m4fss: configured M4 for remoteproc mode [ 4.693547] k3-m4-rproc 5000000.m4fss: local reset is deasserted for device [ 4.705543] remoteproc remoteproc0: 5000000.m4fss is available [ 4.727981] remoteproc remoteproc0: powering up 5000000.m4fss [ 4.733867] remoteproc remoteproc0: Booting fw image am62-mcu-m4f0_0-fw, size 78960 [ 4.743671] remoteproc0#vdev0buffer: assigned reserved memory node m4f-dma-memory@9cb00000 [ 4.752468] remoteproc0#vdev0buffer: registered virtio0 (type 7) [ 4.759092] remoteproc remoteproc0: remote processor 5000000.m4fss is now up [ 4.832112] virtio_rpmsg_bus virtio0: rpmsg host is online [ 4.832744] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xd [ 4.849651] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xe [ 4.934101] platform 78000000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1) [ 4.949416] platform 78000000.r5f: configured R5F for IPC-only mode [ 4.958208] platform 78000000.r5f: assigned reserved memory node r5f-dma-memory@9da00000 [ 4.973727] remoteproc remoteproc1: 78000000.r5f is available [ 4.989006] remoteproc remoteproc1: attaching to 78000000.r5f [ 5.005591] PVR_K: 221: Read BVNC 33.15.11.3 from HW device registers [ 5.015418] PVR_K: 221: RGX Device registered with BVNC 33.15.11.3 [ 5.029727] platform 78000000.r5f: R5F core initialized in IPC-only mode [ 5.054675] remoteproc1#vdev0buffer: assigned reserved memory node r5f-dma-memory@9da00000 [ 5.067058] virtio_rpmsg_bus virtio1: rpmsg host is online [ 5.072616] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xd [ 5.076920] remoteproc1#vdev0buffer: registered virtio1 (type 7) [ 5.084741] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xe [ 5.086896] remoteproc remoteproc1: remote processor 78000000.r5f is now attached [ 5.138880] [drm] Initialized pvr 1.15.6133109 20170530 for fd00000.gpu on minor 1 [ 6.086938] remoteproc remoteproc2: 30074000.pru is available [ 6.103361] remoteproc remoteproc3: 30078000.pru is available [ 6.176237] cdns-csi2rx: probe of 30101000.csi-bridge failed with error -22 [ 6.256782] tps6598x 0-003f: Unable to find the interrupt, switching to polling [ 6.484049] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 6.500533] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 6.512038] usbcore: registered new interface driver usbfs [ 6.517944] usbcore: registered new interface driver hub [ 6.529090] usbcore: registered new device driver usb [ 6.687845] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller [ 6.693448] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 1 [ 6.701417] xhci-hcd xhci-hcd.3.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000002000010010 [ 6.710985] xhci-hcd xhci-hcd.3.auto: irq 480, io mem 0x31100000 [ 6.717523] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 [ 6.725867] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 6.733166] usb usb1: Product: xHCI Host Controller [ 6.738122] usb usb1: Manufacturer: Linux 5.10.153-g3eee621d16 xhci-hcd [ 6.744757] usb usb1: SerialNumber: xhci-hcd.3.auto [ 6.750404] hub 1-0:1.0: USB hub found [ 6.754352] hub 1-0:1.0: 1 port detected [ 6.761977] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller [ 6.767545] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 2 [ 6.775305] xhci-hcd xhci-hcd.3.auto: Host supports USB 3.0 SuperSpeed [ 6.782123] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 6.790504] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 [ 6.798912] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 6.806208] usb usb2: Product: xHCI Host Controller [ 6.811184] usb usb2: Manufacturer: Linux 5.10.153-g3eee621d16 xhci-hcd [ 6.817882] usb usb2: SerialNumber: xhci-hcd.3.auto [ 6.823579] hub 2-0:1.0: USB hub found [ 6.827478] hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19) [ 7.332953] wl18xx_driver wl18xx.2.auto: Direct firmware load for ti-connectivity/wl1271-nvs.bin failed with error -2 [ 7.689835] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11) [ 7.703740] wlcore: loaded [ 8.541124] wlcore: using inverted interrupt logic: 2 [ 8.612541] wlcore: PHY firmware version: Rev 8.2.0.0.245 [ 8.713445] wlcore: firmware booted (Rev 8.9.0.0.86) [ 8.748723] am65-cpsw-nuss 8000000.ethernet: down msc_sl e0000000 tmo 0 [ 8.923495] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19 [ 8.974673] am65-cpsw-nuss 8000000.ethernet eth1: PHY [8000f00.mdio:01] driver [TI DP83867] (irq=POLL) [ 8.999693] am65-cpsw-nuss 8000000.ethernet eth1: configuring for phy/rgmii-rxid link mode [ 9.057695] am65-cpsw-nuss 8000000.ethernet: down msc_sl e0000000 tmo 0 [ 9.081140] am65-cpsw-nuss 8000000.ethernet eth0: PHY [8000f00.mdio:00] driver [TI DP83867] (irq=POLL) [ 9.093476] am65-cpsw-nuss 8000000.ethernet eth0: configuring for phy/rgmii-rxid link mode [ 9.580154] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 12.732581] PVR_K: 1055: RGX Firmware image 'rgx.fw.33.15.11.3' loaded [ 12.758689] PVR_K: 1055: Shader binary image 'rgx.sh.33.15.11.3' loaded [ 19.326055] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [ 19.334892] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 129.118583] Initializing XFRM netlink socket [ 130.775644] process 'docker/tmp/qemu-check895816168/check' started with executable stack [ 323.893447] Bluetooth: Core ver 2.22 [ 323.897298] NET: Registered protocol family 31 [ 323.901825] Bluetooth: HCI device and connection manager initialized [ 323.908215] Bluetooth: HCI socket layer initialized [ 323.913106] Bluetooth: L2CAP socket layer initialized [ 323.918189] Bluetooth: SCO socket layer initialized [ 377.622485] esp_reset, ESP32: Resetpin of Host is 432 [ 377.622717] esp_reset, ESP32: Triggering ESP reset. [ 377.623468] ESP32 peripheral is registered to SPI bus [3],chip select [0], SPI Clock [10] ```
git status ``` On branch master Your branch is up to date with 'origin/master'. Changes not staged for commit: (use "git add ..." to update what will be committed) (use "git restore ..." to discard changes in working directory) modified: ../../../esp/esp_driver/network_adapter/main/spi_slave_api.c modified: c_support/Makefile modified: rpi_init.sh modified: spidev_disabler.dts modified: ../host_driver/esp32/spi/esp_spi.c modified: ../host_driver/esp32/spi/esp_spi.h Untracked files: (use "git add ..." to include in what will be committed) 432 c_support/test.out gitstatus.log python_support/commands.so spidev_disabler.dtbo ../host_driver/esp32/.Module.symvers.cmd ../host_driver/esp32/.esp32_spi.ko.cmd ../host_driver/esp32/.esp32_spi.mod.cmd ../host_driver/esp32/.esp32_spi.mod.o.cmd ../host_driver/esp32/.esp32_spi.o.cmd ../host_driver/esp32/.esp_bt.o.cmd ../host_driver/esp32/.esp_rb.o.cmd ../host_driver/esp32/.esp_serial.o.cmd ../host_driver/esp32/.esp_stats.o.cmd ../host_driver/esp32/.main.o.cmd ../host_driver/esp32/.modules.order.cmd ../host_driver/esp32/Module.symvers ../host_driver/esp32/esp32_spi.ko ../host_driver/esp32/esp32_spi.mod ../host_driver/esp32/esp32_spi.mod.c ../host_driver/esp32/esp32_spi.mod.o ../host_driver/esp32/esp32_spi.o ../host_driver/esp32/esp_bt.o ../host_driver/esp32/esp_rb.o ../host_driver/esp32/esp_serial.o ../host_driver/esp32/esp_stats.o ../host_driver/esp32/main.o ../host_driver/esp32/modules.order ../host_driver/esp32/spi/.esp_spi.o.cmd ../host_driver/esp32/spi/esp_spi.o no changes added to commit (use "git add" and/or "git commit -a") ```
git diff ``` diff --git a/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c b/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c index f248fab..9e29c2f 100644 --- a/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c +++ b/esp_hosted_fg/esp/esp_driver/network_adapter/main/spi_slave_api.c @@ -553,7 +553,7 @@ static interface_handle_t * esp_spi_init(void) /* Configuration for the SPI slave interface */ spi_slave_interface_config_t slvcfg={ - .mode=SPI_MODE_2, + .mode=SPI_MODE_3, .spics_io_num=GPIO_CS, .queue_size=SPI_QUEUE_SIZE, .flags=0, diff --git a/esp_hosted_fg/host/linux/host_control/c_support/Makefile b/esp_hosted_fg/host/linux/host_control/c_support/Makefile index 660482d..a74e3c7 100644 --- a/esp_hosted_fg/host/linux/host_control/c_support/Makefile +++ b/esp_hosted_fg/host/linux/host_control/c_support/Makefile @@ -39,7 +39,7 @@ SRC += ./test_utils.c all: test test: - $(CROSS_COMPILE)$(CC) $(CFLAGS) $(INCLUDE) $(SRC) $(LINKER) $(@).c -o $(@).out + $(CROSS_COMPILE)$(CC) -g $(CFLAGS) $(INCLUDE) $(SRC) $(LINKER) $(@).c -o $(@).out stress: $(CROSS_COMPILE)$(CC) $(CFLAGS) $(CFLAGS_SANITIZE) $(INCLUDE) $(SRC) $(LINKER) $(@).c -o $(@).out -ggdb3 -g diff --git a/esp_hosted_fg/host/linux/host_control/rpi_init.sh b/esp_hosted_fg/host/linux/host_control/rpi_init.sh index 117daa6..ad90193 100755 --- a/esp_hosted_fg/host/linux/host_control/rpi_init.sh +++ b/esp_hosted_fg/host/linux/host_control/rpi_init.sh @@ -22,25 +22,31 @@ MODULE_NAME="esp32_${IF_TYPE}.ko" build_c_demo_app() { + echo "build_c_demo_app()" cd c_support/ - make clean - make -j8 - make -j8 stress +# make clean +# make -j4 +# make -j4 stress + make ARCH=arm64 CROSS_COMPILE=aarch64-none-linux-gnu- clean + make ARCH=arm64 CROSS_COMPILE=aarch64-none-linux-gnu- -j4 + make ARCH=arm64 CROSS_COMPILE=aarch64-none-linux-gnu- -j4 stress cd .. } build_python_demo_app() { - cd python_support/ - make clean - make -j8 - cd .. + echo "build_python_demo_app()" +# cd python_support/ +# make clean +# make -j4 +# cd .. } wlan_init() { + echo "wlan_init()" build_c_demo_app - build_python_demo_app +# build_python_demo_app cd ../host_driver/esp32/ if [ `lsmod | grep esp32 | wc -l` != "0" ]; then @@ -62,14 +68,17 @@ wlan_init() # CROSS_COMPILE -> /bin/arm-linux-gnueabihf- # KERNEL -> Place where kernel is checked out and built # ARCH -> Architecture - make -j8 target=$IF_TYPE CROSS_COMPILE=/usr/bin/arm-linux-gnueabihf- KERNEL="/lib/modules/$(uname -r)/build" \ - CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm + # make -j8 target=$IF_TYPE CROSS_COMPILE=/usr/bin/arm-linux-gnueabihf- KERNEL="/lib/modules/$(uname -r)/build" \ + # CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm + make -j8 target=$IF_TYPE CROSS_COMPILE=aarch64-none-linux-gnu- KERNEL="/lib/modules/$(uname -r)/build" \ + CONFIG_TEST_RAW_TP="$VAL_CONFIG_TEST_RAW_TP" ARCH=arm64 if [ "$RESETPIN" = "" ] ; then #By Default, BCM6 is GPIO on host. use resetpin=6 sudo insmod $MODULE_NAME resetpin=6 else #Use resetpin value from argument + echo "resetpin is" $RESETPIN sudo insmod $MODULE_NAME $RESETPIN fi if [ `lsmod | grep esp32 | wc -l` != "0" ]; then @@ -83,6 +92,7 @@ wlan_init() bt_init() { + echo "bt_init()" sudo raspi-gpio set 15 a0 pu sudo raspi-gpio set 14 a0 pu if [ "$BT_INIT_SET" = "4" ] ; then @@ -93,6 +103,7 @@ bt_init() usage() { + echo "usage()" echo "This script prepares RPI for wlan and bt/ble operation over esp32 device" echo "\nUsage: ./rpi_init.sh [arguments]" echo "\nArguments are optional and are as below" @@ -116,6 +127,7 @@ usage() parse_arguments() { + echo "parse_arguments()" while [ "$1" != "" ] ; do case $1 in --help | -h ) @@ -166,10 +178,11 @@ else fi if [ "$IF_TYPE" = "spi" ] ; then - rm spidev_disabler.dtbo + echo "spidev_disabler skipped." + # rm spidev_disabler.dtbo # Disable default spidev driver - dtc spidev_disabler.dts -O dtb > spidev_disabler.dtbo - sudo dtoverlay -d . spidev_disabler + # dtc spidev_disabler.dts -O dtb > spidev_disabler.dtbo + # sudo dtoverlay -d . spidev_disabler fi if [ `lsmod | grep bluetooth | wc -l` = "0" ]; then diff --git a/esp_hosted_fg/host/linux/host_control/spidev_disabler.dts b/esp_hosted_fg/host/linux/host_control/spidev_disabler.dts index 664ecb9..c27f532 100644 --- a/esp_hosted_fg/host/linux/host_control/spidev_disabler.dts +++ b/esp_hosted_fg/host/linux/host_control/spidev_disabler.dts @@ -5,7 +5,7 @@ compatible = "brcm,bcm2708"; fragment@0 { - target = <&spidev0>; + target = <&main_spi0>; __overlay__ { status = "disabled"; diff --git a/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.c b/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.c index a320a09..fb64122 100644 --- a/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.c +++ b/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.c @@ -76,18 +76,25 @@ static void close_data_path(void) static irqreturn_t spi_data_ready_interrupt_handler(int irq, void * dev) { + printk("spi_data_ready_interrupt_handler\n"); /* ESP peripheral has queued buffer for transmission */ if (spi_context.spi_workqueue) queue_work(spi_context.spi_workqueue, &spi_context.spi_work); + + printk("spi_data_ready_interrupt_handler OK\n"); return IRQ_HANDLED; } static irqreturn_t spi_interrupt_handler(int irq, void * dev) { + printk("spi_interrupt_handler\n"); /* ESP peripheral is ready for next SPI transaction */ if (spi_context.spi_workqueue) queue_work(spi_context.spi_workqueue, &spi_context.spi_work); + + + printk("spi_interrupt_handler OK\n"); return IRQ_HANDLED; } @@ -365,7 +372,7 @@ static int spi_dev_init(int spi_clk_mhz) strlcpy(esp_board.modalias, "esp_spi", sizeof(esp_board.modalias)); esp_board.mode = SPI_MODE_2; esp_board.max_speed_hz = spi_clk_mhz * NUMBER_1M; - esp_board.bus_num = 0; + esp_board.bus_num = 3; esp_board.chip_select = 0; master = spi_busnum_to_master(esp_board.bus_num); diff --git a/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.h b/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.h index c6a41bd..f85b3f0 100644 --- a/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.h +++ b/esp_hosted_fg/host/linux/host_driver/esp32/spi/esp_spi.h @@ -19,9 +19,9 @@ #include "esp.h" -#define HANDSHAKE_PIN 22 +#define HANDSHAKE_PIN 431 #define SPI_IRQ gpio_to_irq(HANDSHAKE_PIN) -#define SPI_DATA_READY_PIN 27 +#define SPI_DATA_READY_PIN 441 #define SPI_DATA_READY_IRQ gpio_to_irq(SPI_DATA_READY_PIN) #define SPI_BUF_SIZE 1600 ```
ifconfig ``` docker0: flags=4099 mtu 1500 metric 1 inet 172.17.0.1 netmask 255.255.0.0 broadcast 172.17.255.255 ether 02:42:bb:23:6d:64 txqueuelen 0 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 eth0: flags=4163 mtu 1500 metric 1 inet 192.168.2.100 netmask 255.255.255.0 broadcast 192.168.2.255 inet6 fe80::3608:e1ff:fe7e:912d prefixlen 64 scopeid 0x20 ether 34:08:e1:7e:91:2d txqueuelen 1000 (Ethernet) RX packets 18 bytes 1680 (1.6 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 466 bytes 26790 (26.1 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 eth1: flags=4099 mtu 1500 metric 1 ether 70:ff:76:1e:a8:10 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 ethap0: flags=4098 mtu 1500 metric 1 ether 00:00:00:00:00:00 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 ethsta0: flags=4098 mtu 1500 metric 1 ether 00:00:00:00:00:00 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 lo: flags=73 mtu 65536 metric 1 inet 127.0.0.1 netmask 255.0.0.0 inet6 ::1 prefixlen 128 scopeid 0x10 loop txqueuelen 1000 (Local Loopback) RX packets 496 bytes 43480 (42.4 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 496 bytes 43480 (42.4 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4099 mtu 1500 metric 1 ether e0:ff:f1:38:4b:01 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 0 bytes 0 (0.0 B) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan1: flags=4163 mtu 1500 metric 1 inet 192.168.43.1 netmask 255.255.255.0 broadcast 192.168.43.255 inet6 fe80::e2ff:f1ff:fe38:4b02 prefixlen 64 scopeid 0x20 ether e0:ff:f1:38:4b:02 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 43 bytes 5946 (5.8 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 ```

When observed with an oscilloscope, the reset pin goes low for a moment when loaded, and it seems that the reset is actually done, but there is no response after that.

mantriyogesh commented 1 year ago

Hello @take-42

Thank you for using ESP-Hosted.

Getting bit confused, if you intend to use SDIO or SPI? You are using 0.0.5 with FG solution with 'SDIO only' transport combination as per your firmware log. SDIO firmware cannot work with SPI host driver.

take-42 commented 1 year ago

Hello, @mantriyogesh. Thank you for pointing this out. It seems I made an elementary mistake. I changed the following to assume SPI and flashed again to run the test, but the "Response not received" remained.

  1. build and flash SPI firmware $ idf.py menuconfig Example Configuration -> Transport layer -> [X] SPI interface

  2. keep same SPI mode at both the sides SPI_MODE is changed to the same value as the initial (both SPI_MODE_2)

mantriyogesh commented 1 year ago

No issues @take-42

Can you please provide the logs at both ends?

mantriyogesh commented 1 year ago

esp $ idf.py flash monitor log and dmesg or /var/log/messages or /var/log/kern/log at host

mantriyogesh commented 1 year ago

By the time, I checked your other logs. Please disable config for wlan0 and wlan1, once your get the ethsta0 working from host driver. We recommend to do it such that on boot always it is disabled.

I am not sure if spidev_disabler.dts changes will be usable by your Linux (it is Raspberry Pi specific). You might have to see the device tree changes. Where SPI bus is enabled and spidev for that bus and chip select is disabled.

Ideally it could be done in following steps:

  1. Make sure the length of jumper cables is small, typically < 6cm, all same length. Smaller the better. PCB the best. Connect the correct connections and make sure they are firm.
  2. Enable Device tree, do not disable spidev
  3. $ ls /dev/spidev* should list available SPI devices. Test /dev/spidevX.Y where X is 3 and Y is 0 in your case with Rx & Tx. This will confirm the PSI pins loopback are working fine or not.
  4. Disable the spidev from device tree. you should now will not see output for your disabled device(s). Basically in your case once spidev disabled, /dev/spidev3.0 should be gone.
  5. Now Verify your Data read, handshake and reset pin are working or now. I think you have already made the changes in the esp_spi.h for this. But make sure if you get the prints in interrupt handlers for data ready and handshake (I noticed you have added logs in interrupt handlers already) You can change these logs like below, which will make sure that log will be printed always

printk(KERN_ERR "%s:%u\n", func,LINE);

  1. Verify resetpin (ESP should reset on loading of kernel module) (I think you have done this already?)

Lets get synced till this point, then will move ahead.

Milestones:

  1. SPI pins verified
  2. Handshake & data ready & reset pin verified with their expected way
  3. Bootup or init log received in host dmesg or /var/log/kern.log or /var/log/messages (check documentation, it will show sample log of events received)
  4. Interrupt logs printed
  5. remove all debugs (make everything slow) and get ethsta0 up. assign static ip and test pin with your connected AP (Wi-Fi router)
mantriyogesh commented 1 year ago

any updates please?

take-42 commented 1 year ago

Hello, @mantriyogesh Sorry for the delay in replying. I will not be able to work for a few days due to other work, but here is what I can confirm at this time.

All jump wires are 10 cm.

Device tree SPI so if status is okay, /dev/spidev3.0 appears and can be sent/received manually. if status is disabled, it will not appear.

GPIO pins used for DataReady, HandShake, and Reset are enabled, and reset works when the module is loaded (observe low for a moment on the oscilloscope, and the startup log is played)

mantriyogesh commented 1 year ago

Hello @take-42 ,

The current logs (Esp and host) will be useful to find out if any obvious misbehavior.

If you are going to take some time, we can close this issue and re-open once you are back.

take-42 commented 1 year ago

ESP and dmsesg logs. The following is a list of the logs.

Since the printk statement you gave me would result in an undeclared error, I typed out the function name in solid type as follows printk( KERN_ERR "spi_data_ready_interupt_handler\n" );

ESP ``` I (0) cpu_start: App cpu up. I (498) cpu_start: Pro cpu start user code I (498) cpu_start: cpu freq: 240000000 I (498) cpu_start: Application information: I (503) cpu_start: Project name: network_adapter I (508) cpu_start: App version: release/ng-v1.0.2-10-gfe0b105-d I (515) cpu_start: Compile time: Mar 7 2023 12:53:05 I (522) cpu_start: ELF file SHA256: f4469ae4d8f6acb2... I (527) cpu_start: ESP-IDF: v4.4.1-dirty I (533) heap_init: Initializing. RAM available for dynamic allocation: I (540) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM I (546) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM I (552) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM I (558) heap_init: At 3FFC89F0 len 00017610 (93 KiB): DRAM I (565) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM I (571) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM I (577) heap_init: At 4009DBB0 len 00002450 (9 KiB): IRAM I (585) spi_flash: detected chip: generic I (588) spi_flash: flash io: dio I (593) cpu_start: Starting scheduler on PRO CPU. I (0) cpu_start: Starting scheduler on APP CPU. I (607) NETWORK_ADAPTER: ********************************************************************* I (613) NETWORK_ADAPTER: ESP-Hosted-FG Firmware version :: 0.0.5 I (621) NETWORK_ADAPTER: Transport used :: SPI only I (629) NETWORK_ADAPTER: ********************************************************************* I (637) NETWORK_ADAPTER: Supported features are: I (641) NETWORK_ADAPTER: - WLAN over SPI I (645) ESP_BT: - BT/BLE I (647) ESP_BT: - HCI Over SPI I (649) ESP_BT: - BT/BLE dual mode I (653) NETWORK_ADAPTER: capabilities: 0xf8 I (665) BTDM_INIT: BT controller compile version [5688ed5] I (667) system_api: Base MAC address is not set I (667) system_api: read default base MAC address from EFUSE I (673) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07 I (999) NETWORK_ADAPTER: ESP Bluetooth MAC addr: 8c:4b:14:15:a4:22 I (1001) SPI_DRIVER: Using SPI interface I (1001) gpio: GPIO[2]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 I (1009) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 I (1015) SPI_DRIVER: SPI Ctrl:1 mode: 2, InitFreq: 10MHz, ReqFreq: 10MHz GPIOs: MOSI: 13, MISO: 12, CS: 15, CLK: 14 HS: 2 DR: 4 I (1025) SPI_DRIVER: Hosted SPI queue size: Tx:10 Rx:10 I (1035) wifi:wifi driver task: 3ffd7ba4, prio:23, stack:6656, core=1 I (1037) wifi:wifi firmware version: 63017e0 I (1039) wifi:wifi certification version: v7.0 I (1041) wifi:config NVS flash: disabled I (1045) wifi:config nano formating: disabled I (1047) wifi:Init data frame dynamic rx buffer num: 32 I (1051) wifi:Init management frame dynamic rx buffer num: 32 I (1057) wifi:Init management short buffer num: 32 I (1059) wifi:Init dynamic tx buffer num: 64 I (1063) wifi:Init static rx buffer size: 1600 I (1067) wifi:Init static rx buffer num: 16 I (1069) wifi:Init dynamic rx buffer num: 32 I (1073) wifi_init: rx ba win: 6 I (1075) wifi_init: tcpip mbox: 32 I (1079) wifi_init: udp mbox: 6 I (1081) wifi_init: tcp mbox: 6 I (1085) wifi_init: tcp tx win: 5744 I (1089) wifi_init: tcp rx win: 5744 I (1091) wifi_init: tcp mss: 1440 I (1095) wifi_init: WiFi IRAM OP enabled I (1099) wifi_init: WiFi RX IRAM OP enabled I (1105) wifi:mode : null I (1105) NETWORK_ADAPTER: Initial set up done I (1109) slave_ctrl: event ESPInit ```
dmesg ``` [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 5.10.153-g3eee621d16 (root@am62xx-evm) (aarch64-none-linux-gnu-gcc (GCC) 9.2.1 20191025, GNU ld (GNU Binutils) 2.34.0.20200910) #8 SMP PREEMPT Wed Mar 1 18:19:57 UTC 2023 [ 0.000000] Machine model: Texas Instruments AM625 SK [ 0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '') [ 0.000000] printk: bootconsole [ns16550a0] enabled [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB [ 0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB [ 0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000080000000-0x000000009c7fffff] [ 0.000000] node 0: [mem 0x000000009c800000-0x000000009e6fffff] [ 0.000000] node 0: [mem 0x000000009e700000-0x000000009e77ffff] [ 0.000000] node 0: [mem 0x000000009e780000-0x000000009fffffff] [ 0.000000] node 0: [mem 0x00000000a0000000-0x00000000ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] On node 0 totalpages: 524288 [ 0.000000] DMA zone: 8192 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 524288 pages, LIFO batch:63 [ 0.000000] cma: Reserved 512 MiB at 0x00000000dd000000 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] psci: SMC Calling Convention v1.2 [ 0.000000] percpu: Embedded 22 pages/cpu s50008 r8192 d31912 u90112 [ 0.000000] pcpu-alloc: s50008 r8192 d31912 u90112 alloc=22*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 845719 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 root=PARTUUID=609e3af9-02 rw rootfstype=ext4 rootwait [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] Memory: 1456352K/2097152K available (10880K kernel code, 1148K rwdata, 4220K rodata, 1792K init, 432K bss, 116512K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 256 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000 [ 0.000000] ITS [mem 0x01820000-0x0182ffff] [ 0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS [ 0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19 [ 0.000000] ITS@0x0000000001820000: allocated 524288 Devices @80800000 (flat, esz 8, psz 64K, shr 0) [ 0.000000] ITS: using cache flushing for cmd queue [ 0.000000] GICv3: using LPI property table @0x0000000080030000 [ 0.000000] GIC: using cache flushing for LPI property table [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000080040000 [ 0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns [ 0.000005] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns [ 0.008532] Console: colour dummy device 80x25 [ 0.013124] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000) [ 0.023806] pid_max: default: 32768 minimum: 301 [ 0.028616] LSM: Security Framework initializing [ 0.033402] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.040982] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.050743] rcu: Hierarchical SRCU implementation. [ 0.055921] Platform MSI: msi-controller@1820000 domain created [ 0.062236] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created [ 0.071493] EFI services will not be available. [ 0.076408] smp: Bringing up secondary CPUs ... [ 0.089697] Detected VIPT I-cache on CPU1 [ 0.089734] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000 [ 0.089748] GICv3: CPU1: using allocated LPI pending table @0x0000000080050000 [ 0.089812] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.098469] Detected VIPT I-cache on CPU2 [ 0.098493] GICv3: CPU2: found redistributor 2 region 0:0x00000000018c0000 [ 0.098505] GICv3: CPU2: using allocated LPI pending table @0x0000000080060000 [ 0.098543] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.107168] Detected VIPT I-cache on CPU3 [ 0.107192] GICv3: CPU3: found redistributor 3 region 0:0x00000000018e0000 [ 0.107203] GICv3: CPU3: using allocated LPI pending table @0x0000000080070000 [ 0.107237] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.107309] smp: Brought up 1 node, 4 CPUs [ 0.187024] SMP: Total of 4 processors activated. [ 0.191835] CPU features: detected: 32-bit EL0 Support [ 0.197102] CPU features: detected: CRC32 instructions [ 0.209766] CPU: All CPU(s) started at EL2 [ 0.213976] alternatives: patching kernel code [ 0.219691] devtmpfs: initialized [ 0.230189] KASLR disabled due to lack of seed [ 0.234947] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.244927] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.266281] pinctrl core: initialized pinctrl subsystem [ 0.272310] DMI not present or invalid. [ 0.276923] NET: Registered protocol family 16 [ 0.283155] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations [ 0.290504] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.298575] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.307298] thermal_sys: Registered thermal governor 'step_wise' [ 0.307304] thermal_sys: Registered thermal governor 'power_allocator' [ 0.314023] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.327746] ASID allocator initialised with 65536 entries [ 0.357692] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.364570] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.371442] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.378294] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.386210] cryptd: max_cpu_qlen set to 1000 [ 0.393447] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected [ 0.402506] vcc_5v0: supplied by vmain_pd [ 0.407010] vcc_3v3_sys: supplied by vmain_pd [ 0.411892] vcc_1v8: supplied by vcc_3v3_sys [ 0.417265] iommu: Default domain type: Translated [ 0.422602] SCSI subsystem initialized [ 0.426842] mc: Linux media interface: v0.10 [ 0.431229] videodev: Linux video capture interface: v2.00 [ 0.436903] pps_core: LinuxPPS API ver. 1 registered [ 0.441979] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.451328] PTP clock support registered [ 0.455365] EDAC MC: Ver: 3.0.0 [ 0.459232] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100 [ 0.466394] FPGA manager framework [ 0.469963] Advanced Linux Sound Architecture Driver Initialized. [ 0.477110] clocksource: Switched to clocksource arch_sys_counter [ 0.483560] VFS: Disk quotas dquot_6.6.0 [ 0.487626] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.500042] NET: Registered protocol family 2 [ 0.504791] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.513527] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) [ 0.522311] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 0.530520] TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear) [ 0.538249] TCP: Hash tables configured (established 16384 bind 16384) [ 0.545158] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) [ 0.552049] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) [ 0.559528] NET: Registered protocol family 1 [ 0.564454] RPC: Registered named UNIX socket transport module. [ 0.570530] RPC: Registered udp transport module. [ 0.575362] RPC: Registered tcp transport module. [ 0.580176] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.586771] PCI: CLS 0 bytes, default 64 [ 0.591599] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [ 0.603730] Initialise system trusted keyrings [ 0.608500] workingset: timestamp_bits=46 max_order=19 bucket_order=0 [ 0.618871] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.625449] NFS: Registering the id_resolver key type [ 0.630658] Key type id_resolver registered [ 0.634933] Key type id_legacy registered [ 0.639101] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 0.645955] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 0.653706] 9p: Installing v9fs 9p2000 file system support [ 0.694809] Key type asymmetric registered [ 0.699006] Asymmetric key parser 'x509' registered [ 0.704029] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) [ 0.711595] io scheduler mq-deadline registered [ 0.716226] io scheduler kyber registered [ 0.722415] pinctrl-single 4084000.pinctrl: 34 pins, size 136 [ 0.728769] pinctrl-single f4000.pinctrl: 171 pins, size 684 [ 0.742118] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled [ 0.762264] brd: module loaded [ 0.772519] loop: module loaded [ 0.776704] megasas: 07.714.04.00-rc1 [ 0.784178] tun: Universal TUN/TAP device driver, 1.6 [ 0.789966] igbvf: Intel(R) Gigabit Virtual Function Network Driver [ 0.796390] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 0.802499] sky2: driver version 1.30 [ 0.807196] VFIO - User Level meta-driver version: 0.3 [ 0.813532] i2c /dev entries driver [ 0.818833] sdhci: Secure Digital Host Controller Interface driver [ 0.825202] sdhci: Copyright(c) Pierre Ossman [ 0.829972] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.836840] ledtrig-cpu: registered to indicate activity on CPUs [ 0.843330] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 0.851442] optee: probing for conduit method. [ 0.856050] optee: revision 3.19 (d6c5d003) [ 0.856337] optee: dynamic shared memory is enabled [ 0.865986] optee: initialized driver [ 0.871760] NET: Registered protocol family 17 [ 0.876491] 9pnet: Installing 9P2000 support [ 0.880938] Key type dns_resolver registered [ 0.885519] Loading compiled-in X.509 certificates [ 0.900863] ti-sci 44043000.system-controller: ti,ctx-memory-region is required for suspend but not provided. [ 0.911039] ti-sci 44043000.system-controller: ti_sci_init_suspend failed, mem suspend will be non-functional. [ 0.921279] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0008 '8.5.3--v08.05.03 (Chill Capybar') [ 0.986344] davinci-mcasp 2b10000.mcasp: IRQ common not found [ 0.994720] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0 [ 1.001168] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000 [ 1.010388] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz [ 1.018054] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz [ 1.024346] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created [ 1.032700] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created [ 1.041958] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created [ 1.051448] ti-udma 485c0100.dma-controller: Number of rings: 82 [ 1.059544] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18) [ 1.070632] ti-udma 485c0000.dma-controller: Number of rings: 150 [ 1.080551] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15) [ 1.090803] printk: console [ttyS2] disabled [ 1.095254] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 27, base_baud = 3000000) is a 8250 [ 1.104024] printk: console [ttyS2] enabled [ 1.112467] printk: bootconsole [ns16550a0] disabled [ 1.130204] davinci_mdio 8000f00.mdio: Configuring MDIO in manual mode [ 1.173113] davinci_mdio 8000f00.mdio: davinci mdio revision 9.7, bus freq 1000000 [ 1.182774] davinci_mdio 8000f00.mdio: phy[0]: device 8000f00.mdio:00, driver TI DP83867 [ 1.190877] davinci_mdio 8000f00.mdio: phy[1]: device 8000f00.mdio:01, driver TI DP83867 [ 1.199056] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000002 [ 1.211899] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5 [ 1.219026] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512 [ 1.225686] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:0 [ 1.238096] rtc-ti-k3 2b1f0000.rtc: registered as rtc0 [ 1.243291] rtc-ti-k3 2b1f0000.rtc: setting system clock to 1970-01-01T00:00:07 UTC (7) [ 1.355903] mmc0: CQHCI version 5.10 [ 1.357261] pinctrl-single f4000.pinctrl: pin PIN33 already requested by 20100000.spi; cannot claim for 2b10000.mcasp [ 1.370105] pinctrl-single f4000.pinctrl: pin-33 (2b10000.mcasp) status -22 [ 1.377061] pinctrl-single f4000.pinctrl: could not request pin 33 (PIN33) from group main-mcasp1-pins-default on device pinctrl-single [ 1.389300] davinci-mcasp 2b10000.mcasp: Error applying setting, reverse things back [ 1.397048] davinci-mcasp: probe of 2b10000.mcasp failed with error -22 [ 1.405774] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit [ 1.420492] pca953x 1-0022: supply vcc not found, using dummy regulator [ 1.427280] pca953x 1-0022: using AI [ 1.456605] sii902x 1-003b: supply iovcc not found, using dummy regulator [ 1.463542] sii902x 1-003b: supply cvcc12 not found, using dummy regulator [ 1.473315] i2c i2c-1: Added multiplexed i2c bus 2 [ 1.480260] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0 [ 1.488013] tidss 30200000.dss: [drm] Cannot find any crtc or sizes [ 1.496256] mmc0: Command Queue Engine enabled [ 1.500776] mmc0: new HS200 MMC card at address 0001 [ 1.506400] vdd_mmc1: supplied by vcc_3v3_sys [ 1.506592] mmcblk0: mmc0:0001 S0J56X 14.8 GiB [ 1.515656] mmcblk0boot0: mmc0:0001 S0J56X partition 1 31.5 MiB [ 1.521842] mmcblk0boot1: mmc0:0001 S0J56X partition 2 31.5 MiB [ 1.527950] mmcblk0rpmb: mmc0:0001 S0J56X partition 3 4.00 MiB, chardev (237:0) [ 1.535634] wlan_lten: supplied by vcc_3v3_sys [ 1.536628] mmcblk0: p1 p2 [ 1.545278] wlan_en: supplied by wlan_lten [ 1.545367] debugfs: Directory 'pd:53' with parent 'pm_genpd' already present! [ 1.545473] mmc1: CQHCI version 5.10 [ 1.549623] mmc2: CQHCI version 5.10 [ 1.557196] debugfs: Directory 'pd:52' with parent 'pm_genpd' already present! [ 1.571042] debugfs: Directory 'pd:51' with parent 'pm_genpd' already present! [ 1.578585] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present! [ 1.594428] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit [ 1.597161] mmc2: SDHCI controller on fa20000.mmc [fa20000.mmc] using ADMA 64-bit [ 1.609966] ALSA device list: [ 1.612933] No soundcards found. [ 1.614934] sdhci-am654 fa20000.mmc: card claims to support voltages below defined range [ 1.624844] Waiting for root device PARTUUID=609e3af9-02... [ 1.636768] mmc2: new high speed SDIO card at address 0001 [ 1.664889] mmc1: new ultra high speed SDR104 SDXC card at address 59b4 [ 1.672195] mmcblk1: mmc1:59b4 EC1S5 59.7 GiB [ 1.678430] mmcblk1: p1 p2 [ 1.704531] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) [ 1.712745] VFS: Mounted root (ext4 filesystem) on device 179:98. [ 1.719754] devtmpfs: mounted [ 1.723983] Freeing unused kernel memory: 1792K [ 1.733176] Run /sbin/init as init process [ 1.737272] with arguments: [ 1.737275] /sbin/init [ 1.737278] with environment: [ 1.737281] HOME=/ [ 1.737283] TERM=linux [ 1.856329] systemd[1]: System time before build time, advancing clock. [ 2.187548] NET: Registered protocol family 10 [ 2.193222] Segment Routing with IPv6 [ 2.217628] systemd[1]: systemd 244.5+ 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) [ 2.239697] systemd[1]: Detected architecture arm64. [ 2.285902] systemd[1]: Set hostname to . [ 2.499497] systemd[1]: /lib/systemd/system/startwlansta.service:7: Unknown key name 'After' in section 'Service', ignoring. [ 2.511695] systemd[1]: /lib/systemd/system/startwlanap.service:7: Unknown key name 'After' in section 'Service', ignoring. [ 2.547411] systemd[1]: /lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock \xe2\x86\x92 /run/docker.sock; please update the unit file accordingly. [ 2.639546] random: systemd: uninitialized urandom read (16 bytes read) [ 2.646532] systemd[1]: system-getty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [ 2.658958] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [ 2.671104] systemd[1]: Created slice system-getty.slice. [ 2.693305] random: systemd: uninitialized urandom read (16 bytes read) [ 2.701616] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 2.725270] random: systemd: uninitialized urandom read (16 bytes read) [ 2.733458] systemd[1]: Created slice User and Session Slice. [ 2.753572] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 2.777409] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 2.801406] systemd[1]: Reached target Paths. [ 2.817254] systemd[1]: Reached target Remote File Systems. [ 2.837216] systemd[1]: Reached target Slices. [ 2.853243] systemd[1]: Reached target Swap. [ 2.874794] systemd[1]: Listening on RPCbind Server Activation Socket. [ 2.897362] systemd[1]: Reached target RPC Port Mapper. [ 2.921645] systemd[1]: Listening on Process Core Dump Socket. [ 2.945628] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 2.976517] systemd[1]: Condition check resulted in Journal Audit Socket being skipped. [ 2.985780] systemd[1]: Listening on Journal Socket (/dev/log). [ 3.009880] systemd[1]: Listening on Journal Socket. [ 3.025982] systemd[1]: Listening on Network Service Netlink Socket. [ 3.049769] systemd[1]: Listening on udev Control Socket. [ 3.069613] systemd[1]: Listening on udev Kernel Socket. [ 3.094095] systemd[1]: Mounting Huge Pages File System... [ 3.113875] systemd[1]: Mounting POSIX Message Queue File System... [ 3.141922] systemd[1]: Mounting Kernel Debug File System... [ 3.162169] systemd[1]: Mounting Temporary Directory (/tmp)... [ 3.182090] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 3.209741] systemd[1]: Starting Start psplash boot splash screen... [ 3.238954] systemd[1]: Starting RPC Bind... [ 3.253573] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. [ 3.268038] systemd[1]: Starting Journal Service... [ 3.294574] systemd[1]: Starting Load Kernel Modules... [ 3.314340] systemd[1]: Starting Remount Root and Kernel File Systems... [ 3.344693] systemd[1]: Starting udev Coldplug all Devices... [ 3.345781] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null) [ 3.372036] systemd[1]: Started RPC Bind. [ 3.386158] systemd[1]: Started Journal Service. [ 3.525213] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 3.558216] Bridge firewalling registered [ 3.566116] cryptodev: loading out-of-tree module taints kernel. [ 3.575720] cryptodev: driver 1.10 loaded. [ 3.645624] random: systemd-journal: uninitialized urandom read (16 bytes read) [ 3.658071] systemd-journald[196]: Received client request to flush runtime journal. [ 3.669504] random: systemd: uninitialized urandom read (16 bytes read) [ 3.682475] random: systemd-journal: uninitialized urandom read (16 bytes read) [ 4.313461] random: crng init done [ 4.316893] random: 66 urandom warning(s) missed due to ratelimiting [ 4.617629] k3-m4-rproc 5000000.m4fss: assigned reserved memory node m4f-dma-memory@9cb00000 [ 4.634247] k3-m4-rproc 5000000.m4fss: configured M4 for remoteproc mode [ 4.672096] k3-m4-rproc 5000000.m4fss: local reset is deasserted for device [ 4.709565] remoteproc remoteproc0: 5000000.m4fss is available [ 4.721472] remoteproc remoteproc0: powering up 5000000.m4fss [ 4.727411] remoteproc remoteproc0: Booting fw image am62-mcu-m4f0_0-fw, size 78960 [ 4.736975] platform 78000000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1) [ 4.749859] remoteproc0#vdev0buffer: assigned reserved memory node m4f-dma-memory@9cb00000 [ 4.762011] virtio_rpmsg_bus virtio0: rpmsg host is online [ 4.762967] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xd [ 4.767698] remoteproc0#vdev0buffer: registered virtio0 (type 7) [ 4.781479] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xe [ 4.785190] remoteproc remoteproc0: remote processor 5000000.m4fss is now up [ 4.797212] platform 78000000.r5f: configured R5F for IPC-only mode [ 4.812767] platform 78000000.r5f: assigned reserved memory node r5f-dma-memory@9da00000 [ 4.828905] remoteproc remoteproc1: 78000000.r5f is available [ 4.836116] remoteproc remoteproc1: attaching to 78000000.r5f [ 4.842381] platform 78000000.r5f: R5F core initialized in IPC-only mode [ 4.849400] remoteproc1#vdev0buffer: assigned reserved memory node r5f-dma-memory@9da00000 [ 4.858581] virtio_rpmsg_bus virtio1: rpmsg host is online [ 4.860294] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xd [ 4.865100] remoteproc1#vdev0buffer: registered virtio1 (type 7) [ 4.872791] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xe [ 4.884093] remoteproc remoteproc1: remote processor 78000000.r5f is now attached [ 5.019640] PVR_K: 219: Read BVNC 33.15.11.3 from HW device registers [ 5.026746] PVR_K: 219: RGX Device registered with BVNC 33.15.11.3 [ 5.037810] [drm] Initialized pvr 1.15.6133109 20170530 for fd00000.gpu on minor 1 [ 6.019759] remoteproc remoteproc2: 30074000.pru is available [ 6.039074] remoteproc remoteproc3: 30078000.pru is available [ 6.085755] cdns-csi2rx: probe of 30101000.csi-bridge failed with error -22 [ 6.225788] tps6598x 0-003f: Unable to find the interrupt, switching to polling [ 6.502705] usbcore: registered new interface driver usbfs [ 6.504570] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 6.508577] usbcore: registered new interface driver hub [ 6.521637] usbcore: registered new device driver usb [ 6.524518] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 6.658837] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller [ 6.664479] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 1 [ 6.672576] xhci-hcd xhci-hcd.3.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000002000010010 [ 6.682107] xhci-hcd xhci-hcd.3.auto: irq 480, io mem 0x31100000 [ 6.688583] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 [ 6.696973] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 6.704273] usb usb1: Product: xHCI Host Controller [ 6.709243] usb usb1: Manufacturer: Linux 5.10.153-g3eee621d16 xhci-hcd [ 6.709260] usb usb1: SerialNumber: xhci-hcd.3.auto [ 6.721684] hub 1-0:1.0: USB hub found [ 6.730546] hub 1-0:1.0: 1 port detected [ 6.734600] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller [ 6.741093] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 2 [ 6.748885] xhci-hcd xhci-hcd.3.auto: Host supports USB 3.0 SuperSpeed [ 6.760452] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 6.760572] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 [ 6.776917] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 6.784162] usb usb2: Product: xHCI Host Controller [ 6.789069] usb usb2: Manufacturer: Linux 5.10.153-g3eee621d16 xhci-hcd [ 6.801033] usb usb2: SerialNumber: xhci-hcd.3.auto [ 6.806829] hub 2-0:1.0: USB hub found [ 6.810713] hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19) [ 7.312825] wl18xx_driver wl18xx.2.auto: Direct firmware load for ti-connectivity/wl1271-nvs.bin failed with error -2 [ 7.669686] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11) [ 7.683375] wlcore: loaded [ 8.663516] wlcore: using inverted interrupt logic: 2 [ 8.727550] wlcore: PHY firmware version: Rev 8.2.0.0.245 [ 8.827963] wlcore: firmware booted (Rev 8.9.0.0.86) [ 8.864948] am65-cpsw-nuss 8000000.ethernet: down msc_sl e0000000 tmo 0 [ 8.920182] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19 [ 8.957644] am65-cpsw-nuss 8000000.ethernet eth1: PHY [8000f00.mdio:01] driver [TI DP83867] (irq=POLL) [ 8.981751] am65-cpsw-nuss 8000000.ethernet eth1: configuring for phy/rgmii-rxid link mode [ 9.037246] am65-cpsw-nuss 8000000.ethernet: down msc_sl e0000000 tmo 0 [ 9.064624] am65-cpsw-nuss 8000000.ethernet eth0: PHY [8000f00.mdio:00] driver [TI DP83867] (irq=POLL) [ 9.078380] am65-cpsw-nuss 8000000.ethernet eth0: configuring for phy/rgmii-rxid link mode [ 9.337318] wlcore: down [ 9.451986] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 12.291668] PVR_K: 1058: RGX Firmware image 'rgx.fw.33.15.11.3' loaded [ 12.314301] PVR_K: 1058: Shader binary image 'rgx.sh.33.15.11.3' loaded [ 129.260141] Initializing XFRM netlink socket [ 131.010242] process 'docker/tmp/qemu-check514310117/check' started with executable stack [ 370.557873] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [ 370.566726] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 399.314917] am65-cpsw-nuss 8000000.ethernet eth0: Link is Down [ 399.380225] am65-cpsw-nuss 8000000.ethernet: down msc_sl f0000000 tmo 0 [ 399.392578] am65-cpsw-nuss 8000000.ethernet eth0: PHY [8000f00.mdio:00] driver [TI DP83867] (irq=POLL) [ 399.401960] am65-cpsw-nuss 8000000.ethernet eth0: configuring for phy/rgmii-rxid link mode [ 402.461890] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [ 402.470809] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 422.700491] am65-cpsw-nuss 8000000.ethernet eth0: Link is Down [ 422.764004] am65-cpsw-nuss 8000000.ethernet: down msc_sl f0000000 tmo 0 [ 422.776469] am65-cpsw-nuss 8000000.ethernet eth0: PHY [8000f00.mdio:00] driver [TI DP83867] (irq=POLL) [ 422.785805] am65-cpsw-nuss 8000000.ethernet eth0: configuring for phy/rgmii-rxid link mode [ 425.853882] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [ 425.862746] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 475.011398] am65-cpsw-nuss 8000000.ethernet eth0: Link is Down [ 475.075425] am65-cpsw-nuss 8000000.ethernet: down msc_sl f0000000 tmo 0 [ 475.087846] am65-cpsw-nuss 8000000.ethernet eth0: PHY [8000f00.mdio:00] driver [TI DP83867] (irq=POLL) [ 475.097190] am65-cpsw-nuss 8000000.ethernet eth0: configuring for phy/rgmii-rxid link mode [ 478.173878] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [ 478.182736] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 641.625516] Bluetooth: Core ver 2.22 [ 641.629328] NET: Registered protocol family 31 [ 641.633821] Bluetooth: HCI device and connection manager initialized [ 641.640213] Bluetooth: HCI socket layer initialized [ 641.645104] Bluetooth: L2CAP socket layer initialized [ 641.650193] Bluetooth: SCO socket layer initialized [ 908.163956] esp_reset, ESP32: Resetpin of Host is 432 [ 908.164188] esp_reset, ESP32: Triggering ESP reset. [ 908.164964] ESP32 peripheral is registered to SPI bus [3],chip select [0], SPI Clock [10] [ 909.299920] spi_data_ready_interrupt_handler ```
mantriyogesh commented 1 year ago

Clubbing some observations:

  1. Data ready isr is getting triggered
  2. Bootup event has not reached to host
  3. You have already tested spidev and claim that it works fine for TX & Rx with self

It clearly states that the SPI first transaction scheduled in spi_sync_transfer() is not executed. This could be mostly due to SPI timing issue

take-42 commented 1 year ago

I tried switching SPI_MODE in esp_spi.c and spi_slave_api.c from 0 to 3 (16 patterns in total), but no change was observed.

mantriyogesh commented 1 year ago

This is surprising, that none worked, considering that spidev test was success.

Can you please test simple spi slave program from esp-idf first? Flash https://github.com/espressif/esp-idf/tree/master/examples/peripherals/spi_slave receiver to esp chipset and mimic sender in host using some user space program (you might have to reenable spidev for this)

I think once spi (all pins, including miso & mosi) is working fine, esp-hosted would smoothly work.

mantriyogesh commented 1 year ago

Did the issue resolve for you?

take-42 commented 1 year ago

No, I have not even been able to conduct a test of the spi slave program yet. When the time is right to work on it, I would like to re-open it.