Hi,
Hardware: Turris Omnia, Indiegogo, delivered in October 2016
On Oct 1 we moved from Bern, a Swiss city, to the countryside. Our new place does not have FTTH, only FTTB (the fiber comes into the building, but building-internal cabling unfortunately is copper), therefore I switched from the Fiber7 offering to Copper7 (same ISP, but using their xDSL/g.fast offering).
I found a Swiss shop having g.fast SFPs in stock (Engitech) and ordered the PROSCEND 190-T. It took me not much time to remove the FlexOptix SFP and get the g.fast SFP to work. The SFP got recognized immediately, and all I had to do was to enable PPPoE on the WAN interface and to enter the credentials my ISP provided me.
On Dec 15 my Turris Omnia got auto-upgraded from TOS 3.11.23 to TOS 5.3.3. At the time I didn’t realize the update had happened. All I noticed was that the Internet link was down, and I wasn’t able to get it up again. Reboots and tinkering, etc. nothing helped. At the time I thought the SFP got killed (it’s getting REALLY hot). At that time, I switched to the ISP’s Fritz!Box 7582 which I am running until today.
Last week I received a new SFP, and therefore I tried to debug the situation one more time knowing I had a “known-good” SFP.
After some digging around in the unfamiliar looking Foris UI I only then realized the update to TOS 5.x most probably was the culprit due to matching timestamps of when the router went offline, and when the update was applied.
I noticed the “Snapshot” functionality, reverted to TOS 3.11.23 — and the SFP worked again. I assumed TOS 5.3.5 would have fixed the issue, upgraded — and the SFP stopped working again. Downgraded again, SFP works flawlessly again.
I then came around the upgrade info about the symlink /boot/dtb, upgraded again, only to realize that the SFP driver is automatically loaded at is should be.
Some logs:
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.14.264 (packaging@turris.cz) (gcc version 7.5.0 (OpenWrt GCC 7.5.0 r11397+89-524cbcf6f5)) #0 SMP Tue Feb 8 00:42:25 2022
[ 0.000000] CPU: ARMv7 Processor [414fc091] revision 1 (ARMv7), cr=10c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Turris Omnia
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] On node 0 totalpages: 262144
[ 0.000000] free_area_init_node: node 0, pgdat c0b3c7c0, node_mem_map ef6f9000
[ 0.000000] Normal zone: 1728 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 196608 pages, LIFO batch:31
[ 0.000000] HighMem zone: 65536 pages, LIFO batch:15
[ 0.000000] random: get_random_bytes called from start_kernel+0x8c/0x4cc with crng_init=0
[ 0.000000] percpu: Embedded 11 pages/cpu s15372 r8192 d21492 u45056
[ 0.000000] pcpu-alloc: s15372 r8192 d21492 u45056 alloc=11*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 260416
[ 0.000000] Kernel command line: earlyprintk console=ttyS0,115200 rootfstype=btrfs rootdelay=2 root=b301 rootflags=subvol=@,commit=5 rw cfg80211.freg=**
[ 0.000000] Bootloader command line not present
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 1027600K/1048576K available (7168K kernel code, 244K rwdata, 1696K rodata, 1024K init, 260K bss, 20976K reserved, 0K cma-reserved, 262144K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc0800000 (8160 kB)
[ 0.000000] .init : 0xc0a00000 - 0xc0b00000 (1024 kB)
[ 0.000000] .data : 0xc0b00000 - 0xc0b3d0c0 ( 245 kB)
[ 0.000000] .bss : 0xc0b3d0c0 - 0xc0b7e3d0 ( 261 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] L2C: DT/platform modifies aux control register: 0x06070000 -> 0x16070000
[ 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 D prefetch enabled, offset 1 lines
[ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[ 0.000000] L2C-310 Coherent cache controller enabled, 16 ways, 1024 kB
[ 0.000000] L2C-310 Coherent: CACHE_ID 0x410054c9, AUX_CTRL 0x56070001
[ 0.000006] sched_clock: 64 bits at 800MHz, resolution 1ns, wraps every 4398046511103ns
[ 0.000016] clocksource: arm_global_timer: mask: 0xffffffffffffffff max_cycles: 0xb881274fa3, max_idle_ns: 440795210636 ns
[ 0.000029] Switching to timer-based delay loop, resolution 1ns
[ 0.000158] Ignoring duplicate/late registration of read_current_timer delay
[ 0.000165] clocksource: armada_370_xp_clocksource: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 76450417870 ns
[ 0.000327] Console: colour dummy device 80x30
[ 0.000345] Calibrating delay loop (skipped), value calculated using timer frequency.. 1600.00 BogoMIPS (lpj=8000000)
[ 0.000352] pid_max: default: 32768 minimum: 301
[ 0.000412] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000418] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000700] CPU: Testing write buffer coherency: ok
[ 0.000712] CPU0: Spectre v2: using BPIALL workaround
[ 0.000831] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.000956] Setting up static identity map for 0x100000 - 0x100060
[ 0.001030] mvebu-soc-id: MVEBU SoC ID=0x6820, Rev=0x4
[ 0.001106] mvebu-pmsu: Initializing Power Management Service Unit
[ 0.001157] Hierarchical SRCU implementation.
[ 0.001352] smp: Bringing up secondary CPUs ...
[ 0.001488] Booting CPU 1
[ 0.001639] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.001641] CPU1: Spectre v2: using BPIALL workaround
[ 0.001693] smp: Brought up 1 node, 2 CPUs
[ 0.001698] SMP: Total of 2 processors activated (3200.00 BogoMIPS).
[ 0.001701] CPU: All CPU(s) started in SVC mode.
[ 0.002150] devtmpfs: initialized
[ 0.003765] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[ 0.003818] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.003826] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.003877] xor: measuring software checksum speed
[ 0.100067] arm4regs : 2392.800 MB/sec
[ 0.200068] 8regs : 1936.000 MB/sec
[ 0.300066] 32regs : 2050.800 MB/sec
[ 0.400066] neon : 1837.200 MB/sec
[ 0.400070] xor: using function: arm4regs (2392.800 MB/sec)
[ 0.400076] pinctrl core: initialized pinctrl subsystem
[ 0.400424] NET: Registered protocol family 16
[ 0.400925] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.401472] cpuidle: using governor ladder
[ 0.401562] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[ 0.401567] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.401685] mvebu-pmsu: CPU hotplug support is currently broken on Armada 38x: disabling
[ 0.401691] mvebu-pmsu: CPU idle is currently broken on Armada 38x: disabling
[ 0.570230] raid6: int32x1 gen() 171 MB/s
[ 0.740089] raid6: int32x1 xor() 243 MB/s
[ 0.910102] raid6: int32x2 gen() 255 MB/s
[ 1.080125] raid6: int32x2 xor() 288 MB/s
[ 1.250228] raid6: int32x4 gen() 305 MB/s
[ 1.420156] raid6: int32x4 xor() 263 MB/s
[ 1.590165] raid6: int32x8 gen() 328 MB/s
[ 1.760113] raid6: int32x8 xor() 229 MB/s
[ 1.930093] raid6: neonx1 gen() 1111 MB/s
[ 2.100091] raid6: neonx1 xor() 1058 MB/s
[ 2.270092] raid6: neonx2 gen() 1303 MB/s
[ 2.440085] raid6: neonx2 xor() 1351 MB/s
[ 2.610095] raid6: neonx4 gen() 1070 MB/s
[ 2.780088] raid6: neonx4 xor() 1329 MB/s
[ 2.950110] raid6: neonx8 gen() 1014 MB/s
[ 3.120091] raid6: neonx8 xor() 914 MB/s
[ 3.120094] raid6: using algorithm neonx2 gen() 1303 MB/s
[ 3.120097] raid6: .... xor() 1351 MB/s, rmw enabled
[ 3.120100] raid6: using neon recovery algorithm
[ 3.120393] SCSI subsystem initialized
[ 3.120513] libata version 3.00 loaded.
[ 3.120623] usbcore: registered new interface driver usbfs
[ 3.120652] usbcore: registered new interface driver hub
[ 3.120675] usbcore: registered new device driver usb
[ 3.121347] clocksource: Switched to clocksource arm_global_timer
[ 3.125214] NET: Registered protocol family 2
[ 3.125304] IP idents hash table entries: 16384 (order: 5, 131072 bytes)
[ 3.125761] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 3.125800] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 3.125861] TCP: Hash tables configured (established 8192 bind 8192)
[ 3.125911] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 3.125943] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 3.126022] NET: Registered protocol family 1
[ 3.126038] PCI: CLS 0 bytes, default 64
[ 3.126351] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[ 3.127326] Crashlog allocated RAM at address 0x3f00000
[ 3.127429] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[ 3.129353] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 3.129361] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[ 3.131027] bounce: pool size: 64 pages
[ 3.131038] io scheduler noop registered
[ 3.131042] io scheduler deadline registered (default)
[ 3.131119] io scheduler bfq registered
[ 3.131708] armada-38x-pinctrl f1018000.pinctrl: registered pinctrl driver
[ 3.133325] mvebu-pcie soc:pcie: PCI host bridge to bus 0000:00
[ 3.133338] pci_bus 0000:00: root bus resource [io 0x1000-0xfffff]
[ 3.133343] pci_bus 0000:00: root bus resource [mem 0xe0000000-0xe7ffffff]
[ 3.133348] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 3.133364] pci 0000:00:01.0: [11ab:6820] type 01 class 0x060400
[ 3.133452] pci 0000:00:02.0: [11ab:6820] type 01 class 0x060400
[ 3.133521] pci 0000:00:03.0: [11ab:6820] type 01 class 0x060400
[ 3.133591] PCI: bus0: Fast back to back transfers disabled
[ 3.133598] pci 0000:00:01.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[ 3.133604] pci 0000:00:02.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[ 3.133610] pci 0000:00:03.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[ 3.133661] pci 0000:01:00.0: [168c:002e] type 00 class 0x028000
[ 3.133688] pci 0000:01:00.0: reg 0x10: [mem 0xe8000000-0xe800ffff 64bit]
[ 3.133777] pci 0000:01:00.0: supports D1
[ 3.133780] pci 0000:01:00.0: PME# supported from D0 D1 D3hot
[ 3.133839] PCI: bus1: Fast back to back transfers disabled
[ 3.133845] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 3.133895] pci 0000:02:00.0: [168c:003c] type 00 class 0x028000
[ 3.133922] pci 0000:02:00.0: reg 0x10: [mem 0xea000000-0xea1fffff 64bit]
[ 3.133949] pci 0000:02:00.0: reg 0x30: [mem 0xea200000-0xea20ffff pref]
[ 3.134010] pci 0000:02:00.0: supports D1 D2
[ 3.134065] PCI: bus2: Fast back to back transfers disabled
[ 3.134072] pci_bus 0000:02: busn_res: [bus 02-ff] end is updated to 02
[ 3.134104] PCI: bus3: Fast back to back transfers enabled
[ 3.134110] pci_bus 0000:03: busn_res: [bus 03-ff] end is updated to 03
[ 3.134130] pci 0000:00:01.0: BAR 8: assigned [mem 0xe0000000-0xe00fffff]
[ 3.134135] pci 0000:00:02.0: BAR 8: assigned [mem 0xe0200000-0xe04fffff]
[ 3.134142] pci 0000:01:00.0: BAR 0: assigned [mem 0xe0000000-0xe000ffff 64bit]
[ 3.134153] pci 0000:00:01.0: PCI bridge to [bus 01]
[ 3.134159] pci 0000:00:01.0: bridge window [mem 0xe0000000-0xe00fffff]
[ 3.134166] pci 0000:02:00.0: BAR 0: assigned [mem 0xe0200000-0xe03fffff 64bit]
[ 3.134177] pci 0000:02:00.0: BAR 6: assigned [mem 0xe0400000-0xe040ffff pref]
[ 3.134181] pci 0000:00:02.0: PCI bridge to [bus 02]
[ 3.134187] pci 0000:00:02.0: bridge window [mem 0xe0200000-0xe04fffff]
[ 3.134192] pci 0000:00:03.0: PCI bridge to [bus 03]
[ 3.134426] mv_xor f1060800.xor: Marvell shared XOR driver
[ 3.191816] mv_xor f1060800.xor: Marvell XOR (Descriptor Mode): ( xor cpy intr )
[ 3.191936] mv_xor f1060900.xor: Marvell shared XOR driver
[ 3.251786] mv_xor f1060900.xor: Marvell XOR (Descriptor Mode): ( xor cpy intr )
[ 3.251992] Serial: 8250/16550 driver, 16 ports, IRQ sharing enabled
[ 3.253145] console [ttyS0] disabled
[ 3.273213] f1012000.serial: ttyS0 at MMIO 0xf1012000 (irq = 22, base_baud = 15625000) is a 16550A
[ 4.169959] console [ttyS0] enabled
[ 4.193716] f1012100.serial: ttyS1 at MMIO 0xf1012100 (irq = 23, base_baud = 15625000) is a 16550A
[ 4.204539] loop: module loaded
[ 4.208044] ahci-mvebu f10a8000.sata: AHCI 0001.0000 32 slots 2 ports 6 Gbps 0x3 impl platform mode
[ 4.217136] ahci-mvebu f10a8000.sata: flags: 64bit ncq sntf led only pmp fbs pio slum part sxs
[ 4.226289] scsi host0: ahci-mvebu
[ 4.229842] scsi host1: ahci-mvebu
[ 4.233335] ata1: SATA max UDMA/133 mmio [mem 0xf10a8000-0xf10a9fff] port 0x100 irq 44
[ 4.241271] ata2: SATA max UDMA/133 mmio [mem 0xf10a8000-0xf10a9fff] port 0x180 irq 44
[ 4.250002] m25p80 spi0.0: s25fl164k (8192 Kbytes)
[ 4.254887] 2 fixed-partitions partitions found on MTD device spi0.0
[ 4.261256] Creating 2 MTD partitions on "spi0.0":
[ 4.266073] 0x000000000000-0x000000100000 : "U-Boot"
[ 4.271393] 0x000000100000-0x000000800000 : "Rescue system"
[ 4.278139] mv88e6085 f1072004.mdio-mii:10: switch 0x1760 detected: Marvell 88E6176, revision 1
[ 4.435603] mvneta f1070000.ethernet eth0: Using hardware mac address d8:58:d7:00:47:a8
[ 4.444373] mvneta f1030000.ethernet eth1: Using hardware mac address d8:58:d7:00:47:a6
[ 4.453090] mvneta f1034000.ethernet eth2: Using hardware mac address d8:58:d7:00:47:a7
[ 4.461259] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 4.467813] ehci-pci: EHCI PCI platform driver
[ 4.472299] ehci-platform: EHCI generic platform driver
[ 4.477598] ehci-orion: EHCI orion driver
[ 4.481710] orion-ehci f1058000.usb: EHCI Host Controller
[ 4.487131] orion-ehci f1058000.usb: new USB bus registered, assigned bus number 1
[ 4.494768] orion-ehci f1058000.usb: irq 40, io mem 0xf1058000
[ 4.521351] orion-ehci f1058000.usb: USB 2.0 started, EHCI 1.00
[ 4.527577] hub 1-0:1.0: USB hub found
[ 4.531364] hub 1-0:1.0: 1 port detected
[ 4.535636] xhci-hcd f10f0000.usb3: xHCI Host Controller
[ 4.540967] xhci-hcd f10f0000.usb3: new USB bus registered, assigned bus number 2
[ 4.548541] xhci-hcd f10f0000.usb3: hcc params 0x0a000990 hci version 0x100 quirks 0x0000000000010010
[ 4.557809] xhci-hcd f10f0000.usb3: irq 46, io mem 0xf10f0000
[ 4.563832] hub 2-0:1.0: USB hub found
[ 4.567604] hub 2-0:1.0: 1 port detected
[ 4.571648] xhci-hcd f10f0000.usb3: xHCI Host Controller
[ 4.572492] ata2: SATA link down (SStatus 0 SControl 300)
[ 4.576976] xhci-hcd f10f0000.usb3: new USB bus registered, assigned bus number 3
[ 4.582422] ata1: SATA link down (SStatus 0 SControl 300)
[ 4.589892] xhci-hcd f10f0000.usb3: Host supports USB 3.0 SuperSpeed
[ 4.601799] usb usb3: We don't know the algorithms for LPM for this host, disabling LPM.
[ 4.610117] hub 3-0:1.0: USB hub found
[ 4.613898] hub 3-0:1.0: 1 port detected
[ 4.617998] xhci-hcd f10f8000.usb3: xHCI Host Controller
[ 4.623339] xhci-hcd f10f8000.usb3: new USB bus registered, assigned bus number 4
[ 4.630888] xhci-hcd f10f8000.usb3: hcc params 0x0a000990 hci version 0x100 quirks 0x0000000000010010
[ 4.640151] xhci-hcd f10f8000.usb3: irq 47, io mem 0xf10f8000
[ 4.646136] hub 4-0:1.0: USB hub found
[ 4.649907] hub 4-0:1.0: 1 port detected
[ 4.653946] xhci-hcd f10f8000.usb3: xHCI Host Controller
[ 4.659274] xhci-hcd f10f8000.usb3: new USB bus registered, assigned bus number 5
[ 4.666789] xhci-hcd f10f8000.usb3: Host supports USB 3.0 SuperSpeed
[ 4.673283] usb usb5: We don't know the algorithms for LPM for this host, disabling LPM.
[ 4.681611] hub 5-0:1.0: USB hub found
[ 4.685381] hub 5-0:1.0: 1 port detected
[ 4.689516] usbcore: registered new interface driver usb-storage
[ 4.695962] armada38x-rtc f10a3800.rtc: registered as rtc0
[ 4.701600] i2c /dev entries driver
[ 4.715594] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[ 4.728056] orion_wdt: Initial timeout 171 sec
[ 4.732775] sdhci: Secure Digital Host Controller Interface driver
[ 4.738969] sdhci: Copyright(c) Pierre Ossman
[ 4.801352] mmc0: SDHCI controller on f10d8000.sdhci [f10d8000.sdhci] using ADMA
[ 4.808853] sdhci-pltfm: SDHCI platform and OF driver helper
[ 4.815376] marvell-cesa f1090000.crypto: CESA device successfully registered
[ 4.822978] NET: Registered protocol family 10
[ 4.829007] Segment Routing with IPv6
[ 4.832719] NET: Registered protocol family 17
[ 4.837187] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[ 4.852297] 8021q: 802.1Q VLAN Support v1.8
[ 4.856567] Registering SWP/SWPB emulation handler
[ 4.862639] Btrfs loaded, crc32c=crc32c-generic
[ 4.868163] mv88e6085 f1072004.mdio-mii:10: switch 0x1760 detected: Marvell 88E6176, revision 1
[ 4.958284] mmc0: new high speed MMC card at address 0001
[ 4.963871] mmcblk0: mmc0:0001 H8G4a? 7.28 GiB
[ 4.968486] mmcblk0boot0: mmc0:0001 H8G4a? partition 1 4.00 MiB
[ 4.974500] mmcblk0boot1: mmc0:0001 H8G4a? partition 2 4.00 MiB
[ 4.980493] mmcblk0rpmb: mmc0:0001 H8G4a? partition 3 4.00 MiB, chardev (250:0)
[ 4.988883] mmcblk0: p1
[ 5.066839] DSA: switch 0 0 parsed
[ 5.070254] DSA: tree 0 parsed
[ 5.765443] mv88e6085 f1072004.mdio-mii:10 lan0 (uninitialized): PHY [mv88e6xxx-1:00] driver [Marvell 88E1540]
[ 5.877678] mv88e6085 f1072004.mdio-mii:10 lan1 (uninitialized): PHY [mv88e6xxx-1:01] driver [Marvell 88E1540]
[ 5.995443] mv88e6085 f1072004.mdio-mii:10 lan2 (uninitialized): PHY [mv88e6xxx-1:02] driver [Marvell 88E1540]
[ 6.115443] mv88e6085 f1072004.mdio-mii:10 lan3 (uninitialized): PHY [mv88e6xxx-1:03] driver [Marvell 88E1540]
[ 6.225442] mv88e6085 f1072004.mdio-mii:10 lan4 (uninitialized): PHY [mv88e6xxx-1:04] driver [Marvell 88E1540]
[ 6.247488] armada38x-rtc f10a3800.rtc: setting system clock to 2022-02-12 23:57:19 UTC (1644710239)
[ 6.256931] Waiting 2 sec before mounting root device...
[ 8.314169] F2FS-fs (mmcblk0p1): Magic Mismatch, valid(0xf2f52010) - read(0x0)
[ 8.321425] F2FS-fs (mmcblk0p1): Can't find valid F2FS filesystem in 1th superblock
[ 8.329293] F2FS-fs (mmcblk0p1): Magic Mismatch, valid(0xf2f52010) - read(0x0)
[ 8.336540] F2FS-fs (mmcblk0p1): Can't find valid F2FS filesystem in 2th superblock
[ 8.344251] F2FS-fs (mmcblk0p1): Magic Mismatch, valid(0xf2f52010) - read(0x0)
[ 8.351496] F2FS-fs (mmcblk0p1): Can't find valid F2FS filesystem in 1th superblock
[ 8.359169] F2FS-fs (mmcblk0p1): Magic Mismatch, valid(0xf2f52010) - read(0x0)
[ 8.366411] F2FS-fs (mmcblk0p1): Can't find valid F2FS filesystem in 2th superblock
[ 8.375024] BTRFS: device fsid 3f35b7e1-fb1e-4a6c-a855-128e375bc340 devid 1 transid 38730 /dev/root
[ 8.384713] BTRFS info (device mmcblk0p1): disk space caching is enabled
[ 8.391442] BTRFS info (device mmcblk0p1): has skinny extents
[ 8.403540] BTRFS info (device mmcblk0p1): enabling ssd optimizations
[ 8.415196] VFS: Mounted root (btrfs filesystem) on device 0:12.
[ 8.421502] devtmpfs: mounted
[ 8.425039] Freeing unused kernel memory: 1024K
[ 8.466781] init: Console is alive
[ 8.470254] init: - watchdog -
[ 8.482712] random: fast init done
[ 8.834180] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[ 8.847357] exFAT: Version 1.2.9
[ 8.862711] SGI XFS with ACLs, security attributes, no debug enabled
[ 8.871261] usbcore: registered new interface driver uas
[ 8.876710] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[ 8.891157] init: - preinit -
[ 10.980181] mount_root: mounting /dev/root
[ 10.984920] BTRFS info (device mmcblk0p1): disk space caching is enabled
[ 10.992109] mount_root: loading kmods from internal overlay
[ 11.013738] kmodloader: loading kernel modules from //etc/modules-boot.d/*
[ 11.021699] kmodloader: done loading kernel modules from //etc/modules-boot.d/*
[ 11.540597] block: attempting to load /etc/config/fstab
[ 11.547043] block: extroot: not configured
[ 11.562511] random: procd: uninitialized urandom read (4 bytes read)
[ 11.758651] urandom-seed: Seeding with /etc/urandom.seed
[ 12.091456] procd: - early -
[ 12.094369] procd: - watchdog -
[ 12.233318] random: jshn: uninitialized urandom read (4 bytes read)
[ 12.266905] random: jshn: uninitialized urandom read (4 bytes read)
[ 12.710445] procd: - watchdog -
[ 12.713758] procd: - ubus -
[ 12.767478] procd: - init -
[ 13.071117] kmodloader: loading kernel modules from /etc/modules.d/*
[ 13.110747] NET: Registered protocol family 38
[ 13.152855] async_tx: api initialized (async)
[ 13.172189] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@redhat.com
[ 13.184404] Key type dns_resolver registered
[ 13.197083] Key type cifs.idmap registered
[ 13.215086] RPC: Registered named UNIX socket transport module.
[ 13.221030] RPC: Registered udp transport module.
[ 13.225797] RPC: Registered tcp transport module.
[ 13.230512] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 13.241625] ntfs: driver 2.1.32 [Flags: R/O MODULE].
[ 13.261637] tun: Universal TUN/TAP device driver, 1.6
[ 13.275110] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 13.284896] gre: GRE over IPv4 demultiplexor driver
[ 13.290668] ip_gre: GRE over IPv4 tunneling driver
[ 13.323873] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[ 13.338690] NFS: Registering the id_resolver key type
[ 13.343804] Key type id_resolver registered
[ 13.347997] Key type id_legacy registered
[ 13.363402] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 13.380209] Netfilter messages via NETLINK v0.30.
[ 13.386393] ip_set: protocol 6
[ 13.412375] cryptodev: driver 1.10 loaded.
[ 13.416011] random: crng init done
[ 13.419916] random: 7 urandom warning(s) missed due to ratelimiting
[ 13.436507] i2c i2c-0: Added multiplexed i2c bus 1
[ 13.441597] i2c i2c-0: Added multiplexed i2c bus 2
[ 13.446600] i2c i2c-0: Added multiplexed i2c bus 3
[ 13.451625] i2c i2c-0: Added multiplexed i2c bus 4
[ 13.456659] i2c i2c-0: Added multiplexed i2c bus 5
[ 13.461923] i2c i2c-0: Added multiplexed i2c bus 6
[ 13.466906] i2c i2c-0: Added multiplexed i2c bus 7
[ 13.472091] pca953x 8-0071: 8-0071 supply vcc not found, using dummy regulator
[ 13.481442] i2c i2c-0: Added multiplexed i2c bus 8
[ 13.486254] pca954x 0-0070: registered 8 multiplexed busses for I2C mux pca9547
[ 13.495306] Mirror/redirect action on
[ 13.503282] u32 classifier
[ 13.505999] input device check on
[ 13.509671] Actions configured
[ 13.516657] sch_cake: Unknown symbol nf_conntrack_find_get (err 0)
[ 13.523061] sch_cake: Unknown symbol nf_ct_get_tuplepr (err 0)
[ 13.554100] fuse init (API version 7.26)
[ 13.566382] Bridge firewalling registered
[ 13.571141] usbcore: registered new interface driver cdc_wdm
[ 13.577939] Loading modules backported from Linux version v4.19.221-0-g5fd3cce374df
[ 13.585640] Backport generated by backports.git v4.19.221-1-0-g07fffc43
[ 13.596179] Ebtables v2.0 registered
[ 13.600822] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 13.613153] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[ 13.635096] ctnetlink v0.93: registering with nfnetlink.
[ 13.669714] usbcore: registered new interface driver ums-alauda
[ 13.676908] usbcore: registered new interface driver ums-cypress
[ 13.683456] usbcore: registered new interface driver ums-datafab
[ 13.689949] usbcore: registered new interface driver ums-freecom
[ 13.696604] usbcore: registered new interface driver ums-isd200
[ 13.703098] usbcore: registered new interface driver ums-jumpshot
[ 13.709663] usbcore: registered new interface driver ums-karma
[ 13.716173] usbcore: registered new interface driver ums-sddr09
[ 13.722675] usbcore: registered new interface driver ums-sddr55
[ 13.729046] usbcore: registered new interface driver ums-usbat
[ 13.739468] usbcore: registered new interface driver usbserial
[ 13.745396] usbcore: registered new interface driver usbserial_generic
[ 13.751994] usbserial: USB Serial support registered for generic
[ 13.771049] xt_time: kernel timezone is -0000
[ 13.776999] at24 1-0054: 8192 byte 24c64 EEPROM, writable, 1 bytes/write
[ 13.784865] usbcore: registered new interface driver cdc_ether
[ 13.828351] PPP generic driver version 2.4.2
[ 13.840216] sfp sfp: module PROSCEND 190-T rev V7.3 sn 19207J7B92080009 dc 31-08-20
[ 13.849591] sfp sfp: unknown connector, encoding 8b10b, nominal bitrate 1.3Gbps +0% -0%
[ 13.857806] sfp sfp: 1000BaseSX+ 1000BaseLX- 1000BaseCX- 1000BaseT- 100BaseTLX- 1000BaseFX- BaseBX10- BasePX-
[ 13.867940] sfp sfp: 10GBaseSR- 10GBaseLR- 10GBaseLRM- 10GBaseER-
[ 13.874235] sfp sfp: Wavelength 0nm, fiber lengths:
[ 13.879302] sfp sfp: 9µm SM : unsupported
[ 13.884030] sfp sfp: 62.5µm MM OM1: unsupported/unspecified
[ 13.889799] sfp sfp: 50µm MM OM2: unsupported/unspecified
[ 13.895576] sfp sfp: 50µm MM OM3: unsupported/unspecified
[ 13.901353] sfp sfp: 50µm MM OM4: 2.540km
[ 13.905724] sfp sfp: Options: retimer
[ 13.909577] sfp sfp: Diagnostics:
[ 13.913182] mvneta f1034000.ethernet eth2: switched to inband/1000base-x link mode
[ 13.921485] PPP MPPE Compression module registered
[ 13.927081] NET: Registered protocol family 24
[ 13.932536] usbcore: registered new interface driver qmi_wwan
[ 13.939419] usbcore: registered new interface driver rndis_host
[ 13.959942] pci 0000:00:02.0: enabling device (0140 -> 0142)
[ 13.965862] ath10k_pci 0000:02:00.0: pci irq msi oper_irq_mode 2 irq_mode 0 reset_mode 0
[ 14.203963] ath10k_pci 0000:02:00.0: Direct firmware load for ath10k/pre-cal-pci-0000:02:00.0.bin failed with error -2
[ 14.214716] ath10k_pci 0000:02:00.0: Falling back to user helper
[ 16.095485] firmware ath10k!pre-cal-pci-0000:02:00.0.bin: firmware_loading_store: map pages failed
[ 16.104607] ath10k_pci 0000:02:00.0: Direct firmware load for ath10k/cal-pci-0000:02:00.0.bin failed with error -2
[ 16.115008] ath10k_pci 0000:02:00.0: Falling back to user helper
[ 16.125627] firmware ath10k!cal-pci-0000:02:00.0.bin: firmware_loading_store: map pages failed
[ 16.134462] ath10k_pci 0000:02:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-6.bin failed with error -2
[ 16.145200] ath10k_pci 0000:02:00.0: Falling back to user helper
[ 16.155703] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
[ 16.173658] ath10k_pci 0000:02:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
[ 16.182940] ath10k_pci 0000:02:00.0: kconfig debug 0 debugfs 1 tracing 0 dfs 1 testmode 1
[ 16.192465] ath10k_pci 0000:02:00.0: firmware ver 10.2.4-1.0-00047 api 5 features no-p2p,raw-mode,mfp,allows-mesh-bcast crc32 35bd9258
[ 16.237255] ath10k_pci 0000:02:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/board-2.bin failed with error -2
[ 16.247726] ath10k_pci 0000:02:00.0: Falling back to user helper
[ 16.258456] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed
[ 16.268571] ath10k_pci 0000:02:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
[ 17.407875] ath10k_pci 0000:02:00.0: htt-ver 2.1 wmi-op 5 htt-op 2 cal otp max-sta 128 raw 0 hwcrypto 1
[ 17.521775] ath: EEPROM regdomain: 0x0
[ 17.521777] ath: EEPROM indicates default country code should be used
[ 17.521779] ath: doing EEPROM country->regdmn map search
[ 17.521782] ath: country maps to regdmn code: 0x3a
[ 17.521784] ath: Country alpha2 being used: US
[ 17.521786] ath: Regpair used: 0x3a
[ 17.533317] usbcore: registered new interface driver option
[ 17.538971] usbserial: USB Serial support registered for GSM modem (1-port)
[ 17.551852] usbcore: registered new interface driver qcserial
[ 17.557669] usbserial: USB Serial support registered for Qualcomm USB modem
[ 17.570887] pci 0000:00:01.0: enabling device (0140 -> 0142)
[ 17.664394] ath: EEPROM regdomain: 0x0
[ 17.664398] ath: EEPROM indicates default country code should be used
[ 17.664402] ath: doing EEPROM country->regdmn map search
[ 17.664409] ath: country maps to regdmn code: 0x3a
[ 17.664414] ath: Country alpha2 being used: US
[ 17.664418] ath: Regpair used: 0x3a
[ 17.676660] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
[ 17.678286] ieee80211 phy1: Atheros AR9287 Rev:2 mem=0xf09e0000, irq=82
[ 17.686913] kmodloader: done loading kernel modules from /etc/modules.d/*
[ 20.044950] mvneta f1030000.ethernet eth1: configuring for fixed/rgmii link mode
[ 20.052995] IPv6: ADDRCONF(NETDEV_UP): eth1: link is not ready
[ 20.059042] mvneta f1030000.ethernet eth1: Link is Up - 1Gbps/Full - flow control off
[ 20.067564] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
[ 20.076136] mv88e6085 f1072004.mdio-mii:10 lan0: configuring for phy/gmii link mode
[ 20.084268] br-lan: port 1(lan0) entered blocking state
[ 20.089520] br-lan: port 1(lan0) entered disabled state
[ 20.108331] device lan0 entered promiscuous mode
[ 20.113080] device eth1 entered promiscuous mode
[ 20.172699] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[ 20.187072] mv88e6085 f1072004.mdio-mii:10 lan1: configuring for phy/gmii link mode
[ 20.199251] br-lan: port 2(lan1) entered blocking state
[ 20.204544] br-lan: port 2(lan1) entered disabled state
[ 20.224251] device lan1 entered promiscuous mode
[ 20.279803] mv88e6085 f1072004.mdio-mii:10 lan2: configuring for phy/gmii link mode
[ 20.304128] br-lan: port 3(lan2) entered blocking state
[ 20.309384] br-lan: port 3(lan2) entered disabled state
[ 20.327858] device lan2 entered promiscuous mode
[ 20.386774] mv88e6085 f1072004.mdio-mii:10 lan3: configuring for phy/gmii link mode
[ 20.407659] br-lan: port 4(lan3) entered blocking state
[ 20.412925] br-lan: port 4(lan3) entered disabled state
[ 20.431049] device lan3 entered promiscuous mode
[ 20.482026] mvneta f1070000.ethernet eth0: configuring for fixed/rgmii link mode
[ 20.490071] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 20.496032] mvneta f1070000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[ 20.519960] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 20.533465] mv88e6085 f1072004.mdio-mii:10 lan4: configuring for phy/gmii link mode
[ 20.541885] br-lan: port 5(lan4) entered blocking state
[ 20.547136] br-lan: port 5(lan4) entered disabled state
[ 20.575375] device lan4 entered promiscuous mode
[ 20.580014] device eth0 entered promiscuous mode
[ 20.647982] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 20.660211] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 21.229252] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 21.240407] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready
[ 22.392733] mvneta f1034000.ethernet eth2: Link is Down
[ 22.487437] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 22.496105] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 23.065266] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 23.079519] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready
[ 23.948683] mv88e6085 f1072004.mdio-mii:10 lan3: Link is Up - 1Gbps/Full - flow control off
[ 23.965313] br-lan: port 4(lan3) entered blocking state
[ 23.970569] br-lan: port 4(lan3) entered forwarding state
[ 24.013021] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[ 24.228908] mvneta f1034000.ethernet eth2: Link is Down
[ 24.393249] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 48.411065] mvneta f1034000.ethernet eth2: Link is Down
[ 48.428597] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 48.437305] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 48.486163] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 48.498053] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 49.064633] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 49.072537] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready
[ 50.228362] mvneta f1034000.ethernet eth2: Link is Down
[ 50.279845] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 50.288650] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 50.858653] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 50.871742] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready
[ 52.022006] mvneta f1034000.ethernet eth2: Link is Down
[ 52.064394] mvneta f1034000.ethernet eth2: configuring for inband/1000base-x link mode
[ 52.073847] IPv6: ADDRCONF(NETDEV_UP): eth2: link is not ready
[ 52.643308] mvneta f1034000.ethernet eth2: Link is Up - 1Gbps/Full - flow control off
[ 52.651174] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready
I researched a bit more and my understanding is that the SFP functionality of TOS 3.x has been completely revamped in TOS 5.x, and not every SFP is guaranteed to continue working.
Question: Is there any chance my SFP is going to work again in the forseeable future?
I am happy to provide logs and to debug the issue. I now also have a spare SFP lying around which I am happy to lend to an engineer, but you require a g.fast line on your side of course to really test it.
Thanks & Best,
M.