From: Koen Vandeputte <koen.vandeputte@citymesh.com>
To: "Petr Štetiar" <ynezz@true.cz>, "Pali Rohár" <pali@kernel.org>
Cc: "Bjorn Helgaas" <helgaas@kernel.org>,
"Bjorn Helgaas" <bhelgaas@google.com>,
linux-pci@vger.kernel.org, linux-kernel@vger.kernel.org,
"Lorenzo Pieralisi" <lorenzo.pieralisi@arm.com>,
"Gregory Clement" <gregory.clement@bootlin.com>,
"Andrew Lunn" <andrew@lunn.ch>,
"Krzysztof Wilczyński" <kw@linux.com>,
"Yinghai Lu" <yinghai@kernel.org>
Subject: Re: PCI: Race condition in pci_create_sysfs_dev_files
Date: Fri, 25 Jun 2021 13:29:00 +0200 [thread overview]
Message-ID: <cd4812f0-1de3-0582-936c-ba30906595af@citymesh.com> (raw)
In-Reply-To: <20210407153041.GA17046@meh.true.cz>
On 07.04.21 17:30, Petr Štetiar wrote:
> Pali Rohár <pali@kernel.org> [2021-04-07 16:51:47]:
>
>> Could you run 'dmesg' and provide its output? So also missing / garbage
>> messages would be visible.
> Adding it inline for archives. It's log from serial console, with output of dmesg at the
> bottom so one can compare if needed.
>
> [ 0.000000] Booting Linux on physical CPU 0x0
> [ 0.000000] Linux version 5.10.27 (ynezz@ntbk) (arm-openwrt-linux-muslgnueabi-gcc (OpenWrt GCC 8.4.0 r12719+30-84f4a783c698) 8.4.0, GNU ld (GNU Binutils) 2.34) #0 SMP Wed Apr 7 12:52:23 2021
> [ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d
> [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
> [ 0.000000] OF: fdt: Machine model: Toradex Apalis iMX6Q/D Module on Ixora Carrier Board
> [ 0.000000] Memory policy: Data cache writealloc
> [ 0.000000] Ignoring RAM at 0x80000000-0x90000000
> [ 0.000000] Consider using a HIGHMEM enabled kernel.
> [ 0.000000] Zone ranges:
> [ 0.000000] Normal [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] Movable zone start for each node
> [ 0.000000] Early memory node ranges
> [ 0.000000] node 0: [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] Initmem setup node 0 [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] percpu: Embedded 19 pages/cpu s47628 r8192 d22004 u77824
> [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 454720
> [ 0.000000] Kernel command line: earlyprintk console=ttymxc0,115200n8 root=PARTUUID=5452574f-02 rootfstype=squashfs rootwait pci=nomsi
> [ 0.000000] Dentry cache hash table entries: 262144 (order: 8, 1048576 bytes, linear)
> [ 0.000000] Inode-cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
> [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
> [ 0.000000] Memory: 1802104K/1835008K available (9040K kernel code, 1170K rwdata, 2328K rodata, 1024K init, 242K bss, 32904K reserved, 0K cma-reserved)
> [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
> [ 0.000000] ftrace: allocating 31336 entries in 62 pages
> [ 0.000000] ftrace: allocated 62 pages with 5 groups
> [ 0.000000] rcu: Hierarchical RCU implementation.
> [ 0.000000] Rude variant of Tasks RCU enabled.
> [ 0.000000] Tracing variant of Tasks RCU enabled.
> [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
> [ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
> [ 0.000000] L2C-310 errata 752271 769419 enabled
> [ 0.000000] L2C-310 enabling early BRESP for Cortex-A9
> [ 0.000000] L2C-310 full line of zeros enabled for Cortex-A9
> [ 0.000000] L2C-310 ID prefetch enabled, offset 16 lines
> [ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
> [ 0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
> [ 0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76470001
> [ 0.000000] random: get_random_bytes called from start_kernel+0x3e0/0x5a0 with crng_init=0
> [ 0.000000] Switching to timer-based delay loop, resolution 333ns
> [ 0.000008] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
> [ 0.000029] clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
> [ 0.001279] Console: colour dummy device 80x30
> [ 0.001318] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
> [ 0.001340] pid_max: default: 32768 minimum: 301
> [ 0.001548] Mount-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
> [ 0.001588] Mountpoint-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
> [ 0.002484] CPU: Testing write buffer coherency: ok
> [ 0.002522] CPU0: Spectre v2: using BPIALL workaround
> [ 0.002789] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
> [ 0.003686] Setting up static identity map for 0x10100000 - 0x10100060
> [ 0.003845] rcu: Hierarchical SRCU implementation.
> [ 0.004844] smp: Bringing up secondary CPUs ...
> [ 0.005689] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
> [ 0.005698] CPU1: Spectre v2: using BPIALL workaround
> [ 0.006667] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
> [ 0.006676] CPU2: Spectre v2: using BPIALL workaround
> [ 0.007606] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
> [ 0.007615] CPU3: Spectre v2: using BPIALL workaround
> [ 0.007755] smp: Brought up 1 node, 4 CPUs
> [ 0.007770] SMP: Total of 4 processors activated (24.00 BogoMIPS).
> [ 0.007780] CPU: All CPU(s) started in SVC mode.
> [ 0.017479] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
> [ 0.017696] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
> [ 0.017731] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
> [ 0.017995] pinctrl core: initialized pinctrl subsystem
> [ 0.019710] NET: Registered protocol family 16
> [ 0.021665] DMA: preallocated 256 KiB pool for atomic coherent allocations
> [ 0.023180] thermal_sys: Registered thermal governor 'step_wise'
> [ 0.023660] CPU identified as i.MX6Q, silicon rev 1.5
> [ 0.245571] vdd1p1: supplied by regulator-dummy
> [ 0.254210] vdd3p0: supplied by regulator-dummy
> [ 0.262785] vdd2p5: supplied by regulator-dummy
> [ 0.271321] vddarm: supplied by regulator-dummy
> [ 0.279909] vddpu: supplied by regulator-dummy
> [ 0.288419] vddsoc: supplied by regulator-dummy
> [ 0.628532] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
> [ 0.628554] hw-breakpoint: maximum watchpoint size is 4 bytes.
> [ 0.628861] debugfs: Directory 'dummy-iomuxc-gpr@20e0000' with parent 'regmap' already present!
> [ 0.629263] imx6q-pinctrl 20e0000.pinctrl: initialized IMX pinctrl driver
> [ 0.647595] Kprobes globally optimized
> [ 0.650233] cryptd: max_cpu_qlen set to 1000
> [ 0.666849] mxs-dma 110000.dma-apbh: initialized
> [ 0.669973] usb_host_vbus: supplied by usb_host_vbus_hub
> [ 0.670896] SCSI subsystem initialized
> [ 0.671797] usbcore: registered new interface driver usbfs
> [ 0.671910] usbcore: registered new interface driver hub
> [ 0.671999] usbcore: registered new device driver usb
> [ 0.674185] i2c i2c-0: IMX I2C adapter registered
> [ 0.676657] i2c i2c-2: IMX I2C adapter registered
> [ 0.677730] i2c i2c-1: IMX I2C adapter registered
> [ 0.678202] pps_core: LinuxPPS API ver. 1 registered
> [ 0.678217] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
> [ 0.678258] PTP clock support registered
> [ 0.680434] clocksource: Switched to clocksource mxc_timer1
> [ 0.800167] NET: Registered protocol family 2
> [ 0.801060] tcp_listen_portaddr_hash hash table entries: 1024 (order: 1, 12288 bytes, linear)
> [ 0.801141] TCP established hash table entries: 16384 (order: 4, 65536 bytes, linear)
> [ 0.801432] TCP bind hash table entries: 16384 (order: 5, 131072 bytes, linear)
> [ 0.802002] TCP: Hash tables configured (established 16384 bind 16384)
> [ 0.802377] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
> [ 0.802490] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
> [ 0.802831] NET: Registered protocol family 1
> [ 0.802876] PCI: CLS 0 bytes, default 64
> [ 0.803583] hw perfevents: no interrupt-affinity property for /pmu, guessing.
> [ 0.803842] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
> [ 0.809163] workingset: timestamp_bits=14 max_order=19 bucket_order=5
> [ 0.813910] squashfs: version 4.0 (2009/01/31) Phillip Lougher
> [ 0.926864] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
> [ 0.929303] imx6q-pcie 1ffc000.pcie: host bridge /soc/pcie@1ffc000 ranges:
> [ 0.929370] imx6q-pcie 1ffc000.pcie: IO 0x0001f80000..0x0001f8ffff -> 0x0000000000
> [ 0.929411] imx6q-pcie 1ffc000.pcie: MEM 0x0001000000..0x0001efffff -> 0x0001000000
> [ 0.936834] imx-sdma 20ec000.sdma: loaded firmware 3.5
> [ 0.938840] pfuze100-regulator 2-0008: Full layer: 1, Metal layer: 1
> [ 0.939545] pfuze100-regulator 2-0008: FAB: 0, FIN: 0
> [ 0.939560] pfuze100-regulator 2-0008: pfuze100 found.
> [ 0.956572] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
> [ 0.957946] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 34, base_baud = 5000000) is a IMX
> [ 1.670939] printk: console [ttymxc0] enabled
> [ 1.676645] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 81, base_baud = 5000000) is a IMX
> [ 1.686125] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 82, base_baud = 5000000) is a IMX
> [ 1.695541] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 83, base_baud = 5000000) is a IMX
> [ 1.711037] loop: module loaded
> [ 1.714198] Loading iSCSI transport class v2.0-870.
> [ 1.720904] ahci-imx 2200000.sata: fsl,transmit-level-mV not specified, using 00000024
> [ 1.728838] ahci-imx 2200000.sata: fsl,transmit-boost-mdB not specified, using 00000480
> [ 1.736873] ahci-imx 2200000.sata: fsl,transmit-atten-16ths not specified, using 00002000
> [ 1.745076] ahci-imx 2200000.sata: fsl,receive-eq-mdB not specified, using 05000000
> [ 1.752856] ahci-imx 2200000.sata: supply ahci not found, using dummy regulator
> [ 1.760380] ahci-imx 2200000.sata: supply phy not found, using dummy regulator
> [ 1.767721] ahci-imx 2200000.sata: supply target not found, using dummy regulator
> [ 1.778076] ahci-imx 2200000.sata: SSS flag set, parallel bus scan disabled
> [ 1.785108] ahci-imx 2200000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
> [ 1.793935] ahci-imx 2200000.sata: flags: ncq sntf stag pm led clo only pmp pio slum part ccc apst
> [ 1.804523] scsi host0: ahci-imx
> [ 1.808138] ata1: SATA max UDMA/133 mmio [mem 0x02200000-0x02203fff] port 0x100 irq 86
> [ 1.818261] libphy: Fixed MDIO Bus: probed
> [ 1.836498] pps pps0: new PPS source ptp0
> [ 1.842688] libphy: fec_enet_mii_bus: probed
> [ 1.848952] fec 2188000.ethernet eth0: registered PHC device 0
> [ 1.855343] e1000e: Intel(R) PRO/1000 Network Driver
> [ 1.860315] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
> [ 1.866373] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
> [ 1.872957] ehci-pci: EHCI PCI platform driver
> [ 1.877464] ehci-mxc: Freescale On-Chip EHCI Host driver
> [ 1.886285] rtc-ds1307 0-0068: oscillator failed, set time!
> [ 1.892036] rtc-ds1307 0-0068: registered as rtc0
> [ 1.898144] rtc-ds1307 0-0068: hctosys: unable to read the hardware clock
> [ 1.905241] i2c /dev entries driver
> [ 1.911218] sdhci: Secure Digital Host Controller Interface driver
> [ 1.917410] sdhci: Copyright(c) Pierre Ossman
> [ 1.921792] sdhci-pltfm: SDHCI platform and OF driver helper
> [ 1.928836] sdhci-esdhc-imx 2194000.mmc: Got CD GPIO
> [ 1.929555] caam 2100000.crypto: Entropy delay = 3200
> [ 1.966821] mmc2: SDHCI controller on 2198000.mmc [2198000.mmc] using ADMA
> [ 1.974375] mmc1: SDHCI controller on 2194000.mmc [2194000.mmc] using ADMA
> [ 1.999674] caam 2100000.crypto: Instantiated RNG4 SH0
> [ 2.040446] imx6q-pcie 1ffc000.pcie: Phy link never came up
> [ 2.049259] imx6q-pcie 1ffc000.pcie: PCI host bridge to bus 0000:00
> [ 2.055566] pci_bus 0000:00: root bus resource [bus 00-ff]
> [ 2.060434] caam 2100000.crypto: Instantiated RNG4 SH1
> [ 2.061088] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
> [ 2.066207] caam 2100000.crypto: device ID = 0x0a16010000000000 (Era 4)
> [ 2.072406] pci_bus 0000:00: root bus resource [mem 0x01000000-0x01efffff]
> [ 2.076096] mmc2: new DDR MMC card at address 0001
> [ 2.077087] mmcblk2: mmc2:0001 BIWIN 7.28 GiB
> [ 2.077714] mmcblk2boot0: mmc2:0001 BIWIN partition 1 4.00 MiB
> [ 2.078331] mmcblk2boot1: mmc2:0001 BIWIN partition 2 4.00 MiB
> [ 2.078464] mmcblk2rpmb: mmc2:0001 BIWIN partition 3 4.00 MiB, chardev (248:0)
> [ 2.079029] caam 2100000.crypto: job rings = 2, qi = 0
> [ 2.079769] mmcblk2: p1 p2
> [ 2.085973] pci 0000:00:00.0: [16c3:abcd] type 01 class 0x060400
> [ 2.098373] caam algorithms registered in /proc/crypto
> [ 2.101276] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x000fffff]
> [ 2.108603] caam 2100000.crypto: registering rng-caam
> [ 2.114480] pci 0000:00:00.0: reg 0x38: [mem 0x00000000-0x0000ffff pref]
> [ 2.124125] NET: Registered protocol family 10
> [ 2.128468] pci 0000:00:00.0: Limiting cfg_size to 512
> [ 2.134736] Segment Routing with IPv6
> [ 2.139879] pci 0000:00:00.0: imx6_pcie_quirk+0x0/0x84 took 11125 usecs
> [ 2.142319] ata1: SATA link down (SStatus 0 SControl 300)
> [ 2.142367] ahci-imx 2200000.sata: no device found, disabling link.
> [ 2.142376] ahci-imx 2200000.sata: pass ahci_imx..hotplug=1 to enable hotplug
> [ 2.145016] NET: Registered protocol family 17
> [ 2.151684] pci 0000:00:00.0: supports D1
> [ 2.156289] 8021q: 802.1Q VLAN Support v1.8
> [ 2.161238] pci 0000:00:00.0: PME# supported from D0 D1 D3hot D3cold
> [ 2.165900] PCI: bus0: Fast back to back transfers disabled
> [ 2.173156] Registering SWP/SWPB emulation handler
> [ 2.181426] PCI: bus1: Fast back to back transfers enabled
> [ 2.185540] Key type ._fscrypt registered
> [ 2.190445] pci 0000:00:00.0: BAR 0: assigned [mem 0x01000000-0x010fffff]
> [ 2.194840] Key type .fscrypt registered
> [ 2.198843] pci 0000:00:00.0: BAR 6: assigned [mem 0x01100000-0x0110ffff pref]
> [ 2.203025] Key type fscrypt-provisioning registered
> [ 2.207714] Key type encrypted registered
> [ 2.209408] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
> [ 2.239936] imx_thermal 20c8000.anatop:tempmon: Industrial CPU temperature grade - max:105C critical:100C passive:95C
> [ 2.240101] pci 0000:00:00.0: Max Payload Size set to 128/ 128 (was 128), Max Read Rq 128
> [ 2.280656] sysfs: cannot create duplicate filename '/devices/platform/soc/1ffc000.pcie/pci0000:00/0000:00:00.0/config'
> [ 2.291471] CPU: 1 PID: 46 Comm: kworker/u8:3 Not tainted 5.10.27 #0
> [ 2.297832] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
> [ 2.303545] random: fast init done
> [ 2.304384] Workqueue: events_unbound async_run_entry_fn
> [ 2.313090] Backtrace:
> [ 2.315558] [<8010cc88>] (dump_backtrace) from [<8010d134>] (show_stack+0x20/0x24)
> [ 2.323136] r7:813285d4 r6:60000013 r5:00000000 r4:80ec845c
> [ 2.328815] [<8010d114>] (show_stack) from [<805971fc>] (dump_stack+0xa4/0xb8)
> [ 2.336058] [<80597158>] (dump_stack) from [<803a7128>] (sysfs_warn_dup+0x68/0x74)
> [ 2.343636] r7:813285d4 r6:80af0dfc r5:812fc8f0 r4:81bcb000
> [ 2.349305] [<803a70c0>] (sysfs_warn_dup) from [<803a6c90>] (sysfs_add_file_mode_ns+0x100/0x1cc)
> [ 2.358098] r7:813285d4 r6:812fc8f0 r5:80b4299c r4:ffffffef
> [ 2.363765] [<803a6b90>] (sysfs_add_file_mode_ns) from [<803a6fe8>] (sysfs_create_bin_file+0x94/0x9c)
> [ 2.372991] r6:81e68078 r5:80b4299c r4:00000000
> [ 2.377626] [<803a6f54>] (sysfs_create_bin_file) from [<805da848>] (pci_create_sysfs_dev_files+0x58/0x2cc)
> [ 2.387285] r6:81e68000 r5:81e68078 r4:81e68000
> [ 2.391923] [<805da7f0>] (pci_create_sysfs_dev_files) from [<805cba98>] (pci_bus_add_device+0x34/0x90)
> [ 2.401237] r10:80b45d88 r9:81818810 r8:81328400 r7:813285d4 r6:81bd8000 r5:81e68078
> [ 2.409071] r4:81e68000
> [ 2.411615] [<805cba64>] (pci_bus_add_device) from [<805cbb30>] (pci_bus_add_devices+0x3c/0x80)
> [ 2.420318] r5:81bd8014 r4:81e68000
> [ 2.423905] [<805cbaf4>] (pci_bus_add_devices) from [<805cf898>] (pci_host_probe+0x50/0xa0)
> [ 2.425126] random: crng init done
> [ 2.432263] r7:813285d4 r6:81bd8000 r5:81bd800c r4:00000000
> [ 2.432279] [<805cf848>] (pci_host_probe) from [<805eeb20>] (dw_pcie_host_init+0x1d0/0x414)
> [ 2.432294] r7:813285d4 r6:81328258 r5:00000200 r4:00000000
> [ 2.455360] [<805ee950>] (dw_pcie_host_init) from [<805ef5a8>] (imx6_pcie_probe+0x38c/0x69c)
> [ 2.463807] r10:81226180 r9:ef0205c4 r8:81818800 r7:81328240 r6:81328240 r5:81818810
> [ 2.471640] r4:00000020
> [ 2.474197] [<805ef21c>] (imx6_pcie_probe) from [<8065e858>] (platform_drv_probe+0x58/0xa8)
> [ 2.482557] r10:80ec9f78 r9:00000000 r8:80f160a8 r7:00000000 r6:80ec9f78 r5:00000000
> [ 2.490390] r4:81818810
> [ 2.492937] [<8065e800>] (platform_drv_probe) from [<8065c0a0>] (really_probe+0x128/0x534)
> [ 2.501207] r7:00000000 r6:80f5b8c4 r5:81818810 r4:80f5b8d4
> [ 2.506877] [<8065bf78>] (really_probe) from [<8065c700>] (driver_probe_device+0x88/0x200)
> [ 2.515148] r10:00000000 r9:80f0bb60 r8:00000000 r7:80f160a8 r6:80ec9f78 r5:80ec9f78
> [ 2.522981] r4:81818810
> [ 2.525526] [<8065c678>] (driver_probe_device) from [<8065c904>] (__driver_attach_async_helper+0x8c/0xb4)
> [ 2.535100] r9:80f0bb60 r8:00000000 r7:8104d000 r6:80ec9f78 r5:80f25010 r4:81818810
> [ 2.542853] [<8065c878>] (__driver_attach_async_helper) from [<8015b930>] (async_run_entry_fn+0x58/0x1bc)
> [ 2.552425] r6:81a758c0 r5:80f25010 r4:81a758d0
> [ 2.557060] [<8015b8d8>] (async_run_entry_fn) from [<8015114c>] (process_one_work+0x238/0x5ac)
> [ 2.565681] r8:00000000 r7:8104d000 r6:81048400 r5:8127a080 r4:81a758d0
> [ 2.572392] [<80150f14>] (process_one_work) from [<8015152c>] (worker_thread+0x6c/0x5c0)
> [ 2.580493] r10:81048400 r9:80e03d00 r8:81048418 r7:00000088 r6:81048400 r5:8127a094
> [ 2.588325] r4:8127a080
> [ 2.590874] [<801514c0>] (worker_thread) from [<80158168>] (kthread+0x174/0x178)
> [ 2.598278] r10:8127a080 r9:81217fe4 r8:8116fe74 r7:81364000 r6:00000000 r5:8127b040
> [ 2.606111] r4:81217fc0
> [ 2.608654] [<80157ff4>] (kthread) from [<80100148>] (ret_from_fork+0x14/0x2c)
> [ 2.615881] Exception stack(0x81365fb0 to 0x81365ff8)
> [ 2.620941] 5fa0: 00000000 00000000 00000000 00000000
> [ 2.629127] 5fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
> [ 2.637311] 5fe0: 00000000 00000000 00000000 00000000 00000013 00000000
> [ 2.643934] r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80157ff4
> [ 2.651766] r4:8127b040
> [ 2.654741] pcieport 0000:00:00.0: PME: Signaling with IRQ 316
> [ 2.672706] VFS: Mounted root (squashfs filesystem) readonly on device 179:2.
> [ 2.684075] Freeing unused kernel memory: 1024K
> [ 2.710947] Run /sbin/init as init process
> [ 2.959976] init: Console is alive
> [ 2.963628] init: - watchdog -
> [ 3.364282] kmodloader: loading kernel modules from /etc/modules-boot.d/*
> [ 3.418956] gpio-keys gpio-keys: does not support key code:143
> [ 3.427977] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
> [ 3.441567] init: - preinit -
> [ 4.224669] Micrel KSZ9031 Gigabit PHY 2188000.ethernet-1:07: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=2188000.ethernet-1:07, irq=120)
> Press the [f] key and hit [enter] to enter failsafe mode
> Press the [1], [2], [3] or [4] key and hit [enter] to select the debug level
> [ 8.560835] EXT4-fs (loop0): recovery complete
> [ 8.566782] EXT4-fs (loop0): mounted filesystem with ordered data mode. Opts: (null)
> [ 8.576293] mount_root: switching to ext4 overlay
> [ 8.824878] EXT4-fs (mmcblk2p1): mounted filesystem without journal. Opts: (null)
> [ 8.841054] urandom-seed: Seeding with /etc/urandom.seed
> [ 8.957052] procd: - early -
> [ 8.960004] procd: - watchdog -
> [ 9.553020] procd: - watchdog -
> [ 9.556647] procd: - ubus -
> [ 9.719723] procd: - init -
> Please press Enter to activate this console.
> [ 10.135757] kmodloader: loading kernel modules from /etc/modules.d/*
> [ 10.147710] urngd: v1.0.2 started.
> [ 10.158876] can: controller area network core
> [ 10.163463] NET: Registered protocol family 29
> [ 10.169546] CAN device driver interface
> [ 10.174395] can: raw protocol
> [ 10.510803] sps30 0-0069: failed to reset device
> [ 10.518325] usbcore: registered new interface driver usbserial_generic
> [ 10.524997] usbserial: USB Serial support registered for generic
> [ 10.537468] xt_time: kernel timezone is -0000
> [ 10.560920] usbcore: registered new interface driver option
> [ 10.566594] usbserial: USB Serial support registered for GSM modem (1-port)
> [ 10.580628] kmodloader: done loading kernel modules from /etc/modules.d/*
> [ 15.264668] Micrel KSZ9031 Gigabit PHY 2188000.ethernet-1:07: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=2188000.ethernet-1:07, irq=120)
> [ 15.280953] br-lan: port 1(eth0) entered blocking state
> [ 15.286194] br-lan: port 1(eth0) entered disabled state
> [ 15.291801] device eth0 entered promiscuous mode
>
>
>
> BusyBox v1.33.0 () built-in shell (ash)
>
> _______ ________ __
> | |.-----.-----.-----.| | | |.----.| |_
> | - || _ | -__| || | | || _|| _|
> |_______|| __|_____|__|__||________||__| |____|
> |__| W I R E L E S S F R E E D O M
> -----------------------------------------------------
> OpenWrt SNAPSHOT, r16433+39-e48c6400e477
> -----------------------------------------------------
> === WARNING! =====================================
> There is no root password defined on this device!
> Use the "passwd" command to set up a new password
> in order to prevent unauthorized SSH logins.
> --------------------------------------------------
> root@OpenWrt:/# dmesg
> [ 0.000000] Booting Linux on physical CPU 0x0
> [ 0.000000] Linux version 5.10.27 (ynezz@ntbk) (arm-openwrt-linux-muslgnueabi-gcc (OpenWrt GCC 8.4.0 r12719+30-84f4a783c698) 8.4.0, GNU ld (GNU Binutils) 2.34) #0 SMP Wed Apr 7 12:52:23 2021
> [ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d
> [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
> [ 0.000000] OF: fdt: Machine model: Toradex Apalis iMX6Q/D Module on Ixora Carrier Board
> [ 0.000000] Memory policy: Data cache writealloc
> [ 0.000000] Ignoring RAM at 0x80000000-0x90000000
> [ 0.000000] Consider using a HIGHMEM enabled kernel.
> [ 0.000000] Zone ranges:
> [ 0.000000] Normal [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] Movable zone start for each node
> [ 0.000000] Early memory node ranges
> [ 0.000000] node 0: [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] Initmem setup node 0 [mem 0x0000000010000000-0x000000007fffffff]
> [ 0.000000] On node 0 totalpages: 458752
> [ 0.000000] Normal zone: 4032 pages used for memmap
> [ 0.000000] Normal zone: 0 pages reserved
> [ 0.000000] Normal zone: 458752 pages, LIFO batch:63
> [ 0.000000] percpu: Embedded 19 pages/cpu s47628 r8192 d22004 u77824
> [ 0.000000] pcpu-alloc: s47628 r8192 d22004 u77824 alloc=19*4096
> [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
> [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 454720
> [ 0.000000] Kernel command line: earlyprintk console=ttymxc0,115200n8 root=PARTUUID=5452574f-02 rootfstype=squashfs rootwait pci=nomsi
> [ 0.000000] Dentry cache hash table entries: 262144 (order: 8, 1048576 bytes, linear)
> [ 0.000000] Inode-cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
> [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
> [ 0.000000] Memory: 1802104K/1835008K available (9040K kernel code, 1170K rwdata, 2328K rodata, 1024K init, 242K bss, 32904K reserved, 0K cma-reserved)
> [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
> [ 0.000000] ftrace: allocating 31336 entries in 62 pages
> [ 0.000000] ftrace: allocated 62 pages with 5 groups
> [ 0.000000] rcu: Hierarchical RCU implementation.
> [ 0.000000] Rude variant of Tasks RCU enabled.
> [ 0.000000] Tracing variant of Tasks RCU enabled.
> [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
> [ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
> [ 0.000000] L2C-310 errata 752271 769419 enabled
> [ 0.000000] L2C-310 enabling early BRESP for Cortex-A9
> [ 0.000000] L2C-310 full line of zeros enabled for Cortex-A9
> [ 0.000000] L2C-310 ID prefetch enabled, offset 16 lines
> [ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
> [ 0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
> [ 0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76470001
> [ 0.000000] random: get_random_bytes called from start_kernel+0x3e0/0x5a0 with crng_init=0
> [ 0.000000] Switching to timer-based delay loop, resolution 333ns
> [ 0.000008] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
> [ 0.000029] clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
> [ 0.001279] Console: colour dummy device 80x30
> [ 0.001318] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
> [ 0.001340] pid_max: default: 32768 minimum: 301
> [ 0.001548] Mount-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
> [ 0.001588] Mountpoint-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
> [ 0.002484] CPU: Testing write buffer coherency: ok
> [ 0.002522] CPU0: Spectre v2: using BPIALL workaround
> [ 0.002789] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
> [ 0.003686] Setting up static identity map for 0x10100000 - 0x10100060
> [ 0.003845] rcu: Hierarchical SRCU implementation.
> [ 0.004844] smp: Bringing up secondary CPUs ...
> [ 0.005689] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
> [ 0.005698] CPU1: Spectre v2: using BPIALL workaround
> [ 0.006667] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
> [ 0.006676] CPU2: Spectre v2: using BPIALL workaround
> [ 0.007606] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
> [ 0.007615] CPU3: Spectre v2: using BPIALL workaround
> [ 0.007755] smp: Brought up 1 node, 4 CPUs
> [ 0.007770] SMP: Total of 4 processors activated (24.00 BogoMIPS).
> [ 0.007780] CPU: All CPU(s) started in SVC mode.
> [ 0.017479] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
> [ 0.017696] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
> [ 0.017731] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
> [ 0.017995] pinctrl core: initialized pinctrl subsystem
> [ 0.019710] NET: Registered protocol family 16
> [ 0.021665] DMA: preallocated 256 KiB pool for atomic coherent allocations
> [ 0.023180] thermal_sys: Registered thermal governor 'step_wise'
> [ 0.023660] CPU identified as i.MX6Q, silicon rev 1.5
> [ 0.245571] vdd1p1: supplied by regulator-dummy
> [ 0.254210] vdd3p0: supplied by regulator-dummy
> [ 0.262785] vdd2p5: supplied by regulator-dummy
> [ 0.271321] vddarm: supplied by regulator-dummy
> [ 0.279909] vddpu: supplied by regulator-dummy
> [ 0.288419] vddsoc: supplied by regulator-dummy
> [ 0.628532] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
> [ 0.628554] hw-breakpoint: maximum watchpoint size is 4 bytes.
> [ 0.628861] debugfs: Directory 'dummy-iomuxc-gpr@20e0000' with parent 'regmap' already present!
> [ 0.629263] imx6q-pinctrl 20e0000.pinctrl: initialized IMX pinctrl driver
> [ 0.647595] Kprobes globally optimized
> [ 0.650233] cryptd: max_cpu_qlen set to 1000
> [ 0.666849] mxs-dma 110000.dma-apbh: initialized
> [ 0.669973] usb_host_vbus: supplied by usb_host_vbus_hub
> [ 0.670896] SCSI subsystem initialized
> [ 0.671303] libata version 3.00 loaded.
> [ 0.671797] usbcore: registered new interface driver usbfs
> [ 0.671910] usbcore: registered new interface driver hub
> [ 0.671999] usbcore: registered new device driver usb
> [ 0.674185] i2c i2c-0: IMX I2C adapter registered
> [ 0.676657] i2c i2c-2: IMX I2C adapter registered
> [ 0.677730] i2c i2c-1: IMX I2C adapter registered
> [ 0.678202] pps_core: LinuxPPS API ver. 1 registered
> [ 0.678217] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
> [ 0.678258] PTP clock support registered
> [ 0.680434] clocksource: Switched to clocksource mxc_timer1
> [ 0.800167] NET: Registered protocol family 2
> [ 0.801060] tcp_listen_portaddr_hash hash table entries: 1024 (order: 1, 12288 bytes, linear)
> [ 0.801141] TCP established hash table entries: 16384 (order: 4, 65536 bytes, linear)
> [ 0.801432] TCP bind hash table entries: 16384 (order: 5, 131072 bytes, linear)
> [ 0.802002] TCP: Hash tables configured (established 16384 bind 16384)
> [ 0.802377] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
> [ 0.802490] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
> [ 0.802831] NET: Registered protocol family 1
> [ 0.802876] PCI: CLS 0 bytes, default 64
> [ 0.803583] hw perfevents: no interrupt-affinity property for /pmu, guessing.
> [ 0.803842] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
> [ 0.809163] workingset: timestamp_bits=14 max_order=19 bucket_order=5
> [ 0.813910] squashfs: version 4.0 (2009/01/31) Phillip Lougher
> [ 0.926864] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
> [ 0.929303] imx6q-pcie 1ffc000.pcie: host bridge /soc/pcie@1ffc000 ranges:
> [ 0.929370] imx6q-pcie 1ffc000.pcie: IO 0x0001f80000..0x0001f8ffff -> 0x0000000000
> [ 0.929411] imx6q-pcie 1ffc000.pcie: MEM 0x0001000000..0x0001efffff -> 0x0001000000
> [ 0.936834] imx-sdma 20ec000.sdma: loaded firmware 3.5
> [ 0.938840] pfuze100-regulator 2-0008: Full layer: 1, Metal layer: 1
> [ 0.939545] pfuze100-regulator 2-0008: FAB: 0, FIN: 0
> [ 0.939560] pfuze100-regulator 2-0008: pfuze100 found.
> [ 0.956572] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
> [ 0.957946] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 34, base_baud = 5000000) is a IMX
> [ 1.670939] printk: console [ttymxc0] enabled
> [ 1.676645] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 81, base_baud = 5000000) is a IMX
> [ 1.686125] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 82, base_baud = 5000000) is a IMX
> [ 1.695541] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 83, base_baud = 5000000) is a IMX
> [ 1.711037] loop: module loaded
> [ 1.714198] Loading iSCSI transport class v2.0-870.
> [ 1.720904] ahci-imx 2200000.sata: fsl,transmit-level-mV not specified, using 00000024
> [ 1.728838] ahci-imx 2200000.sata: fsl,transmit-boost-mdB not specified, using 00000480
> [ 1.736873] ahci-imx 2200000.sata: fsl,transmit-atten-16ths not specified, using 00002000
> [ 1.745076] ahci-imx 2200000.sata: fsl,receive-eq-mdB not specified, using 05000000
> [ 1.752856] ahci-imx 2200000.sata: supply ahci not found, using dummy regulator
> [ 1.760380] ahci-imx 2200000.sata: supply phy not found, using dummy regulator
> [ 1.767721] ahci-imx 2200000.sata: supply target not found, using dummy regulator
> [ 1.778076] ahci-imx 2200000.sata: SSS flag set, parallel bus scan disabled
> [ 1.785108] ahci-imx 2200000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
> [ 1.793935] ahci-imx 2200000.sata: flags: ncq sntf stag pm led clo only pmp pio slum part ccc apst
> [ 1.804523] scsi host0: ahci-imx
> [ 1.808138] ata1: SATA max UDMA/133 mmio [mem 0x02200000-0x02203fff] port 0x100 irq 86
> [ 1.818261] libphy: Fixed MDIO Bus: probed
> [ 1.836498] pps pps0: new PPS source ptp0
> [ 1.842688] libphy: fec_enet_mii_bus: probed
> [ 1.848952] fec 2188000.ethernet eth0: registered PHC device 0
> [ 1.855343] e1000e: Intel(R) PRO/1000 Network Driver
> [ 1.860315] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
> [ 1.866373] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
> [ 1.872957] ehci-pci: EHCI PCI platform driver
> [ 1.877464] ehci-mxc: Freescale On-Chip EHCI Host driver
> [ 1.886285] rtc-ds1307 0-0068: oscillator failed, set time!
> [ 1.892036] rtc-ds1307 0-0068: registered as rtc0
> [ 1.898144] rtc-ds1307 0-0068: hctosys: unable to read the hardware clock
> [ 1.905241] i2c /dev entries driver
> [ 1.911218] sdhci: Secure Digital Host Controller Interface driver
> [ 1.917410] sdhci: Copyright(c) Pierre Ossman
> [ 1.921792] sdhci-pltfm: SDHCI platform and OF driver helper
> [ 1.928836] sdhci-esdhc-imx 2194000.mmc: Got CD GPIO
> [ 1.929555] caam 2100000.crypto: Entropy delay = 3200
> [ 1.966821] mmc2: SDHCI controller on 2198000.mmc [2198000.mmc] using ADMA
> [ 1.974375] mmc1: SDHCI controller on 2194000.mmc [2194000.mmc] using ADMA
> [ 1.999674] caam 2100000.crypto: Instantiated RNG4 SH0
> [ 2.040446] imx6q-pcie 1ffc000.pcie: Phy link never came up
> [ 2.049259] imx6q-pcie 1ffc000.pcie: PCI host bridge to bus 0000:00
> [ 2.055566] pci_bus 0000:00: root bus resource [bus 00-ff]
> [ 2.060434] caam 2100000.crypto: Instantiated RNG4 SH1
> [ 2.061088] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
> [ 2.066207] caam 2100000.crypto: device ID = 0x0a16010000000000 (Era 4)
> [ 2.072406] pci_bus 0000:00: root bus resource [mem 0x01000000-0x01efffff]
> [ 2.076096] mmc2: new DDR MMC card at address 0001
> [ 2.077087] mmcblk2: mmc2:0001 BIWIN 7.28 GiB
> [ 2.077714] mmcblk2boot0: mmc2:0001 BIWIN partition 1 4.00 MiB
> [ 2.078331] mmcblk2boot1: mmc2:0001 BIWIN partition 2 4.00 MiB
> [ 2.078464] mmcblk2rpmb: mmc2:0001 BIWIN partition 3 4.00 MiB, chardev (248:0)
> [ 2.079029] caam 2100000.crypto: job rings = 2, qi = 0
> [ 2.079769] mmcblk2: p1 p2
> [ 2.085973] pci 0000:00:00.0: [16c3:abcd] type 01 class 0x060400
> [ 2.098373] caam algorithms registered in /proc/crypto
> [ 2.101276] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x000fffff]
> [ 2.108603] caam 2100000.crypto: registering rng-caam
> [ 2.114480] pci 0000:00:00.0: reg 0x38: [mem 0x00000000-0x0000ffff pref]
> [ 2.124125] NET: Registered protocol family 10
> [ 2.128468] pci 0000:00:00.0: Limiting cfg_size to 512
> [ 2.134736] Segment Routing with IPv6
> [ 2.139879] pci 0000:00:00.0: imx6_pcie_quirk+0x0/0x84 took 11125 usecs
> [ 2.142319] ata1: SATA link down (SStatus 0 SControl 300)
> [ 2.142367] ahci-imx 2200000.sata: no device found, disabling link.
> [ 2.142376] ahci-imx 2200000.sata: pass ahci_imx..hotplug=1 to enable hotplug
> [ 2.145016] NET: Registered protocol family 17
> [ 2.151684] pci 0000:00:00.0: supports D1
> [ 2.156289] 8021q: 802.1Q VLAN Support v1.8
> [ 2.161238] pci 0000:00:00.0: PME# supported from D0 D1 D3hot D3cold
> [ 2.165900] PCI: bus0: Fast back to back transfers disabled
> [ 2.173156] Registering SWP/SWPB emulation handler
> [ 2.181426] PCI: bus1: Fast back to back transfers enabled
> [ 2.185540] Key type ._fscrypt registered
> [ 2.190445] pci 0000:00:00.0: BAR 0: assigned [mem 0x01000000-0x010fffff]
> [ 2.194840] Key type .fscrypt registered
> [ 2.198843] pci 0000:00:00.0: BAR 6: assigned [mem 0x01100000-0x0110ffff pref]
> [ 2.203025] Key type fscrypt-provisioning registered
> [ 2.207714] Key type encrypted registered
> [ 2.209408] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
> [ 2.239936] imx_thermal 20c8000.anatop:tempmon: Industrial CPU temperature grade - max:105C critical:100C passive:95C
> [ 2.240101] pci 0000:00:00.0: Max Payload Size set to 128/ 128 (was 128), Max Read Rq 128
> [ 2.280656] sysfs: cannot create duplicate filename '/devices/platform/soc/1ffc000.pcie/pci0000:00/0000:00:00.0/config'
> [ 2.291471] CPU: 1 PID: 46 Comm: kworker/u8:3 Not tainted 5.10.27 #0
> [ 2.297832] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
> [ 2.303545] random: fast init done
> [ 2.304384] Workqueue: events_unbound async_run_entry_fn
> [ 2.313090] Backtrace:
> [ 2.315558] [<8010cc88>] (dump_backtrace) from [<8010d134>] (show_stack+0x20/0x24)
> [ 2.323136] r7:813285d4 r6:60000013 r5:00000000 r4:80ec845c
> [ 2.328815] [<8010d114>] (show_stack) from [<805971fc>] (dump_stack+0xa4/0xb8)
> [ 2.336058] [<80597158>] (dump_stack) from [<803a7128>] (sysfs_warn_dup+0x68/0x74)
> [ 2.343636] r7:813285d4 r6:80af0dfc r5:812fc8f0 r4:81bcb000
> [ 2.349305] [<803a70c0>] (sysfs_warn_dup) from [<803a6c90>] (sysfs_add_file_mode_ns+0x100/0x1cc)
> [ 2.358098] r7:813285d4 r6:812fc8f0 r5:80b4299c r4:ffffffef
> [ 2.363765] [<803a6b90>] (sysfs_add_file_mode_ns) from [<803a6fe8>] (sysfs_create_bin_file+0x94/0x9c)
> [ 2.372991] r6:81e68078 r5:80b4299c r4:00000000
> [ 2.377626] [<803a6f54>] (sysfs_create_bin_file) from [<805da848>] (pci_create_sysfs_dev_files+0x58/0x2cc)
> [ 2.387285] r6:81e68000 r5:81e68078 r4:81e68000
> [ 2.391923] [<805da7f0>] (pci_create_sysfs_dev_files) from [<805cba98>] (pci_bus_add_device+0x34/0x90)
> [ 2.401237] r10:80b45d88 r9:81818810 r8:81328400 r7:813285d4 r6:81bd8000 r5:81e68078
> [ 2.409071] r4:81e68000
> [ 2.411615] [<805cba64>] (pci_bus_add_device) from [<805cbb30>] (pci_bus_add_devices+0x3c/0x80)
> [ 2.420318] r5:81bd8014 r4:81e68000
> [ 2.423905] [<805cbaf4>] (pci_bus_add_devices) from [<805cf898>] (pci_host_probe+0x50/0xa0)
> [ 2.425126] random: crng init done
> [ 2.432263] r7:813285d4 r6:81bd8000 r5:81bd800c r4:00000000
> [ 2.432279] [<805cf848>] (pci_host_probe) from [<805eeb20>] (dw_pcie_host_init+0x1d0/0x414)
> [ 2.432294] r7:813285d4 r6:81328258 r5:00000200 r4:00000000
> [ 2.455360] [<805ee950>] (dw_pcie_host_init) from [<805ef5a8>] (imx6_pcie_probe+0x38c/0x69c)
> [ 2.463807] r10:81226180 r9:ef0205c4 r8:81818800 r7:81328240 r6:81328240 r5:81818810
> [ 2.471640] r4:00000020
> [ 2.474197] [<805ef21c>] (imx6_pcie_probe) from [<8065e858>] (platform_drv_probe+0x58/0xa8)
> [ 2.482557] r10:80ec9f78 r9:00000000 r8:80f160a8 r7:00000000 r6:80ec9f78 r5:00000000
> [ 2.490390] r4:81818810
> [ 2.492937] [<8065e800>] (platform_drv_probe) from [<8065c0a0>] (really_probe+0x128/0x534)
> [ 2.501207] r7:00000000 r6:80f5b8c4 r5:81818810 r4:80f5b8d4
> [ 2.506877] [<8065bf78>] (really_probe) from [<8065c700>] (driver_probe_device+0x88/0x200)
> [ 2.515148] r10:00000000 r9:80f0bb60 r8:00000000 r7:80f160a8 r6:80ec9f78 r5:80ec9f78
> [ 2.522981] r4:81818810
> [ 2.525526] [<8065c678>] (driver_probe_device) from [<8065c904>] (__driver_attach_async_helper+0x8c/0xb4)
> [ 2.535100] r9:80f0bb60 r8:00000000 r7:8104d000 r6:80ec9f78 r5:80f25010 r4:81818810
> [ 2.542853] [<8065c878>] (__driver_attach_async_helper) from [<8015b930>] (async_run_entry_fn+0x58/0x1bc)
> [ 2.552425] r6:81a758c0 r5:80f25010 r4:81a758d0
> [ 2.557060] [<8015b8d8>] (async_run_entry_fn) from [<8015114c>] (process_one_work+0x238/0x5ac)
> [ 2.565681] r8:00000000 r7:8104d000 r6:81048400 r5:8127a080 r4:81a758d0
> [ 2.572392] [<80150f14>] (process_one_work) from [<8015152c>] (worker_thread+0x6c/0x5c0)
> [ 2.580493] r10:81048400 r9:80e03d00 r8:81048418 r7:00000088 r6:81048400 r5:8127a094
> [ 2.588325] r4:8127a080
> [ 2.590874] [<801514c0>] (worker_thread) from [<80158168>] (kthread+0x174/0x178)
> [ 2.598278] r10:8127a080 r9:81217fe4 r8:8116fe74 r7:81364000 r6:00000000 r5:8127b040
> [ 2.606111] r4:81217fc0
> [ 2.608654] [<80157ff4>] (kthread) from [<80100148>] (ret_from_fork+0x14/0x2c)
> [ 2.615881] Exception stack(0x81365fb0 to 0x81365ff8)
> [ 2.620941] 5fa0: 00000000 00000000 00000000 00000000
> [ 2.629127] 5fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
> [ 2.637311] 5fe0: 00000000 00000000 00000000 00000000 00000013 00000000
> [ 2.643934] r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80157ff4
> [ 2.651766] r4:8127b040
> [ 2.654741] pcieport 0000:00:00.0: PME: Signaling with IRQ 316
> [ 2.672706] VFS: Mounted root (squashfs filesystem) readonly on device 179:2.
> [ 2.684075] Freeing unused kernel memory: 1024K
> [ 2.710947] Run /sbin/init as init process
> [ 2.715058] with arguments:
> [ 2.715065] /sbin/init
> [ 2.715073] earlyprintk
> [ 2.715079] with environment:
> [ 2.715086] HOME=/
> [ 2.715092] TERM=linux
> [ 2.959976] init: Console is alive
> [ 2.963628] init: - watchdog -
> [ 3.364282] kmodloader: loading kernel modules from /etc/modules-boot.d/*
> [ 3.418956] gpio-keys gpio-keys: does not support key code:143
> [ 3.427977] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
> [ 3.441567] init: - preinit -
> [ 4.224669] Micrel KSZ9031 Gigabit PHY 2188000.ethernet-1:07: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=2188000.ethernet-1:07, irq=120)
> [ 8.560835] EXT4-fs (loop0): recovery complete
> [ 8.566782] EXT4-fs (loop0): mounted filesystem with ordered data mode. Opts: (null)
> [ 8.576293] mount_root: switching to ext4 overlay
> [ 8.824878] EXT4-fs (mmcblk2p1): mounted filesystem without journal. Opts: (null)
> [ 8.841054] urandom-seed: Seeding with /etc/urandom.seed
> [ 8.957052] procd: - early -
> [ 8.960004] procd: - watchdog -
> [ 9.553020] procd: - watchdog -
> [ 9.556647] procd: - ubus -
> [ 9.719723] procd: - init -
> [ 10.135757] kmodloader: loading kernel modules from /etc/modules.d/*
> [ 10.147710] urngd: v1.0.2 started.
> [ 10.158876] can: controller area network core
> [ 10.163463] NET: Registered protocol family 29
> [ 10.169546] CAN device driver interface
> [ 10.174395] can: raw protocol
> [ 10.510803] sps30 0-0069: failed to reset device
> [ 10.518325] usbcore: registered new interface driver usbserial_generic
> [ 10.524997] usbserial: USB Serial support registered for generic
> [ 10.537468] xt_time: kernel timezone is -0000
> [ 10.560920] usbcore: registered new interface driver option
> [ 10.566594] usbserial: USB Serial support registered for GSM modem (1-port)
> [ 10.580628] kmodloader: done loading kernel modules from /etc/modules.d/*
> [ 15.264668] Micrel KSZ9031 Gigabit PHY 2188000.ethernet-1:07: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=2188000.ethernet-1:07, irq=120)
> [ 15.280953] br-lan: port 1(eth0) entered blocking state
> [ 15.286194] br-lan: port 1(eth0) entered disabled state
> [ 15.291801] device eth0 entered promiscuous mode
>
> Cheers,
>
> Petr
Hi all,
Adding some more info regarding this issue:
I've cooked up this simple patch to get some more info:
Index: linux-5.10.44/drivers/pci/pci-sysfs.c
===================================================================
--- linux-5.10.44.orig/drivers/pci/pci-sysfs.c
+++ linux-5.10.44/drivers/pci/pci-sysfs.c
@@ -1335,6 +1335,8 @@ int __must_check pci_create_sysfs_dev_fi
int rom_size;
struct bin_attribute *attr;
+ dump_stack();
+
if (!sysfs_initialized)
return -EACCES;
Which shows this:
[ 1.847384] Key type .fscrypt registered
[ 1.854288] pci 0000:01:00.0: PCI bridge to [bus 02-05]
[ 1.859242] Key type fscrypt-provisioning registered
[ 1.863252] pci 0000:01:00.0: bridge window [mem 0x01100000-0x011fffff]
[ 1.874096] Key type encrypted registered
[ 1.879290] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[ 1.879306] pci 0000:00:00.0: bridge window [mem 0x01100000-0x012fffff]
--> patch kicking in here showing first creation now
[ 1.879346] CPU: 1 PID: 7 Comm: kworker/u4:0 Not tainted 5.10.44 #0
[ 1.913354] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
[ 1.919908] Workqueue: events_unbound async_run_entry_fn
[ 1.925255] [<8010d5e0>] (unwind_backtrace) from [<801099f0>]
(show_stack+0x10/0x14)
[ 1.933008] [<801099f0>] (show_stack) from [<804ab92c>]
(dump_stack+0x94/0xa8)
[ 1.940249] [<804ab92c>] (dump_stack) from [<804ea96c>]
(pci_create_sysfs_dev_files+0x10/0x28c)
[ 1.948969] [<804ea96c>] (pci_create_sysfs_dev_files) from
[<804dc648>] (pci_bus_add_device+0x20/0x84)
[ 1.958287] [<804dc648>] (pci_bus_add_device) from [<804dc6d8>]
(pci_bus_add_devices+0x2c/0x70)
[ 1.966996] [<804dc6d8>] (pci_bus_add_devices) from [<804dffc8>]
(pci_host_probe+0x40/0x94)
[ 1.975362] [<804dffc8>] (pci_host_probe) from [<804fd5f0>]
(dw_pcie_host_init+0x1c0/0x3fc)
[ 1.983720] [<804fd5f0>] (dw_pcie_host_init) from [<804fdcb0>]
(imx6_pcie_probe+0x358/0x63c)
[ 1.992179] [<804fdcb0>] (imx6_pcie_probe) from [<8054c79c>]
(platform_drv_probe+0x48/0x98)
[ 2.000542] [<8054c79c>] (platform_drv_probe) from [<8054a9fc>]
(really_probe+0xfc/0x4dc)
[ 2.008732] [<8054a9fc>] (really_probe) from [<8054b0bc>]
(driver_probe_device+0x5c/0xb4)
[ 2.016916] [<8054b0bc>] (driver_probe_device) from [<8054b1bc>]
(__driver_attach_async_helper+0xa8/0xac)
[ 2.026497] [<8054b1bc>] (__driver_attach_async_helper) from
[<8014beec>] (async_run_entry_fn+0x44/0x108)
[ 2.036082] [<8014beec>] (async_run_entry_fn) from [<80141b64>]
(process_one_work+0x1d8/0x43c)
[ 2.044704] [<80141b64>] (process_one_work) from [<80141e2c>]
(worker_thread+0x64/0x5b0)
[ 2.052802] [<80141e2c>] (worker_thread) from [<80147698>]
(kthread+0x148/0x14c)
[ 2.060207] [<80147698>] (kthread) from [<80100148>]
(ret_from_fork+0x14/0x2c)
[ 2.067433] Exception stack(0x81075fb0 to 0x81075ff8)
[ 2.072493] 5fa0: 00000000
00000000 00000000 00000000
[ 2.080678] 5fc0: 00000000 00000000 00000000 00000000 00000000
00000000 00000000 00000000
[ 2.088864] 5fe0: 00000000 00000000 00000000 00000000 00000013 00000000
--> getting called again .. different caller this time .. seems
unimportant ?
[ 2.095490] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.10.44 #0
[ 2.095924] pcieport 0000:00:00.0: PME: Signaling with IRQ 307
[ 2.101510] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
[ 2.113883] [<8010d5e0>] (unwind_backtrace) from [<801099f0>]
(show_stack+0x10/0x14)
[ 2.121638] [<801099f0>] (show_stack) from [<804ab92c>]
(dump_stack+0x94/0xa8)
[ 2.128875] [<804ab92c>] (dump_stack) from [<804ea96c>]
(pci_create_sysfs_dev_files+0x10/0x28c)
[ 2.137588] [<804ea96c>] (pci_create_sysfs_dev_files) from
[<80b1b920>] (pci_sysfs_init+0x34/0x54)
[ 2.146559] [<80b1b920>] (pci_sysfs_init) from [<80101820>]
(do_one_initcall+0x54/0x1e8)
[ 2.154667] [<80101820>] (do_one_initcall) from [<80b01108>]
(kernel_init_freeable+0x23c/0x290)
[ 2.163386] [<80b01108>] (kernel_init_freeable) from [<80837e3c>]
(kernel_init+0x8/0x118)
[ 2.171578] [<80837e3c>] (kernel_init) from [<80100148>]
(ret_from_fork+0x14/0x2c)
[ 2.179151] Exception stack(0x81053fb0 to 0x81053ff8)
[ 2.184210] 3fa0: 00000000
00000000 00000000 00000000
[ 2.192393] 3fc0: 00000000 00000000 00000000 00000000 00000000
00000000 00000000 00000000
[ 2.200575] 3fe0: 00000000 00000000 00000000 00000000 00000013 00000000
--> And then finally, the error occurs as it's already been added
before. same cpu and same PID trying to add the same stuff again to sysfs
[ 2.207200] CPU: 1 PID: 7 Comm: kworker/u4:0 Not tainted 5.10.44 #0
[ 2.207263] sysfs: cannot create duplicate filename
'/devices/platform/soc/1ffc000.pcie/pci0000:00/0000:00:00.0/config' <------
[ 2.213478] Hardware name: Freescale i.MX6 Quad/DualLite (Device Tree)
[ 2.230798] Workqueue: events_unbound async_run_entry_fn
[ 2.236129] [<8010d5e0>] (unwind_backtrace) from [<801099f0>]
(show_stack+0x10/0x14)
[ 2.243882] [<801099f0>] (show_stack) from [<804ab92c>]
(dump_stack+0x94/0xa8)
[ 2.251118] [<804ab92c>] (dump_stack) from [<804ea96c>]
(pci_create_sysfs_dev_files+0x10/0x28c)
[ 2.259837] [<804ea96c>] (pci_create_sysfs_dev_files) from
[<804dc648>] (pci_bus_add_device+0x20/0x84)
[ 2.269153] [<804dc648>] (pci_bus_add_device) from [<804dc6d8>]
(pci_bus_add_devices+0x2c/0x70)
[ 2.277861] [<804dc6d8>] (pci_bus_add_devices) from [<804dc70c>]
(pci_bus_add_devices+0x60/0x70)
[ 2.286656] [<804dc70c>] (pci_bus_add_devices) from [<804dffc8>]
(pci_host_probe+0x40/0x94)
[ 2.295018] [<804dffc8>] (pci_host_probe) from [<804fd5f0>]
(dw_pcie_host_init+0x1c0/0x3fc)
[ 2.303377] [<804fd5f0>] (dw_pcie_host_init) from [<804fdcb0>]
(imx6_pcie_probe+0x358/0x63c)
[ 2.311832] [<804fdcb0>] (imx6_pcie_probe) from [<8054c79c>]
(platform_drv_probe+0x48/0x98)
[ 2.320196] [<8054c79c>] (platform_drv_probe) from [<8054a9fc>]
(really_probe+0xfc/0x4dc)
[ 2.328382] [<8054a9fc>] (really_probe) from [<8054b0bc>]
(driver_probe_device+0x5c/0xb4)
[ 2.336567] [<8054b0bc>] (driver_probe_device) from [<8054b1bc>]
(__driver_attach_async_helper+0xa8/0xac)
[ 2.346145] [<8054b1bc>] (__driver_attach_async_helper) from
[<8014beec>] (async_run_entry_fn+0x44/0x108)
[ 2.355727] [<8014beec>] (async_run_entry_fn) from [<80141b64>]
(process_one_work+0x1d8/0x43c)
[ 2.364350] [<80141b64>] (process_one_work) from [<80141e2c>]
(worker_thread+0x64/0x5b0)
[ 2.372449] [<80141e2c>] (worker_thread) from [<80147698>]
(kthread+0x148/0x14c)
[ 2.379853] [<80147698>] (kthread) from [<80100148>]
(ret_from_fork+0x14/0x2c)
[ 2.387077] Exception stack(0x81075fb0 to 0x81075ff8)
[ 2.392134] 5fa0: 00000000
00000000 00000000 00000000
[ 2.400317] 5fc0: 00000000 00000000 00000000 00000000 00000000
00000000 00000000 00000000
[ 2.408498] 5fe0: 00000000 00000000 00000000 00000000 00000013 00000000
Any idea?
Thanks,
Koen
next prev parent reply other threads:[~2021-06-25 11:29 UTC|newest]
Thread overview: 25+ messages / expand[flat|nested] mbox.gz Atom feed top
2020-07-16 11:04 PCI: Race condition in pci_create_sysfs_dev_files Pali Rohár
2020-08-14 8:08 ` Pali Rohár
2020-09-09 11:28 ` Pali Rohár
2020-10-05 8:20 ` Pali Rohár
2020-10-05 13:54 ` Bjorn Helgaas
2020-10-06 22:22 ` Bjorn Helgaas
2020-10-07 1:47 ` Oliver O'Halloran
2020-10-07 8:14 ` Pali Rohár
2020-10-07 16:14 ` Bjorn Helgaas
2020-10-08 19:59 ` Bjorn Helgaas
2020-10-09 8:08 ` Pali Rohár
2020-11-04 16:29 ` Pali Rohár
2020-11-15 6:19 ` Krzysztof Wilczyński
2020-11-15 12:10 ` Pali Rohár
2020-10-07 8:12 ` Pali Rohár
2021-04-07 14:25 ` Petr Štetiar
2021-04-07 14:51 ` Pali Rohár
2021-04-07 15:30 ` Petr Štetiar
2021-06-25 11:29 ` Koen Vandeputte [this message]
2021-06-25 11:54 ` Pali Rohár
2021-10-13 6:18 ` Dexuan-Linux Cui
2021-11-18 3:09 ` Krzysztof Wilczyński
2021-11-18 3:42 ` Dexuan Cui
2020-11-04 16:46 ` Pali Rohár
2021-04-07 14:41 ` Pali Rohár
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=cd4812f0-1de3-0582-936c-ba30906595af@citymesh.com \
--to=koen.vandeputte@citymesh.com \
--cc=andrew@lunn.ch \
--cc=bhelgaas@google.com \
--cc=gregory.clement@bootlin.com \
--cc=helgaas@kernel.org \
--cc=kw@linux.com \
--cc=linux-kernel@vger.kernel.org \
--cc=linux-pci@vger.kernel.org \
--cc=lorenzo.pieralisi@arm.com \
--cc=pali@kernel.org \
--cc=yinghai@kernel.org \
--cc=ynezz@true.cz \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).