Hi Geert-san,
> From: Geert Uytterhoeven, Sent: Friday, June 26, 2020 7:13 PM
>
> Hi Shimoda-san,
>
> [reducing audience]
>
> On Fri, Jun 26, 2020 at 11:32 AM Yoshihiro Shimoda
> <yoshihiro.shimoda.uh@xxxxxxxxxxx> wrote:
> > Note that v5.8-rc2 with r8a77951-salvator-xs seems to cause panic from
> > PCI driver when the system is suspended. So, I disabled the PCI
> > devices when I tested this patch series.
>
> Does this happen with current renesas-devel and renesas_defconfig?
> (it doesn't for me)
Yes. I enabled PM_DEBUG and E1000E though.
> Do you have any PCIe devices attached? (I haven't)
Yes. (Intel Ethernet card is connected to the PCI slot.)
< my environment >
- r8a77961-salvator-xs
- renesas-devel-2020-06-26-v5.8-rc2
+ renesas_defconfig + PM_DEBUG + E1000E
- initramfs
JFYI, I pasted the kernel log like below.
--
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd073]
[ 0.000000] Linux version 5.8.0-rc2-arm64-renesas (shimoda@shimoda-SVE1411AJ) (aarch64-linux-gnu-gcc (Linaro GCC 7.5-2019.12) 7.5.0, GNU ld (Linaro_Binutils-2019.12) 2.28.2.20170706) #57 SMP PREEMPT Mon Jun 29 18:00:16 JST 2020
[ 0.000000] Machine model: Renesas Salvator-X 2nd version board based on r8a77961
[ 0.000000] printk: debug: ignoring loglevel setting.
[ 0.000000] efi: UEFI not found.
[ 0.000000] cma: Reserved 128 MiB at 0x00000000b8000000
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000048000000-0x000000007fffffff]
[ 0.000000] DMA32 [mem 0x0000000080000000-0x00000000ffffffff]
[ 0.000000] Normal [mem 0x0000000100000000-0x00000006ffffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000048000000-0x00000000bfffffff]
[ 0.000000] node 0: [mem 0x0000000480000000-0x00000004ffffffff]
[ 0.000000] node 0: [mem 0x0000000600000000-0x00000006ffffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000048000000-0x00000006ffffffff]
[ 0.000000] On node 0 totalpages: 2064384
[ 0.000000] DMA zone: 3584 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 229376 pages, LIFO batch:63
[ 0.000000] DMA32 zone: 4096 pages used for memmap
[ 0.000000] DMA32 zone: 262144 pages, LIFO batch:63
[ 0.000000] Normal zone: 24576 pages used for memmap
[ 0.000000] Normal zone: 1572864 pages, LIFO batch:63
[ 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 resident on physical CPU 0x0
[ 0.000000] psci: SMC Calling Convention v1.1
[ 0.000000] percpu: Embedded 30 pages/cpu s91408 r0 d31472 u122880
[ 0.000000] pcpu-alloc: s91408 r0 d31472 u122880 alloc=30*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5
[ 0.000000] Detected PIPT I-cache on CPU0
[ 0.000000] CPU features: detected: EL2 vector hardening
[ 0.000000] Speculative Store Bypass Disable mitigation not required
[ 0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2032128
[ 0.000000] Kernel command line: console=ttySC0,115200 ignore_loglevel rw ip=none rdinit=/sbin/init
[ 0.000000] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] software IO TLB: mapped [mem 0x7bfff000-0x7ffff000] (64MB)
[ 0.000000] Memory: 7855196K/8257536K available (10812K kernel code, 1372K rwdata, 3500K rodata, 18048K init, 10976K bss, 271268K reserved, 131072K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
[ 0.000000] Running RCU self tests
[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
[ 0.000000] rcu: [4CRCU event tracing is enabled.
[ 0.000000] rcu: [4CRCU lockdep checking is enabled.
[ 0.000000] rcu: [4CRCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=6.
[ 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=6
[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[ 0.000000] random: get_random_bytes called from start_kernel+0x378/0x508 with crng_init=0
[ 0.000000] arch_timer: cp15 timer(s) running at 8.32MHz (virt).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1eb398c07, max_idle_ns: 440795202503 ns
[ 0.000004] sched_clock: 56 bits at 8MHz, resolution 120ns, wraps every 2199023255503ns
[ 0.000189] Console: colour dummy device 80x25
[ 0.000208] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000217] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000225] ... MAX_LOCK_DEPTH: 48
[ 0.000233] ... MAX_LOCKDEP_KEYS: 8192
[ 0.000241] ... CLASSHASH_SIZE: 4096
[ 0.000249] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.000257] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.000264] ... CHAINHASH_SIZE: 32768
[ 0.000272] memory used by lock dependency info: 6301 kB
[ 0.000280] memory used for stack traces: 4224 kB
[ 0.000288] per task-struct memory footprint: 1920 bytes
[ 0.000341] Calibrating delay loop (skipped), value calculated using timer frequency.. 16.64 BogoMIPS (lpj=33280)
[ 0.000355] pid_max: default: 32768 minimum: 301
[ 0.000602] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.000657] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.004464] rcu: Hierarchical SRCU implementation.
[ 0.005395] Detected Renesas R-Car Gen3 r8a77961 ES3.0
[ 0.006066] EFI services will not be available.
[ 0.006740] smp: Bringing up secondary CPUs ...
[ 0.008009] Detected PIPT I-cache on CPU1
[ 0.008074] CPU1: Booted secondary processor 0x0000000001 [0x411fd073]
[ 0.009527] CPU features: detected: ARM erratum 845719
[ 0.009545] Detected VIPT I-cache on CPU2
[ 0.009612] CPU2: Booted secondary processor 0x0000000100 [0x410fd034]
[ 0.010957] Detected VIPT I-cache on CPU3
[ 0.010991] CPU3: Booted secondary processor 0x0000000101 [0x410fd034]
[ 0.012380] Detected VIPT I-cache on CPU4
[ 0.012415] CPU4: Booted secondary processor 0x0000000102 [0x410fd034]
[ 0.013705] Detected VIPT I-cache on CPU5
[ 0.013740] CPU5: Booted secondary processor 0x0000000103 [0x410fd034]
[ 0.014074] smp: Brought up 1 node, 6 CPUs
[ 0.014120] SMP: Total of 6 processors activated.
[ 0.014131] CPU features: detected: 32-bit EL0 Support
[ 0.014141] CPU features: detected: CRC32 instructions
[ 0.014150] CPU features: detected: 32-bit EL1 Support
[ 0.015136] CPU: All CPU(s) started at EL1
[ 0.015201] alternatives: patching kernel code
[ 0.017277] devtmpfs: initialized
[ 0.033308] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.033354] futex hash table entries: 2048 (order: 6, 262144 bytes, linear)
[ 0.035560] pinctrl core: initialized pinctrl subsystem
[ 0.037017] thermal_sys: Registered thermal governor 'step_wise'
[ 0.038125] DMI not present or invalid.
[ 0.038713] NET: Registered protocol family 16
[ 0.040921] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[ 0.041113] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[ 0.041670] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[ 0.041822] audit: initializing netlink subsys (disabled)
[ 0.042179] audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1
[ 0.043007] cpuidle: using governor menu
[ 0.043201] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[ 0.043473] ASID allocator initialised with 65536 entries
[ 0.076130] sh-pfc e6060000.pin-controller: r8a77961_pfc support registered
[ 0.088931] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[ 0.088945] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[ 0.088955] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.088964] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[ 0.092908] cryptd: max_cpu_qlen set to 1000
[ 0.101004] iommu: Default domain type: Translated
[ 0.101586] vgaarb: loaded
[ 0.102214] SCSI subsystem initialized
[ 0.102584] libata version 3.00 loaded.
[ 0.102827] usbcore: registered new interface driver usbfs
[ 0.102889] usbcore: registered new interface driver hub
[ 0.103037] usbcore: registered new device driver usb
[ 0.105141] i2c-sh_mobile e60b0000.i2c: I2C adapter 0, bus speed 400000 Hz
[ 0.105621] mc: Linux media interface: v0.10
[ 0.105675] videodev: Linux video capture interface: v2.00
[ 0.105781] pps_core: LinuxPPS API ver. 1 registered
[ 0.105790] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx>
[ 0.105815] PTP clock support registered
[ 0.106722] Advanced Linux Sound Architecture Driver Initialized.
[ 0.108211] clocksource: Switched to clocksource arch_sys_counter
[ 0.586632] VFS: Disk quotas dquot_6.6.0
[ 0.586729] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.601849] NET: Registered protocol family 2
[ 0.602529] tcp_listen_portaddr_hash hash table entries: 4096 (order: 6, 327680 bytes, linear)
[ 0.603046] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.604788] TCP bind hash table entries: 65536 (order: 10, 4718592 bytes, vmalloc)
[ 0.612302] TCP: Hash tables configured (established 65536 bind 65536)
[ 0.612677] UDP hash table entries: 4096 (order: 7, 655360 bytes, linear)
[ 0.613755] UDP-Lite hash table entries: 4096 (order: 7, 655360 bytes, linear)
[ 0.615045] NET: Registered protocol family 1
[ 0.616241] RPC: Registered named UNIX socket transport module.
[ 0.616269] RPC: Registered udp transport module.
[ 0.616279] RPC: Registered tcp transport module.
[ 0.616288] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.616305] PCI: CLS 0 bytes, default 64
[ 0.697485] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
[ 0.698098] hw perfevents: enabled with armv8_cortex_a57 PMU driver, 7 counters available
[ 0.698580] kvm [1]: HYP mode not available
[ 0.708317] workingset: timestamp_bits=46 max_order=21 bucket_order=0
[ 0.722635] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.724131] NFS: Registering the id_resolver key type
[ 0.724299] Key type id_resolver registered
[ 0.724328] Key type id_legacy registered
[ 0.724351] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 0.724378] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[ 0.725163] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[ 0.725197] io scheduler mq-deadline registered
[ 0.725207] io scheduler kyber registered
[ 0.732851] gpio_rcar e6050000.gpio: driving 16 GPIOs
[ 0.733448] gpio_rcar e6051000.gpio: driving 29 GPIOs
[ 0.733994] gpio_rcar e6052000.gpio: driving 15 GPIOs
[ 0.734530] gpio_rcar e6053000.gpio: driving 16 GPIOs
[ 0.735081] gpio_rcar e6054000.gpio: driving 18 GPIOs
[ 0.735636] gpio_rcar e6055000.gpio: driving 26 GPIOs
[ 0.736180] gpio_rcar e6055400.gpio: driving 32 GPIOs
[ 0.736850] gpio_rcar e6055800.gpio: driving 4 GPIOs
[ 0.738501] rcar-pcie fe000000.pcie: host bridge /soc/pcie@fe000000 ranges:
[ 0.738563] rcar-pcie fe000000.pcie: IO 0x00fe100000..0x00fe1fffff -> 0x0000000000
[ 0.738647] rcar-pcie fe000000.pcie: MEM 0x00fe200000..0x00fe3fffff -> 0x00fe200000
[ 0.738697] rcar-pcie fe000000.pcie: MEM 0x0030000000..0x0037ffffff -> 0x0030000000
[ 0.738728] rcar-pcie fe000000.pcie: MEM 0x0038000000..0x003fffffff -> 0x0038000000
[ 0.738766] rcar-pcie fe000000.pcie: IB MEM 0x0040000000..0x00bfffffff -> 0x0040000000
[ 0.752979] rcar-pcie fe000000.pcie: PCIe x1: link up
[ 0.754952] rcar-pcie fe000000.pcie: PCI host bridge to bus 0000:00
[ 0.754972] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.754985] pci_bus 0000:00: root bus resource [io 0x0000-0xfffff]
[ 0.754996] pci_bus 0000:00: root bus resource [mem 0xfe200000-0xfe3fffff]
[ 0.755007] pci_bus 0000:00: root bus resource [mem 0x30000000-0x37ffffff]
[ 0.755018] pci_bus 0000:00: root bus resource [mem 0x38000000-0x3fffffff pref]
[ 0.755099] pci 0000:00:00.0: [1912:0028] type 01 class 0x060400
[ 0.755167] pci 0000:00:00.0: enabling Extended Tags
[ 0.755283] pci 0000:00:00.0: PME# supported from D0 D3hot D3cold
[ 0.757386] pci 0000:01:00.0: [8086:10d3] type 00 class 0x020000
[ 0.757495] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x0001ffff]
[ 0.757534] pci 0000:01:00.0: reg 0x14: [mem 0x00000000-0x0007ffff]
[ 0.757573] pci 0000:01:00.0: reg 0x18: [io 0x0000-0x001f]
[ 0.757611] pci 0000:01:00.0: reg 0x1c: [mem 0x00000000-0x00003fff]
[ 0.757707] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0003ffff pref]
[ 0.757953] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[ 0.769639] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 0.769676] pci 0000:00:00.0: BAR 14: assigned [mem 0xfe200000-0xfe2fffff]
[ 0.769689] pci 0000:00:00.0: BAR 15: assigned [mem 0x38000000-0x380fffff pref]
[ 0.769700] pci 0000:00:00.0: BAR 13: assigned [io 0x1000-0x1fff]
[ 0.769721] pci 0000:01:00.0: BAR 1: assigned [mem 0xfe200000-0xfe27ffff]
[ 0.769745] pci 0000:01:00.0: BAR 6: assigned [mem 0x38000000-0x3803ffff pref]
[ 0.769756] pci 0000:01:00.0: BAR 0: assigned [mem 0xfe280000-0xfe29ffff]
[ 0.769778] pci 0000:01:00.0: BAR 3: assigned [mem 0xfe2a0000-0xfe2a3fff]
[ 0.769801] pci 0000:01:00.0: BAR 2: assigned [io 0x1000-0x101f]
[ 0.769828] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 0.769839] pci 0000:00:00.0: bridge window [io 0x1000-0x1fff]
[ 0.769853] pci 0000:00:00.0: bridge window [mem 0xfe200000-0xfe2fffff]
[ 0.769865] pci 0000:00:00.0: bridge window [mem 0x38000000-0x380fffff pref]
[ 0.770087] pcieport 0000:00:00.0: enabling device (0000 -> 0003)
[ 0.770414] pcieport 0000:00:00.0: PME: Signaling with IRQ 123
[ 0.771005] rcar-pcie ee800000.pcie: host bridge /soc/pcie@ee800000 ranges:
[ 0.771064] rcar-pcie ee800000.pcie: IO 0x00ee900000..0x00ee9fffff -> 0x0000000000
[ 0.771117] rcar-pcie ee800000.pcie: MEM 0x00eea00000..0x00eebfffff -> 0x00eea00000
[ 0.771170] rcar-pcie ee800000.pcie: MEM 0x00c0000000..0x00c7ffffff -> 0x00c0000000
[ 0.771200] rcar-pcie ee800000.pcie: MEM 0x00c8000000..0x00cfffffff -> 0x00c8000000
[ 0.771239] rcar-pcie ee800000.pcie: IB MEM 0x0040000000..0x00bfffffff -> 0x0040000000
[ 0.836449] rcar-pcie ee800000.pcie: PCIe link down
[ 0.949044] SuperH (H)SCI(F) driver initialized
[ 0.950166] e6550000.serial: ttySC1 at MMIO 0xe6550000 (irq = 26, base_baud = 0) is a hscif
[ 0.951497] e6e88000.serial: ttySC0 at MMIO 0xe6e88000 (irq = 109, base_baud = 0) is a scif
[ 0.951552] BUG: spinlock bad magic on CPU#1, swapper/0/1
[ 0.951573] lock: sci_ports+0x0/0x4c80, .magic: 00000000, .owner: <none>/-1, .owner_cpu: 0
[ 0.951584] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 5.8.0-rc2-arm64-renesas #57
[ 0.951589] Hardware name: Renesas Salvator-X 2nd version board based on r8a77961 (DT)
[ 0.951595] Call trace:
[ 0.951609] dump_backtrace+0x0/0x1d8
[ 0.951615] show_stack+0x14/0x20
[ 0.951626] dump_stack+0xe8/0x130
[ 0.951635] spin_dump+0x6c/0x88
[ 0.951641] do_raw_spin_lock+0xb0/0xf8
[ 0.951650] _raw_spin_lock_irqsave+0x80/0xa0
[ 0.951660] uart_add_one_port+0x3b0/0x4e8
[ 0.951666] sci_probe+0x504/0x7c8
[ 0.951675] platform_drv_probe+0x50/0xa0
[ 0.951686] really_probe+0xdc/0x330
[ 0.951692] driver_probe_device+0x58/0xb8
[ 0.951699] device_driver_attach+0x6c/0x90
[ 0.951705] __driver_attach+0x54/0xe0
[ 0.951712] bus_for_each_dev+0x74/0xc8
[ 0.951718] driver_attach+0x20/0x28
[ 0.951725] bus_add_driver+0x140/0x1e8
[ 0.951730] driver_register+0x60/0x110
[ 0.951737] __platform_driver_register+0x40/0x48
[ 0.951746] sci_init+0x2c/0x34
[ 0.951754] do_one_initcall+0x160/0x32c
[ 0.951759] kernel_init_freeable+0x2c0/0x328
[ 0.951765] kernel_init+0x10/0x108
[ 0.951772] ret_from_fork+0x10/0x18
[ 2.359682] printk: console [ttySC0] enabled
[ 2.380944] loop: module loaded
[ 2.386504] libphy: Fixed MDIO Bus: probed
[ 2.391119] tun: Universal TUN/TAP device driver, 1.6
[ 2.396428] CAN device driver interface
[ 2.400719] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[ 2.406565] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[ 2.412679] e1000e 0000:01:00.0: enabling device (0000 -> 0002)
[ 2.418852] e1000e 0000:01:00.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
[ 2.428231] e1000e 0000:01:00.0 0000:01:00.0 (uninitialized): Failed to initialize MSI-X interrupts. Falling back to MSI interrupts.
[ 2.488894] e1000e 0000:01:00.0 0000:01:00.0 (uninitialized): registered PHC clock
[ 2.550588] e1000e 0000:01:00.0 eth0: (PCI Express:2.5GT/s:Width x1) 68:05:ca:40:68:2b
[ 2.558551] e1000e 0000:01:00.0 eth0: Intel(R) PRO/1000 Network Connection
[ 2.565453] e1000e 0000:01:00.0 eth0: MAC: 3, PHY: 8, PBA No: E46981-008
[ 2.573693] libphy: ravb_mii: probed
[ 2.578523] ravb e6800000.ethernet eth1: Base address at 0xe6800000, 2e:09:0a:01:99:3f, IRQ 106.
[ 2.587769] VFIO - User Level meta-driver version: 0.3
[ 2.593313] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 2.599864] ehci-pci: EHCI PCI platform driver
[ 2.604370] ehci-platform: EHCI generic platform driver
[ 2.610305] ehci-platform ee0a0100.usb: EHCI Host Controller
[ 2.616008] ehci-platform ee0a0100.usb: new USB bus registered, assigned bus number 1
[ 2.623965] ehci-platform ee0a0100.usb: irq 113, io mem 0xee0a0100
[ 2.644217] ehci-platform ee0a0100.usb: USB 2.0 started, EHCI 1.10
[ 2.651195] hub 1-0:1.0: USB hub found
[ 2.654994] hub 1-0:1.0: 1 port detected
[ 2.659421] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 2.665690] ohci-pci: OHCI PCI platform driver
[ 2.670190] ohci-platform: OHCI generic platform driver
[ 2.676062] ohci-platform ee0a0000.usb: Generic Platform OHCI controller
[ 2.682794] ohci-platform ee0a0000.usb: new USB bus registered, assigned bus number 2
[ 2.690746] ohci-platform ee0a0000.usb: irq 113, io mem 0xee0a0000
[ 2.787535] hub 2-0:1.0: USB hub found
[ 2.791330] hub 2-0:1.0: 1 port detected
[ 2.796339] xhci-hcd ee000000.usb: xHCI Host Controller
[ 2.801630] xhci-hcd ee000000.usb: new USB bus registered, assigned bus number 3
[ 2.809181] xhci-hcd ee000000.usb: Direct firmware load for r8a779x_usb3_v3.dlmem failed with error -2
[ 2.818543] xhci-hcd ee000000.usb: can't setup: -2
[ 2.823356] xhci-hcd ee000000.usb: USB bus 3 deregistered
[ 2.828855] xhci-hcd: probe of ee000000.usb failed with error -2
[ 2.835064] usbcore: registered new interface driver usb-storage
[ 2.841817] renesas_usbhs e6590000.usb: host probed
[ 2.846720] renesas_usbhs e6590000.usb: no transceiver found
[ 2.852525] renesas_usbhs e6590000.usb: gadget probed
[ 2.857816] renesas_usbhs e6590000.usb: probed
[ 2.863300] renesas_usb3 ee020000.usb: probed with phy
[ 2.869064] i2c /dev entries driver
[ 2.880206] cs2000-cp 1-004f: revision - C1
[ 2.884510] i2c-rcar e6510000.i2c: probed
[ 2.889315] pca953x 2-0020: supply vcc not found, using dummy regulator
[ 2.896042] pca953x 2-0020: using no AI
[ 2.907460] i2c-rcar e66d8000.i2c: probed
[ 2.912100] adv748x 2-0070: Endpoint /soc/i2c@e66d8000/video-receiver@70/port@7/endpoint on port 7
[ 2.921131] adv748x 2-0070: Endpoint /soc/i2c@e66d8000/video-receiver@70/port@8/endpoint on port 8
[ 2.930138] adv748x 2-0070: Endpoint /soc/i2c@e66d8000/video-receiver@70/port@a/endpoint on port 10
[ 2.939227] adv748x 2-0070: Endpoint /soc/i2c@e66d8000/video-receiver@70/port@b/endpoint on port 11
[ 2.948456] random: fast init done
[ 2.952071] adv748x 2-0070: chip found @ 0xe0 revision 2143
[ 3.002137] rcar_gen3_thermal e6198000.thermal: TSC0: Loaded 1 trip points
[ 3.013252] rcar_gen3_thermal e6198000.thermal: TSC1: Loaded 1 trip points
[ 3.024345] rcar_gen3_thermal e6198000.thermal: TSC2: Loaded 2 trip points
[ 3.033379] cpufreq: cpufreq_online: CPU0: Running at unlisted freq: 1497600 KHz
[ 3.040873] cpufreq: cpufreq_online: CPU0: Unlisted initial frequency changed to: 1500000 KHz
[ 3.050435] cpufreq: cpufreq_online: CPU2: Running at unlisted freq: 1198080 KHz
[ 3.058412] cpufreq: cpufreq_online: CPU2: Unlisted initial frequency changed to: 1200000 KHz
[ 3.068500] renesas_sdhi_internal_dmac ee100000.sd: Got CD GPIO
[ 3.074469] renesas_sdhi_internal_dmac ee100000.sd: Got WP GPIO
[ 3.130048] renesas_sdhi_internal_dmac ee140000.sd: mmc0 base at 0x00000000ee140000, max clock rate 200 MHz
[ 3.140414] renesas_sdhi_internal_dmac ee160000.sd: Got CD GPIO
[ 3.146422] renesas_sdhi_internal_dmac ee160000.sd: Got WP GPIO
[ 3.153370] ledtrig-cpu: registered to indicate activity on CPUs
[ 3.159672] ccree e6601000.crypto: ARM CryptoCell 630P Driver: HW version 0xAF400001/0xDCC63000, Driver version 5.0
[ 3.175898] ccree e6601000.crypto: ARM ccree device initialized
[ 3.182622] usbcore: registered new interface driver usbhid
[ 3.188298] usbhid: USB HID core driver
[ 3.210319] NET: Registered protocol family 17
[ 3.214806] can: controller area network core (rev 20170425 abi 9)
[ 3.221137] NET: Registered protocol family 29
[ 3.225621] can: raw protocol (rev 20170425)
[ 3.229928] can: broadcast manager protocol (rev 20170425 t)
[ 3.235606] can: netlink gateway (rev 20190810) max_hops=1
[ 3.241350] Key type dns_resolver registered
[ 3.246029] registered taskstats version 1
[ 3.300561] mmc0: new HS400 MMC card at address 0001
[ 3.306169] mmcblk0: mmc0:0001 BGSD4R 29.1 GiB
[ 3.308260] ehci-platform ee080100.usb: EHCI Host Controller
[ 3.310909] mmcblk0boot0: mmc0:0001 BGSD4R partition 1 31.9 MiB
[ 3.316393] ehci-platform ee080100.usb: new USB bus registered, assigned bus number 3
[ 3.322464] mmcblk0boot1: mmc0:0001 BGSD4R partition 2 31.9 MiB
[ 3.330211] usb 2-1: new full-speed USB device number 2 using ohci-platform
[ 3.336227] mmcblk0rpmb: mmc0:0001 BGSD4R partition 3 4.00 MiB, chardev (243:0)
[ 3.343167] ehci-platform ee080100.usb: irq 112, io mem 0xee080100
[ 3.357009] mmcblk0: p1
[ 3.780248] ehci-platform ee080100.usb: USB 2.0 started, EHCI 1.10
[ 3.787213] hub 3-0:1.0: USB hub found
[ 3.791013] hub 3-0:1.0: 1 port detected
[ 3.795878] ohci-platform ee080000.usb: Generic Platform OHCI controller
[ 3.802640] ohci-platform ee080000.usb: new USB bus registered, assigned bus number 4
[ 3.810593] ohci-platform ee080000.usb: irq 112, io mem 0xee080000
[ 3.907545] hub 4-0:1.0: USB hub found
[ 3.911408] hub 4-0:1.0: 1 port detected
[ 3.916512] renesas_sdhi_internal_dmac ee100000.sd: Got CD GPIO
[ 3.922489] renesas_sdhi_internal_dmac ee100000.sd: Got WP GPIO
[ 3.976633] renesas_sdhi_internal_dmac ee100000.sd: mmc1 base at 0x00000000ee100000, max clock rate 200 MHz
[ 3.987262] renesas_sdhi_internal_dmac ee160000.sd: Got CD GPIO
[ 3.993238] renesas_sdhi_internal_dmac ee160000.sd: Got WP GPIO
[ 4.048185] renesas_sdhi_internal_dmac ee160000.sd: mmc2 base at 0x00000000ee160000, max clock rate 200 MHz
[ 4.062206] input: keys as /devices/platform/keys/input/input0
[ 4.069056] ALSA device list:
[ 4.072030] No soundcards found.
[ 4.075505] Warning: unable to open an initial console.
[ 4.091456] Freeing unused kernel memory: 18048K
[ 4.096287] Run /sbin/init as init process
[ 4.100486] with arguments:
[ 4.103524] /sbin/init
[ 4.106284] with environment:
[ 4.109495] HOME=/
[ 4.111868] TERM=linux
[ 4.294444] mmc1: new ultra high speed SDR104 SDHC card at address aaaa
[ 4.302053] mmcblk1: mmc1:aaaa SL16G 14.8 GiB
[ 4.311499] mmcblk1: p1
[ 4.399371] mmc2: new ultra high speed SDR104 SDHC card at address aaaa
[ 4.406708] mmcblk2: mmc2:aaaa SL32G 29.7 GiB
[ 4.416734] mmcblk2: p1
(none) login: root
login[222]: root login on 'ttySC0'
~ # echo N > /sys/module/printk/parameters/console_suspend
~ # echo platform > /sys/power/pm_test
~ # dmesg | grep pci
[ 0.738501] rcar-pcie fe000000.pcie: host bridge /soc/pcie@fe000000 ranges:
[ 0.738563] rcar-pcie fe000000.pcie: IO 0x00fe100000..0x00fe1fffff -> 0x0000000000
[ 0.738647] rcar-pcie fe000000.pcie: MEM 0x00fe200000..0x00fe3fffff -> 0x00fe200000
[ 0.738697] rcar-pcie fe000000.pcie: MEM 0x0030000000..0x0037ffffff -> 0x0030000000
[ 0.738728] rcar-pcie fe000000.pcie: MEM 0x0038000000..0x003fffffff -> 0x0038000000
[ 0.738766] rcar-pcie fe000000.pcie: IB MEM 0x0040000000..0x00bfffffff -> 0x0040000000
[ 0.752979] rcar-pcie fe000000.pcie: PCIe x1: link up
[ 0.754952] rcar-pcie fe000000.pcie: PCI host bridge to bus 0000:00
[ 0.754972] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.754985] pci_bus 0000:00: root bus resource [io 0x0000-0xfffff]
[ 0.754996] pci_bus 0000:00: root bus resource [mem 0xfe200000-0xfe3fffff]
[ 0.755007] pci_bus 0000:00: root bus resource [mem 0x30000000-0x37ffffff]
[ 0.755018] pci_bus 0000:00: root bus resource [mem 0x38000000-0x3fffffff pref]
[ 0.755099] pci 0000:00:00.0: [1912:0028] type 01 class 0x060400
[ 0.755167] pci 0000:00:00.0: enabling Extended Tags
[ 0.755283] pci 0000:00:00.0: PME# supported from D0 D3hot D3cold
[ 0.757386] pci 0000:01:00.0: [8086:10d3] type 00 class 0x020000
[ 0.757495] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x0001ffff]
[ 0.757534] pci 0000:01:00.0: reg 0x14: [mem 0x00000000-0x0007ffff]
[ 0.757573] pci 0000:01:00.0: reg 0x18: [io 0x0000-0x001f]
[ 0.757611] pci 0000:01:00.0: reg 0x1c: [mem 0x00000000-0x00003fff]
[ 0.757707] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0003ffff pref]
[ 0.757953] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[ 0.769639] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 0.769676] pci 0000:00:00.0: BAR 14: assigned [mem 0xfe200000-0xfe2fffff]
[ 0.769689] pci 0000:00:00.0: BAR 15: assigned [mem 0x38000000-0x380fffff pref]
[ 0.769700] pci 0000:00:00.0: BAR 13: assigned [io 0x1000-0x1fff]
[ 0.769721] pci 0000:01:00.0: BAR 1: assigned [mem 0xfe200000-0xfe27ffff]
[ 0.769745] pci 0000:01:00.0: BAR 6: assigned [mem 0x38000000-0x3803ffff pref]
[ 0.769756] pci 0000:01:00.0: BAR 0: assigned [mem 0xfe280000-0xfe29ffff]
[ 0.769778] pci 0000:01:00.0: BAR 3: assigned [mem 0xfe2a0000-0xfe2a3fff]
[ 0.769801] pci 0000:01:00.0: BAR 2: assigned [io 0x1000-0x101f]
[ 0.769828] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 0.769839] pci 0000:00:00.0: bridge window [io 0x1000-0x1fff]
[ 0.769853] pci 0000:00:00.0: bridge window [mem 0xfe200000-0xfe2fffff]
[ 0.769865] pci 0000:00:00.0: bridge window [mem 0x38000000-0x380fffff pref]
[ 0.770087] pcieport 0000:00:00.0: enabling device (0000 -> 0003)
[ 0.770414] pcieport 0000:00:00.0: PME: Signaling with IRQ 123
[ 0.771005] rcar-pcie ee800000.pcie: host bridge /soc/pcie@ee800000 ranges:
[ 0.771064] rcar-pcie ee800000.pcie: IO 0x00ee900000..0x00ee9fffff -> 0x0000000000
[ 0.771117] rcar-pcie ee800000.pcie: MEM 0x00eea00000..0x00eebfffff -> 0x00eea00000
[ 0.771170] rcar-pcie ee800000.pcie: MEM 0x00c0000000..0x00c7ffffff -> 0x00c0000000
[ 0.771200] rcar-pcie ee800000.pcie: MEM 0x00c8000000..0x00cfffffff -> 0x00c8000000
[ 0.771239] rcar-pcie ee800000.pcie: IB MEM 0x0040000000..0x00bfffffff -> 0x0040000000
[ 0.836449] rcar-pcie ee800000.pcie: PCIe link down
[ 2.599864] ehci-pci: EHCI PCI platform driver
[ 2.665690] ohci-pci: OHCI PCI platform driver
~ # cat /proc/net/dev
Inter-| Receive | Transmit
face |bytes packets errs drop fifo frame compressed multicast|bytes packets errs drop fifo colls carrier compressed
lo: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
eth0: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
eth1: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
~ # echo mem > /sys/power/state
[ 374.072298] PM: suspend entry (deep)
[ 374.075994] Filesystems sync: 0.000 seconds
[ 374.083159] Freezing user space processes ... (elapsed 0.001 seconds) done.
[ 374.091570] OOM killer disabled.
[ 374.094823] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[ 374.227534] e1000e: EEE TX LPI TIMER: 00000000
[ 374.354388] SError Interrupt on CPU0, code 0xbf000002 -- SError
[ 374.354390] CPU: 0 PID: 633 Comm: kworker/u12:4 Not tainted 5.8.0-rc2-arm64-renesas #57
[ 374.354392] Hardware name: Renesas Salvator-X 2nd version board based on r8a77961 (DT)
[ 374.354393] Workqueue: events_unbound async_run_entry_fn
[ 374.354395] pstate: 40000085 (nZcv daIf -PAN -UAO BTYPE=--)
[ 374.354396] pc : rcar_pci_read_reg+0xc/0x20
[ 374.354397] lr : rcar_pcie_config_access+0xe4/0x1c0
[ 374.354398] sp : ffff8000148aba80
[ 374.354399] x29: ffff8000148aba80 x28: 0000000000000000
[ 374.354402] x27: ffff800011fb0000 x26: 0000000000000000
[ 374.354404] x25: 00000000000000cc x24: 0000000000000000
[ 374.354406] x23: ffff8000148abb54 x22: 0000000000000000
[ 374.354408] x21: ffff0006b484f800 x20: 0000000000000000
[ 374.354411] x19: ffff0006b3a14580 x18: 0000000000000000
[ 374.354413] x17: 0000000000000000 x16: 0000000000000000
[ 374.354415] x15: 0000000000000000 x14: 000006e45d8ca55e
[ 374.354417] x13: 0000000000000330 x12: 000000000000016d
[ 374.354419] x11: 0000000000000000 x10: 0000000000000000
[ 374.354421] x9 : ffff800012059120 x8 : ffff800011fb0948
[ 374.354423] x7 : ffff8000105075a8 x6 : 0000000000000000
[ 374.354425] x5 : ffff8000148abb54 x4 : 00000000000000cc
[ 374.354427] x3 : 0000000000000000 x2 : ffff800013700018
[ 374.354429] x1 : 0000000000000020 x0 : 00000000ffffffff
[ 374.354432] Kernel panic - not syncing: Asynchronous SError Interrupt
[ 374.354433] CPU: 0 PID: 633 Comm: kworker/u12:4 Not tainted 5.8.0-rc2-arm64-renesas #57
[ 374.354434] Hardware name: Renesas Salvator-X 2nd version board based on r8a77961 (DT)
[ 374.354435] Workqueue: events_unbound async_run_entry_fn
[ 374.354437] Call trace:
[ 374.354438] dump_backtrace+0x0/0x1d8
[ 374.354439] show_stack+0x14/0x20
[ 374.354439] dump_stack+0xe8/0x130
[ 374.354440] panic+0x168/0x380
[ 374.354441] nmi_panic+0x6c/0x70
[ 374.354442] arm64_serror_panic+0x74/0x88
[ 374.354443] do_serror+0x88/0x1a0
[ 374.354444] el1_error+0x84/0x100
[ 374.354444] rcar_pci_read_reg+0xc/0x20
[ 374.354445] rcar_pcie_read_conf+0x38/0xb0
[ 374.354446] pci_bus_read_config_word+0x84/0xe0
[ 374.354447] pci_read_config_word+0x28/0x40
[ 374.354448] pci_raw_set_power_state+0x108/0x2a8
[ 374.354449] pci_set_power_state+0x5c/0x150
[ 374.354450] pci_prepare_to_sleep+0x60/0x98
[ 374.354451] pci_pm_suspend_noirq+0xe4/0x278
[ 374.354451] dpm_run_callback+0x88/0x3c0
[ 374.354452] __device_suspend_noirq+0x68/0x1f0
[ 374.354453] async_suspend_noirq+0x20/0xa8
[ 374.354454] async_run_entry_fn+0x44/0x108
[ 374.354455] process_one_work+0x2a0/0x718
[ 374.354456] worker_thread+0x40/0x458
[ 374.354457] kthread+0x150/0x158
[ 374.354457] ret_from_fork+0x10/0x18
[ 374.354484] SMP: stopping secondary CPUs
[ 374.354485] Kernel Offset: disabled
[ 374.354486] CPU features: 0x200022,21006004
---
Best regards,
Yoshihiro Shimoda
