[Gelöst] 800MB Ftp/sftp-transfer über VPN für zum crash der FB6360 (LAN1 als WAN)

[vaxinf]

Hallo,

nachdem der AVM-Support nur meinte, ich sollte halt kein ftp/sftp-transfer von großen Datenmengen durchführen, möchte ich hier im Forum frage, ob ein Workaround bekannt ist?

Hier Konfig: PC(192.168.10.21) <-> FB1 (192.168.10.1)<->FB1-LAN1(134.34.109.12)<->FB2-LAN1(134.34.109.6)<->FB2(192.168.11.1)<->FTP-SERVER(192.168.11.150).

Der Transfer bricht irgendwann mittendrin ab und die FB1 rebootet.

Eberhard

 

[Theo Tintensich]

Was ist mit "sftp" gemeint?
Dass der verkehr über eine FTP-verbinsung mit verschlüsseltem Befehlskanal geht, oder dass die Verbindung über Port 22 (also SSH-verschlüsselt) geht?

Sie WAN-Seite der beiden FB ist wirklich im gleichen Netz?

FB1-LAN1(134.34.109.12)<->FB2-LAN1(134.34.109.6)

 

[vaxinf]

sftp ist "ssh-verschlüsselt" und benutzt port 22.

Die Konfiguration erscheint wirklich obskur. Zur Erklärung: die beiden Router sind in einem Uni-Netz auf zwei Stockwerke verteilt und liegen nicht einfach
benachbart. Dazwischen sind Switches mit VLANs, die das Ganze managen.

Ich habe diesen Setup zum Testen benutzt, weil ich auf dem entfernt liegenden Rechner (ein Raspi) einen ftp-Server gestartet habe, weil AVM zuerst behauptete, dass es an der ssh-Verschlüsselung liegt, warum die FB abschmiert.

Beim dem sftp-Test ist die entfernte Box in einem ganz anderen Adressbereich (KabelBW) und dort verhielt sich die lokale FB genauso unwirsch wie beim anschließenden ftp-Test.

Eberhard

 

[Theo Tintensich]

Das klingt irgendwie nach einem Speicherloch bei dem VPN-Tunnel. Wenn etwas verschlüsseltes nochmals verschlüsselt werden soll, sucht die Software vielleicht zu lange nach einem Bereich, der sich gut komprimieren lässt, und lädt deshalb zu viel in den Speicher, der vollläuft-
Denn Daten, die verschlüsselt werden sollen, sollen (müssen) vorher komprimiert werden, um erstens die Datenmenge zu reduzieren, und zweiten eine "Plain-Text-Attacke" zu erschweren.

Du benutzt die VPN-Lösung von AVM für die Netz-Kopplung?
Auf der Box, die abschmiert mal eine andere Lösung probieren (eigener VPN-Server...)

 

[vaxinf]

Ja, es ist die mitgelieferte VPN-Software von AVM (Firmware 6.52, also recht aktuell und die neueste Version für die FB6360).

Wenn es wirklich ein Programmierfehler in der VPN-Software ist, sollte der auch bei anderen FBs auftauchen!

Ich habe schon die Konfigdaten mit dem FBEditor durchforstet, aber nichts gefunden, was nützlich wäre zu verändern (Puffergrößen u.ä.).

Ich möchte ungern anfangen, eine anderen VPN-Lösung auszutesten, solange es Chancen gibt, das Problem so zu lösen.

eberhard

 

[PeterPawn]

Was steht denn im "crash.log" in den Support-Daten, warum die Box neu startet?

 

[vaxinf]

##### BEGIN SECTION CRASHLOG /proc/avm/log_sd
==========

BEGIN SECTION '/proc/avm/log_sd/crash'
----------
sent on: Thu Jan 1 01:31:20 CET 1970 by supportdata
2016-12-19 15:17:10 "pcd"(1255) REBOOT reason unknown
2016-12-20 11:15:59 "pcd"(1255) REBOOT reason unknown
2017-01-08 16:23:16 "pcd"(1257) REBOOT reason unknown
2017-01-09 17:12:53 "pcd"(1257) REBOOT reason unknown
2017-01-17 20:20:55 "pcd"(1257) REBOOT reason unknown
2017-01-31 15:49:54 "pcd"(1257) REBOOT reason unknown
-----
(first) sent on: Wed Feb 22 14:27:52 2017 UTC by support data
----------
END SECTION '/proc/avm/log_sd/crash'
==========
##### END SECTION CRASHLOG
##### BEGIN SECTION PANICLOG /proc/avm/log_sd
==========

BEGIN SECTION '/proc/avm/log_sd/panic'
----------
UPTIME: 86153
(0 d 23 h 55 min 53 s - panic on Wed Feb 22 14:12:23 2017 UTC )
PANIC LOG VERSION 2.0
<5>Linux version 2.6.28.10 (gcc version 4.7.3 20130102 (prerelease) (Buildroot 2012.08) ) #1 PREEMPT Thu Sep 22 12:50:12 CEST 2016
<4>CPU: ARMv6-compatible processor [410fb764] revision 4 (ARMv7), cr=00c538ff
<4>CPU: VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
<4>Machine: puma5
<4>bank[0] start 80000000 size 8000000 node 0
<4>Ignoring unrecognised tag 0x00000000
<4>annex: Kabel
<4>Memory policy: ECC disabled, Data cache writeback
<6>nid=0 start=80000 map=8042e end=88000 mapsize=1000 mode_bootmen_map=8042e000
<7>On node 0 totalpages: 32768
<7>free_area_init_node: node 0, pgdat 8036450c, node_mem_map 8042f000
<7> Normal zone: 256 pages used for memmap
<7> Normal zone: 0 pages reserved
<7> Normal zone: 32512 pages, LIFO batch:7
<7> Movable zone: 0 pages used for memmap
<4>[c55] c55_mem_start = 0x87ff0000
<4>entering build_all_zonelists()
<4>return from set_zonelist_order()
<4>Built 1 zonelists in Zone order, mobility grouping on. Total pages: 32512
<5>Kernel command line: console=ttyS0,115200n81
<4>AVALANCHE_INTC_BASE: e5000000
<4>Interrupt controller revision : 4e822100
<4>PID hash table entries: 512 (order: 9, 2048 bytes)
<4>Power & Sleep Controller @ 0xd8621000 Initialized [id-0x44822905]
<4>USB PHY POR Bypass enabled
<4>Initialized Peripheral Port Remap Register to base : 0x50000000
<6> Puma5 Timer0 and HRES Timer2 initialized
<3>pll_div_1_reg=0x8000 at 0xd8620118
<3>pll_div_2_reg=0x8003 at 0xd862011c
<3>pll_div_3_reg=0x8001 at 0xd8620120
<3>pll_div_4_reg=0x8003 at 0xd8620160
<3>pll_div_5_reg=0x8000 at 0xd8620164
<3>pll_div_6_reg=0x8001 at 0xd8620168
<4>Console: colour dummy device 80x30
<4>[rs_avm_console_init] (console_init)
<6>console [ttyS0] enabled
<6>Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
<6>Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
<6>Memory: 128MB = 128MB total
<5>Memory: 125440KB available (3220K code, 916K data, 108K init)
<6>Calibrating delay loop... 399.76 BogoMIPS (lpj=1998848)
<6>Security Framework initialized
<4>Mount-cache hash table entries: 512
<6>CPU: Testing write buffer coherency: ok
<4>kernel_init: started
<4>kernel_init: kernel locked
<6>net_namespace: 656 bytes
<6>NET: Registered protocol family 16
<4>[puma_gpio_init]
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x8034E2C8
<4> PAL_cppi4Init : Object Address is 0x80369884
<4> PAL_cppi4Init : Before MEM Test
<4> PAL_cppi4Init : Before QMGR Init
<4> PAL_cppi4Init : QMGR [0] Init ...
<4>PAL_cppi4Init : There is a room for 994 more descriptors
<4>Off chip memory allocated: 369664
<4>QMgr Init: buffer after alignment: 87880000
<4> PAL_cppi4Init : QMGR [1] Init ...
<3>[cpmac] Version: 1.108.1.134 - Revision 811:3085 - Do 22.09.2016 12:49:56
<4>[puma5_mtd_init](563):
<4>[puma5_mtd_init](575): linux_fs_start 0
<4>[puma5_mtd_init](611): mtd[0] = 0x48000000,0x48000000
<4>[puma5_mtd_init](622): mtd[0] = 0x00000000 - 0x00000000
<4>[puma5_mtd_init](611): mtd[1] = 0x48020000,0x48F80000
<4>[puma5_mtd_init](622): mtd[1] = 0x00020000 - 0x00f80000
<4>[puma5_mtd_init](611): mtd[2] = 0x48000000,0x48020000
<4>[puma5_mtd_init](622): mtd[2] = 0x00000000 - 0x00020000
<4>[puma5_mtd_init](611): mtd[3] = 0x48F80000,0x48FC0000
<4>[puma5_mtd_init](622): mtd[3] = 0x00f80000 - 0x00fc0000
<4>[puma5_mtd_init](611): mtd[4] = 0x48FC0000,0x49000000
<4>[puma5_mtd_init](622): mtd[4] = 0x00fc0000 - 0x01000000
<4>[puma5_mtd_init](611): mtd[5] = 0x49000000
<4>[puma5_mtd_init](660): mtd0: filesystem: 0x00000000 - 0x00000000 (size 0x0)
<4>[puma5_mtd_init](660): mtd1: kernel: 0x00020000 - 0x00f80000 (size 0xf60000)
<4>[puma5_mtd_init](660): mtd2: urlader: 0x00000000 - 0x00020000 (size 0x20000)
<4>[puma5_mtd_init](660): mtd3: tffs (1): 0x00f80000 - 0x00fc0000 (size 0x40000)
<4>[puma5_mtd_init](660): mtd4: tffs (2): 0x00fc0000 - 0x01000000 (size 0x40000)
<4>[puma5_mtd_init](660): mtd5: extra: 0x00020000 - 0x00f80000 (size 0xf60000)
<4>[puma5_mtd_init](660): mtd6: jffs2: 0x00000000 - 0x00000000 (size 0x0)
<4>[puma5_mtd_init](709): special mtd_parser registered
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x00000000
<4> PAL_cppi4Init : Object Address is 0x80369884
<4>avalanche_ppd_init: PP system initialized successfully.
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x8034E2C8
<4> PAL_cppi4Init : Object Address is 0x80369884
<4>PAL_cppi4BufPoolDirectInit : Pool[10] is at 0x87900000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[11] is at 0x87980000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[13] is at 0x87A00000 of 0x00040000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 6] is at 0x87A40000 of 0x00020000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 7] is at 0x87A80000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 0] is at 0x87B00000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 1] is at 0x87B80000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 4] is at 0x87000000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 5] is at 0x87A60000 of 0x00010000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[12] is at 0x87080000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 2] is at 0x87100000 of 0x00080000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 8] is at 0x87A70000 of 0x00010000 size
<4>PAL_cppi4BufPoolDirectInit : Pool[ 9] is at 0x87874000 of 0x00004000 size
<4>avalanche_ppd_init(951):return code 0x00
<4>HIL Core: Profile intrusive has been Loaded.
<6>NET: Registered protocol family 2
<7>
<7>
<7>Switched to high resolution mode on CPU 0
<7>
<6>IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
<6>TCP established hash table entries: 4096 (order: 3, 32768 bytes)
<6>TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
<6>TCP: Hash tables configured (established 4096 bind 4096)
<6>TCP reno registered
<6>NET: Registered protocol family 1
<4>NetWinder Floating Point Emulator V0.97 (extended precision)
<6>audit: initializing netlink socket (disabled)
<5>type=2000 audit(1.700:1): initialized
<6>squashfs: version 3.4 (2008/08/26) Phillip Lougher
<6>JFFS2 version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
<4>fuse init (API version 7.10)
<6>msgmni has been set to 245
<6>io scheduler noop registered (default)
<6>avm_net_trace: Up and running.
<4>[avm] configured: watchdog event debug
<4>AVM_WATCHDOG: Watchdog Driver for AR7 Hardware (Version 1.0, build: Sep 22 2016 12:49:27)
<6>[loadcontrol] set auto - scale=1
<4>[uart_avm_init] (module_init)
<6>Serial: SERIAL_AVM_8250 driver
<6>ttyS0 at MMIO 0x8610e00 (irq = 7) is a PORT_16550A
<6>loop: module loaded
<6>nbd: registered device at major 43
<6>tun: Universal TUN/TAP device driver, 1.6
<6>tun: (C) 1999-2004 Max Krasnyansky <[email protected]>
<4>Loading cpgmac driver for puma5
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x00000000
<4> PAL_cppi4Init : Object Address is 0x80369884
<6>PP: Succesfully created VPID 31 PID 31 Device cpmac0
<6>PP: Ingress Hook on PID/VPID: 31/31 Name: cpmac0
<6>PP: Egress Hook on PID/VPID: 31/31 Name: cpmac0
<4>TI CPGMAC_F Linux DDA version 0.1 - CPGMAC_F DDC version 0.2
<4>Cpmac: Installed 1 instances.
<4>Cpmac driver is allocating buffer memory at init time.
<4>Generic platform RAM MTD, (c) 2004 Simtec Electronics
<4>Serial Flash [Bus:0 CS:0] : mx25l12805 16384KB, 4096 sectors each 4KB
<3>[sfl_probe] create sfl_sema
<4>[parse_mtd_partitions] types=find_jffs2
<5>find_jffs2 partition parsing not available
<4>[parse_mtd_partitions] types=find_squashfs
<4>[puma5_squashfs_parser_function](201): mtd_info->name=macronix, mtd_info->index=0, param=0, p_mtd_pat=0x8781bb4c
<4>[puma5_squashfs_parser_function](206): Detected macronix
<4>[puma5_squashfs_parser_function](223): MAP_FLASH
<4>[puma5_squashfs_parser_function](261): [mtd0] filesystem: 0x00000000 - 0x00000000 (size 0x0)
<4>[puma5_squashfs_parser_function](261): [mtd1] kernel: 0x00020000 - 0x00f80000 (size 0xf60000)
<4>[puma5_squashfs_parser_function](261): [mtd2] urlader: 0x00000000 - 0x00020000 (size 0x20000)
<4>[puma5_squashfs_parser_function](261): [mtd3] tffs (1): 0x00f80000 - 0x00fc0000 (size 0x40000)
<4>[puma5_squashfs_parser_function](261): [mtd4] tffs (2): 0x00fc0000 - 0x01000000 (size 0x40000)
<4>[puma5_squashfs_parser_function](261): [mtd5] extra: 0x00020000 - 0x00f80000 (size 0xf60000)
<4>[puma5_squashfs_parser_function](261): [mtd6] jffs2: 0x00000000 - 0x00000000 (size 0x0)
<4>[puma5_squashfs_parser_function](269): try partition=kernel (offset=0x20000, len=f60000, blocksize=1000)
<3>use partition 6 (jffs2) for jffs2
<4>[puma5_squashfs_parser_function](398): magic found @pos 0x14a600
<5>7 find_squashfs partitions found on MTD device macronix
<5>Creating 7 MTD partitions on "macronix":
<5>0x0014a600-0x00f80000 : "filesystem" (master-size:16777216)
<4>mtd: partition "filesystem" doesn't start on an erase block boundary -- force read-only
<4>[puma5_mtd_add_notifier](489): name filesystem
<4>[puma5_mtd_add_notifier](493): found filesystem
<4>[puma5_mtd_add_notifier](500): use filesystem
<4>[puma5_mtd_add_notifier](504): root device: /dev/mtdblock0 (filesystem)
<5>0x00020000-0x0014a600 : "kernel" (master-size:16777216)
<4>mtd: partition "kernel" doesn't end on an erase block -- force read-only
<4>[puma5_mtd_add_notifier](489): name kernel
<4>[puma5_mtd_add_notifier](536): skip kernel
<5>0x00000000-0x00020000 : "urlader" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name urlader
<4>[puma5_mtd_add_notifier](536): skip urlader
<4>[puma5_mtd_add_notifier](539): set puma5_urlader_mtd
<5>0x00f80000-0x00fc0000 : "tffs (1)" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name tffs (1)
<4>[puma5_mtd_add_notifier](527): tffs (1) on Index 3
<5>0x00fc0000-0x01000000 : "tffs (2)" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name tffs (2)
<4>[puma5_mtd_add_notifier](533): tffs (1) on Index 4
<5>0x00020000-0x00f80000 : "extra" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name extra
<4>[puma5_mtd_add_notifier](536): skip extra
<5>0x00e90000-0x00f80000 : "jffs2" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name jffs2
<4>[puma5_mtd_add_notifier](536): skip jffs2
<4>Serial Flash [Bus:0 CS:1] : mx25l12805 16384KB, 4096 sectors each 4KB
<4>[parse_mtd_partitions] types=find_jffs2
<5>find_jffs2 partition parsing not available
<4>[parse_mtd_partitions] types=find_squashfs
<4>[puma5_squashfs_parser_function](201): mtd_info->name=macronix, mtd_info->index=0, param=1, p_mtd_pat=0x8781bb4c
<4>[puma5_squashfs_parser_function](206): Detected macronix
<4>[puma5_squashfs_parser_function](223): MAP_FLASH
<4>[puma5_squashfs_parser_function](261): [mtd0] filesystem_reserved: 0x000a0000 - 0x000a0000 (size 0x0)
<4>[puma5_squashfs_parser_function](261): [mtd1] kernel_reserved: 0x000a0000 - 0x01000000 (size 0xf60000)
<4>[puma5_squashfs_parser_function](261): [mtd2] config-space: 0x00000000 - 0x000a0000 (size 0xa0000)
<4>[puma5_squashfs_parser_function](261): [mtd3] extra_reserved: 0x000a0000 - 0x01000000 (size 0xf60000)
<4>[puma5_squashfs_parser_function](261): [mtd4] jffs2_reserved: 0x00000000 - 0x00000000 (size 0x0)
<4>[puma5_squashfs_parser_function](269): try partition=kernel_reserved (offset=0xa0000, len=f60000, blocksize=1000)
<3>use partition 4 (jffs2_reserved) for jffs2
<4>[puma5_squashfs_parser_function](398): magic found @pos 0x1ca000
<5>5 find_squashfs partitions found on MTD device macronix
<5>Creating 5 MTD partitions on "macronix":
<5>0x001ca000-0x01000000 : "filesystem_reserved" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name filesystem_reserved
<4>[puma5_mtd_add_notifier](536): skip filesystem_reserved
<5>0x000a0000-0x001ca000 : "kernel_reserved" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name kernel_reserved
<4>[puma5_mtd_add_notifier](536): skip kernel_reserved
<5>0x00000000-0x000a0000 : "config-space" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name config-space
<4>[puma5_mtd_add_notifier](536): skip config-space
<5>0x000a0000-0x01000000 : "extra_reserved" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name extra_reserved
<4>[puma5_mtd_add_notifier](536): skip extra_reserved
<5>0x00f10000-0x01000000 : "jffs2_reserved" (master-size:16777216)
<4>[puma5_mtd_add_notifier](489): name jffs2_reserved
<4>[puma5_mtd_add_notifier](536): skip jffs2_reserved
<6>ti_spi.0: AVALANCHE SPI Controller driver at base=0xd8612500, phys=0xd8612500, virt=0xd8612500, irq=0
<6>mice: PS/2 mouse device common for all mice
<6>i2c /dev entries driver
<6>Initialize Avalanche IIC-over-VLYNQ adapter module
<5>CAPI Subsystem Rev 1.1.2.8
<6>oprofile: using arm/armv6
<6>IPv4 over IPv4 tunneling driver
<6>TCP cubic registered
<6>mcfw: IGMPv3 fast forwarding
<6>NET: Registered protocol family 10
<6>NET: Registered protocol family 17
<6>l2tp_core: L2TP core driver, V2.0
<6>l2tp_ip: L2TP IP encapsulation support (L2TPv3)
<6>l2tp_netlink: L2TP netlink interface
<6>l2tp_eth: L2TP ethernet pseudowire support (L2TPv3)
<6>l2tp_ip6: L2TP IP encapsulation support for IPv6 (L2TPv3)
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x00000000
<4> PAL_cppi4Init : Object Address is 0x80369884
<6>VFP support v0.3: not present
<4>TFFS: tiny flash file system driver. GPL (c) AVM Berlin (Version 2.0)
<4> mount on mtd3 and mtd4 (double buffering)
<6>Adam2 environment variables API installed.
<4>AVM Simple Profiling enabled Version 3.0
<4>kernel_init: basic setup done
<4>[squashfs] use lzma compression
<4>VFS: Mounted root (squashfs filesystem) readonly.
<6>Freeing init memory: 108K
<4>[uart_avm_startup]port 80369664
<4>trying /sbin/init
<4>TFFS Name Table I
<4>system-load 100 % loadavg 0.38 0.8 0.3 - 22 tasks:59 % curr:version(0 %) max44 %, pid:767), readytorun: 3, pgfault 1847/s (max 2 avg 1.0)
<4>led_modul_Fritz_Box_Puma: module license '
<4>(C) Copyright 2012 by AVM
<4>' taints kernel.
<2>AVM_WATCHDOG: System Init UEberwachung 240 Sekunden
<6>rtc-avm rtc-avm.0: rtc core: registered avm as rtc0
<3>[avm-rtc]: avm_rtc_probe: register: ret=0x86d86e00
<3>[avm-rtc]: avm_rtc_probe: success
<3>
<3>[avm_debug] redirecting kernel-messages (/dev/debug)
<4>
<4>---- start avmdebug(suppress 0 bytes) ----
<4>
<4>[piglet]use gpio-settings for 157
<4>[piglet] PLLDIV 8004 VLYNQ: 10206 3008000 clk = 80000000
<4>[piglet]patch_dectfw: 88975000, totallen = 80950(13c36)
<4>[piglet]patch_dectfw: patch_adress: f00a0 max_len: 26 with Version 2 Len: 17
<4>[piglet]patch_dectfw: RFPI tag found 02591c8430
<4>[piglet]dect_loader144xx: fast-bootmode
<4>*
<4>**************************************************************************************************************************************************************
<4>[piglet]dect144xx_file_process: upload of '/lib/modules/dectfw_secondlevel_488.hex' successfull
<4>[piglet]bitfile '/lib/modules/bitfile.bit1'
<4>[piglet]try to preload in progress-context: /lib/modules/bitfile.bit1
<4>[piglet] bitfile 72761 bytes done
<4>[piglet]TDM: FS: 8015 Hz CLK: 2051225 Hz
<4>system-load 100 % loadavg 0.56 0.13 0.4 - 24 tasks:24 % curr18 %) max18 %, pid:767), readytorun: 3, pgfault 2080/s (max 2 avg 1.0)
<4>[4294939475] [pcmlink]chrony-support
<4>[pcmlink]c55: simple checksum: 623DBE
<4>[4294939576] [isdn]PCMLINK: Version 5.511 (isdn: 3163) Codecslots=13 Slics=2 Pots=1 TE=2 NT=2 DECT=4 DSP-EC: 4
<4>capicodec_init()
<4>[capi_codec] support fax
<4>[capi_codec] support Codecs
<4>: Codecs_Init register a /dev/debug handler
<4>ramzswap: /dev/ramzswap0 initialized: disksize_kb=16384
<4>Adding 16376k swap on /dev/ramzswap0. Priority:-1 extents:1 across:16376k
<4>system-load 100 % loadavg 0.94 0.22 0.7 - 38 tasks:56 % curr37 %) max37 %, pid:767), readytorun: 2, pgfault 2513/s (max 3 avg 1.0)
<4>VBUS COMPARATOR pre OFF 30
<4>VBUS COMPARATOR post OFF 0
<4>[4294940575] DSP: XDU=1( D1 ) OVR=0 MIPS_OVR=0
<4>
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x00000000
<4> PAL_cppi4Init : Object Address is 0x80369884
<4> Entered HAL_DocsisCppiInit
<4> PAL_cppi4Init : domain is 1, cfg ptr is 0x7F31C860
<4> PAL_cppi4Init : Object Address is 0x8036B164
<4> PAL_cppi4Init : Before MEM Test
<4> PAL_cppi4Init : Before QMGR Init
<4> PAL_cppi4Init : QMGR [0] Init ...
<4> PAL_cppi4Init : QMGR [1] Init ...
<4>Off chip memory allocated: 32768
<4>QMgr Init: buffer after alignment: 86528000
<4>PAL_cppi4BufPoolDirectInit : Pool[ 0] is at 0x01040000 of 0x00008000 size
<4> PAL_cppi4Init : domain is 0, cfg ptr is 0x00000000
<4> PAL_cppi4Init : Object Address is 0x80369884
<4>Dbridge Init SUCSESS
<4>system-load 100 % loadavg 1.49 0.36 0.12 - 53 tasks:55 % curr:bpi_auth(0 %) max43 %, pid:767), readytorun: 3, pgfault 3942/s (max 6 avg 1.4)
<4>system-load 100 % loadavg 2.17 0.55 0.18 - 68 tasks:85 % curr:ctlmgr(6 %) max45 %, pid:767), readytorun: 5, pgfault 1601/s (max 5 avg 1.7)
<4>eRouter: start now
<4>Starting eRouter....
<4>eDocsis: interface initialized successfully
<4>[avm_power] eth: port 0 force normal CON t0
<4>[avm_power] eth: port 1 force normal CON t0
<4>[avm_power] eth: port 2 force normal CON t0
<4>[avm_power] eth: port 3 force normal CON t0
<4>Error: Device cpmac0 has a packet handler 0x8028dbf0 installed
<4>Error: Device cpmac0 has an egress hook 0x8028d6dc installed
<4>eRouter: Network interface registered successfully
<4>PP: Error: Unable to create VPID -1 PID -1 Device lan
<4>PP: Error: Unable to create VPID -1 PID -1 Device lan
<4>PP: Error: Unable to create VPID -1 PID -1 Device lan
<4>PP: Error: Unable to create VPID -1 PID -1 Device guest
<4>PP: Error: Unable to create VPID -1 PID -1 Device guest
<4>FcUtils_AddSysInterface: Failed to get net device struct for
<4>system-load 100 % loadavg 2.31 0.63 0.21 - 82 tasks:80 % curr:dsld(0 %) max36 %, pid:767), readytorun: 7, pgfault 2020/s (max 4 avg 1.2)
<4>kdsld: kdsld_vcc_preunregister: *
<4>kdsld: kdsld_vcc_preregister: preata1
<4>kdsld: kdsld_vcc_preregister: vcc->ifaces=00000000
<4>system-load 100 % loadavg 3.28 0.89 0.30 - 99 tasks:64 % curr29 %) max29 %, pid:767), readytorun: 12, pgfault 4360/s (max 5 avg 1.5)
<4>PP: Error: Unable to create VPID -1 PID -1 Device dsl
<4>PP: Error: Unable to create VPID -1 PID -1 Device dsl
<4>kdsld: HOTSPOT: no hotspots configured
<4>system-load 100 % loadavg 4.61 1.25 0.42 - 99 tasks:56 % curr:rc.wlan(2 %) max30 %, pid:767), readytorun: 4, pgfault 4238/s (max 5 avg 2.0)
<4>HTC HOST Version 1.xx Loaded...
<4>system-load 100 % loadavg 5.75 1.61 0.55 - 105 tasks:88 % curr56 %) max56 %, pid:767), readytorun: 3, pgfault 585/s (max 8 avg 5.8)
<4>AR5212, AR5416, RF5111, RF5112, RF2413, RF5413, RF2316, RF2317, DEBUG, WRITE_EEPROM, 11D)
<4>[4294947241] [DECTDRV_ERR] API_FP_MAC_START_STOP_REQ 255 -> 0
<4>[4294947432] [DECTDRV_ERR] API_FP_MAC_START_STOP_REQ 0 -> 0
<4>[4294947438] [DECTDRV_ERR] API_FP_MAC_START_STOP_REQ 0 -> 0
<4>system-load 100 % loadavg 6.39 1.88 0.65 - 102 tasks:85 % curr:luacgi(0 %) max52 %, pid:767), readytorun: 5, pgfault 943/s (max 8 avg 3.5)
<4>hif_gmac_init
<4>FWD:loaded
<4>FWD:loaded1
<4>FWD:loaded1
<4>mdio_start_handshake waiting for target to up unit 0
<4>mdio handshake is good
<4>mdio_block_send exchanging block write parameters
<4>.
<4>mdio_block_send - start_address 0x00501000 length 0x000014d8 exec_address 0x00901600
<4>.Checksum for the file acfb8934
<4>..............................................................................................................................................................................................................................................................................................................................................................................................done!
<4>Send waiting for lock
<4>MDIO FWD GOOD - releasing the lock
<4>total transfer time in jiffies 1780
<4>.
<4>HIF GMAC parametrs sent
<4>
<4>Registering the HIF :0
<4>Registering the HIF :1
<4>gmac_dev_vlan_update: updating device magpie to VID 5
<4>hif_gmac_dev_attach
<4>Post Init called
<4>Downloading ..................................................................done!
<4>system-load 100 % loadavg 6.63 2.8 0.73 - 102 tasks:83 % curridof(0 %) max45 %, pid:767), readytorun: 8, pgfault 591/s (max 2 avg 1.1)
<4>AVM_WATCHDOG: System Init UEberwachung abgeschlossen (134210 ms noch verfuegbar)
<4>SysRq : Changing Loglevel
<4>Loglevel set to 4
<4>---> reanimated debugbuffer: read=0 write=5828, written=5828 <---
<4>hif_gmac_recv_excep received TGT_READY_MSG
<4>hif_gmac_dev_attach
<4>registered CPMAC WLAN classifier
<4>Post Init called
<4>[Default Pipe]UL: 1, DL: 1
<4>[HTCProcessTargetReady 76] wakeup mutex HTCWaitForHtcRdy!
<4>[HTCWaitForHtcRdy 458] Starting mutex waiting...
<4>[HTCWaitForHtcRdy 486] Finish mutex waiting...
<4>svc 256 UL 0 DL 0
<4>svc 257 UL 0 DL 0
<4>svc 258 UL 0 DL 0
<4>svc 259 UL 0 DL 0
<4>svc 260 UL 0 DL 0
<4>svc 263 UL 0 DL 0
<4>svc 264 UL 0 DL 0
<4>svc 262 UL 0 DL 0
<4>svc 261 UL 0 DL 0
<4>registering WLANNI interface with handle @86cbc400 and device @86cbed10
<4>__ath_attach: Set global_scn[0]
<4>ACBKMinfree = 48
<4>ACBEMinfree = 32
<4>ACVIMinfree = 16
<4>ACVOMinfree = 0
<4>CABMinfree = 48
<4>UAPSDMinfree = 0
<4>ath_htc_host_txep_init: Epnum to Hardware Queue Mapping
<4>ath_htc_host_txep_init:epnum=0 hqnum=-1
<4>ath_htc_host_txep_init:epnum=1 hqnum=9
<4>ath_htc_host_txep_init:epnum=2 hqnum=-1
<4>ath_htc_host_txep_init:epnum=3 hqnum=-1
<4>ath_htc_host_txep_init:epnum=4 hqnum=-1
<4>ath_htc_host_txep_init:epnum=5 hqnum=-1
<4>ath_htc_host_txep_init:epnum=6 hqnum=-1
<4>ath_htc_host_txep_init:epnum=7 hqnum=-1
<4>ath_htc_host_txep_init:epnum=8 hqnum=-1
<4>ath_htc_host_txep_init:epnum=9 hqnum=-1
<4>ath_htc_host_txep_init:epnum=10 hqnum=-1
<4>ath_htc_host_txep_init:epnum=11 hqnum=-1
<4> osdev->beacon_ep2
<4> osdev->cab_ep 3
<4> osdev->uapsd_ep 4
<4> osdev->mgmt_ep 5
<4> osdev->data_BE_ep 6
<4> osdev->data_BK_ep 7
<4> osdev->data_VI_ep 8
<4> osdev->data_VO_ep 9
<4>dfs_attach: use DFS enhancements
<4>DFS min filter rssiThresh = 15
<4>DFS max pulse dur = 151 ticks
<4>ath_get_caps[4949] rx chainmask mismatch actual 3 sc_chainmak 0
<4>ath_get_caps[4924] tx chainmask mismatch actual 3 sc_chainmak 0
<4>ic_num_chains=2x2
<4>_avm_ath_ext_attach_ah:70
<4>_avm_ath_ext_attach_ieee:52
<4>wlan_vap_create : enter. devhandle=0x86cbc400, opmode=IEEE80211_M_HOSTAP, flags=0x1
<4>ieee80211_chk_vap_target: target_vap_bitmap(0) is invalid
<4>ieee80211_add_vap_target: target_vap_bitmap(0) is invalid
<4>ieee80211_add_vap_target: vap index: 0, vap unit 0
<4>wlan_vap_create : exit. devhandle=0x86cbc400, opmode=IEEE80211_M_HOSTAP, flags=0x1.
<4>VAP device ath0 created
<4> ieee80211_ioctl_siwmode: imr.ifm_active=131712, new mode=3, valid=1
<4> ieee80211_ioctl_siwmode: imr.ifm_active=131712, new mode=3, valid=1
<4>TFFS: Ftand > 75 ... trigger Cleanup
<4>PP: Error: Unable to delete session 140
<4>PP: Error: Unable to delete session 146
<4>PP: Error: Unable to delete session 176
<4>wmi retries 1 seq 21468 swba=836952, hb=167378
<4>Already recv reject cur 21468 last 21468 seq 21468
<4>wmi retries 1 seq 21492 swba=837455, hb=167461
<4>Already recv reject cur 21492 last 21492 seq 21492
<4>
<4>---- eof avmdebug ----
<0>[8584742][0]AVM_WATCHDOG_reboot(hdl=11, telefon): reboot (current: ksoftirqd/0 pgfault 0 oom_score 0)
<0>pagefaults absolut 1479567 since last telefon-trigger 15
<0> hdl= 2 l2tpv3d pid 1591 triggered before: 0.830 s(avg 10.720 s) state S oom_score 14
<0> hdl= 3 ctlmgr pid 1602 triggered before: 10.310 s(avg 11.070 s) state R oom_score 28
<0> hdl= 9 upnpd pid 1610 triggered before: 5.720 s(avg 20.470 s) state R oom_score 36
<0> hdl= 4 multid pid 1619 triggered before: 43.130 s(avg 23.450 s) state R oom_score 12
<0> hdl= 5 pcpd pid 1699 triggered before: 8.150 s(avg 11.150 s) state R oom_score 13
<0> hdl= 6 upnpdevd pid 1703 triggered before: 2.820 s(avg 13.510 s) state S oom_score 15
<0> hdl= 7 wland pid 1717 triggered before: 74.520 s(avg 90.010 s) state S oom_score 10
<0> hdl= 8 dsld pid 1865 triggered before: 100.400 s(avg 21.870 s) state R oom_score 26
<0> hdl=10 pbd pid 2069 triggered before: 72.660 s(avg 79.970 s) state S oom_score 18
<0> hdl=11 telefon pid 2212 triggered before: 180.010 s(avg 92.080 s) state R oom_score 27
<0> force SIGBUS for telefon (pid= 2212)
<0> hdl=12 voipd pid 2301 triggered before: 10.310 s(avg 11.300 s) state S oom_score 46
<0> hdl=13 aha pid 2404 triggered before: 23.750 s(avg 36.660 s) state S oom_score 42
<0> hdl=14 boxnotifyd pid 2419 triggered before: 29.380 s(avg 80.180 s) state S oom_score 7
<0> hdl=15 usermand pid 2482 triggered before: 2.680 s(avg 16.270 s) state R oom_score 15
<0> hdl=16 contfiltd pid 2485 triggered before: 1.700 s(avg 11.070 s) state S oom_score 15
<0>ar7wdt_hw_reboot: kernel context for telefon (pid=2212):
<6>telefon R running 0 2212 1
<4>[<80296338>] (__sched_text_start+0x0/0x340) from [<802967d0>] (preempt_schedule+0x40/0x5c)
<4>[<80296790>] (preempt_schedule+0x0/0x5c) from [<8004f808>] (local_bh_enable+0xa0/0xc0)
<4> r4:83c9c000 r3:00000002
<4>[<8004f768>] (local_bh_enable+0x0/0xc0) from [<801c53d4>] (Appl_Find_ApplId+0x84/0xc4)
<4> r4:00000000 r3:83c9c000
<4>[<801c5350>] (Appl_Find_ApplId+0x0/0xc4) from [<801c8a58>] (HOST_MAP_APPL_ID+0x20/0x34)
<4> r6:7ee002b8 r5:00000000 r4:7ee002b8 r3:00000001
<4>[<801c8a38>] (HOST_MAP_APPL_ID+0x0/0x34) from [<801c8ae0>] (HOST_MESSAGE+0x18/0xbc)
<4> r4:7ee002b8 r3:00000001
<4>[<801c8ac8>] (HOST_MESSAGE+0x0/0xbc) from [<801c7874>] (LOCAL_CAPI_PUT_MESSAGE+0x3c/0x50)
<4> r5:857657e0 r4:7ee002b8
<4>[<801c7838>] (LOCAL_CAPI_PUT_MESSAGE+0x0/0x50) from [<801c9bcc>] (capi_oslib_write+0x220/0x29c)
<4>[<801c99ac>] (capi_oslib_write+0x0/0x29c) from [<800a83a4>] (vfs_write+0xb4/0x130)
<4> r8:00000023 r7:83c9ff78 r6:7ee002b8 r5:857697c0 r4:00000023
<4>r3:83c9ff78
<4>[<800a82f0>] (vfs_write+0x0/0x130) from [<800a8600>] (sys_write+0x40/0x74)
<4> r7:7ee002b8 r6:857697c0 r5:00000000 r4:00000000
<4>[<800a85c0>] (sys_write+0x0/0x74) from [<800238e0>] (ret_fast_syscall+0x0/0x2c)
<4> r8:80023a88 r7:00000004 r6:00000000 r5:00000023 r4:2aab24a0
<0>ar7wdt_hw_reboot: user context for telefon:
<4> sp: 7ee002b0 (start_stack 7ee05360)
<4> epc: 2ac4c824 seg= 63 of=0x0004b824 [libuClibc-0.9.32.1.so]
<4>Mem-info:
<4>Normal per-cpu:
<4>CPU 0: hi: 42, btch: 7 usd: 29
<4>Active_anon:5866 active_file:1815 inactive_anon:88
<4> inactive_file:4088 unevictable:1839 dirty:0 writeback:0 unstable:0
<4> free:8521 slab:5570 mapped:3598 pagetables:434 bounce:0
<4>Normal free:34084kB min:8192kB low:10240kB high:12288kB active_anon:23464kB inactive_anon:352kB active_file:7260kB inactive_file:16352kB unevictable:7356kB present:130048kB pages_scanned:0 all_unreclaimable? no
<4>lowmem_reserve[]: 0 0
<4>Normal: 159*4kB 117*8kB 36*16kB 14*32kB 14*64kB 5*128kB 3*256kB 1*512kB 2*1024kB 1*2048kB 6*4096kB = 34084kB
<4>8506 total pagecache pages
<4>0 pages in swap cache
<4>Swap cache stats: add 0, delete 0, find 0/0
<4>Free swap = 16376kB
<4>Total swap = 16376kB
<4>32768 pages of RAM
<4>10008 free pages
<4>1341 reserved pages
<4>5570 slab pages
<4>17147 pages shared
<4>0 pages swap cached
<0>
<0> pid score VMZ RSS Stack Data Code Lib Name
<0> 1 577 1212 352 84 88 460 568 {init}
<0> 1225 6 1208 284 88 80 460 568 {tail}
<0> 1257 310 1752 556 88 200 56 880 {pcd}
<0> 1263 3 740 224 88 68 4 568 {watchdog_rt}
<0> 1264 17 1696 624 88 160 20 880 {logger}
<0> 1286 11 2292 552 88 708 12 948 {gptimer}
<0> 1287 9 1800 476 88 224 16 932 {gim}
<0> 1329 8 1672 640 88 404 8 1100 {configd}
<0> 1356 20 3996 1080 88 1104 12 1868 {edocsis}
<0> 1363 14 2752 784 88 472 20 1332 {cm_status}
<0> 1413 101 3112 808 88 704 8 1684 {hal_event_mbox}
<0> 1414 102 3360 864 88 708 8 1684 {hal_cmd_mbox}
<0> 1416 9 1772 372 88 196 12 940 {docsis_bootdebu}
<0> 1448 114 5516 1444 88 1356 16 3032 {mlx}
<0> 1465 107 4268 992 88 1288 16 1956 {hal_tuner_mgr}
<0> 1533 112 5276 1444 88 1184 16 2980 {qos_dsx_sm}
<0> 1534 118 6400 1708 88 1816 128 3260 {dispatcher}
<0> 1535 111 5004 1340 88 1100 24 2812 {bpi_auth}
<0> 1567 120 6684 2132 88 1936 116 3408 {docsis_mac_driv}
<0> 1568 110 4784 1260 88 952 20 2764 {bpi_tek}
<0> 1569 23 4572 1132 88 832 12 2700 {bpi_sa_map}
<0> 1583 12 2384 732 88 500 16 1664 {avmipcd}
<0> 1586 105 3912 1120 88 1040 20 1844 {downstream_mana}
<0> 1587 105 3912 1128 88 1040 20 1844 {downstream_mana}
<0> 1588 105 3912 1120 88 1040 20 1844 {downstream_mana}
<0> 1589 105 3912 1264 88 1040 20 1844 {downstream_mana}
<0> 1591 14 2812 1084 88 624 60 1892 {l2tpv3d}
<0> 1596 107 4272 1216 88 1216 40 1980 {upstream_manage}
<0> 1597 107 4272 1216 88 1216 40 1980 {upstream_manage}
<0> 1598 107 4272 1236 88 1216 40 1980 {upstream_manage}
<0> 1599 107 4272 1236 88 1216 40 1980 {upstream_manage}
<0> 1602 28 16216 8476 88 5780 48 7964 {ctlmgr}
<0> 1607 13 2680 720 88 404 20 1324 {eventmgr_cm}
<0> 1608 120 6812 2068 88 2092 84 3400 {docsis_mac_mana}
<0> 1610 36 7080 3520 88 2588 16 3808 {upnpd}
<0> 1619 12 4004 2088 88 1112 340 1988 {multid}
<0> 1679 20 4012 1068 88 660 16 2524 {pacm_vendor_app}
<0> 1680 31 6140 1940 88 1432 140 3332 {pacm_snmp_agent}
<0> 1681 31 5980 1804 88 1496 240 3060 {pacm_security}
<0> 1682 20 4020 1088 88 628 24 2520 {pacm_event_mgr}
<0> 1683 21 4180 972 88 1192 12 1932 {pacm_doim}
<0> 1692 30 5892 1604 88 1500 60 3152 {pacm_mta_contro}
<0> 1699 13 2544 1056 88 572 24 1728 {pcpd}
<0> 1703 15 3020 1072 88 1080 12 1704 {upnpdevd}
<0> 1717 10 2096 1096 88 548 196 1180 {wland}
<0> 1865 26 5148 2440 88 1248 200 2792 {dsld}
<0> 1954 120 6692 2272 88 1740 256 3476 {snmp_agent_cm}
<0> 2069 18 3644 1044 88 668 80 2448 {pbd}
<0> 2159 23 4548 1956 88 780 164 2952 {avmike}
<0> 2212 27 5192 2128 88 2032 504 2060 {telefon}
<0> 2301 46 8892 6888 88 2472 136 5192 {voipd}
<0> 2372 6 1212 332 88 84 460 568 {inetd}
<0> 2382 8 1672 580 88 720 132 708 {chronyd}
<0> 2404 42 8148 2000 204 4844 188 2396 {aha}
<0> 2419 7 1528 484 88 332 12 1024 {boxnotifyd}
<0> 2439 4 780 136 88 96 8 572 {run_clock}
<0> 2453 6 1212 184 84 88 460 568 {init}
<0> 2482 15 3064 1264 88 688 36 1980 {usermand}
<0> 2485 15 2996 1340 88 592 36 2016 {contfiltd}
<0> 2607 6 1248 576 88 120 332 692 {hostapd}
<0>
<0>tasks without mm 27 childs 16
<4>system-load 100 % loadavg 20.97 12.1 5.1 - 103 tasks:100 % curr:athHTCThread(6 %) max:gptimer(41 %, pid:1288), readytorun: 21, pgfault 0/s (max 0 avg 0.0)
<4>[<8029478c>] (dump_stack+0x0/0x14) from [<802948f0>] (panic+0x24/0x14c)
<4>[<802948cc>] (panic+0x0/0x14c) from [<8016eec8>] (panic_function+0xf8/0x128)
<4> r3:d8611000 r2:0000aaaa r1:00000000 r0:80317b4d
<4> r7:80392a88
<4>[<8016edd0>] (panic_function+0x0/0x128) from [<8005470c>] (run_timer_softirq+0x194/0x26c)
<4> r5:83ccc000 r4:80392280
<4>[<80054578>] (run_timer_softirq+0x0/0x26c) from [<8004f55c>] (__do_softirq+0x98/0x190)
<4>[<8004f4c4>] (__do_softirq+0x0/0x190) from [<8004f69c>] (do_softirq+0x48/0x54)
<4>[<8004f654>] (do_softirq+0x0/0x54) from [<8004f7ec>] (local_bh_enable+0x84/0xc0)
<4> r4:83ccc000 r3:00000008
<4>[<8004f768>] (local_bh_enable+0x0/0xc0) from [<80276314>] (packet_poll+0x80/0x88)
<4> r4:8565d800 r3:83ccc000
<4>[<80276294>] (packet_poll+0x0/0x88) from [<801cf160>] (sock_poll+0x20/0x24)
<4> r5:00000000 r4:00000008
<4>[<801cf140>] (sock_poll+0x0/0x24) from [<800b6afc>] (do_select+0x2ec/0x48c)
<4>[<800b6810>] (do_select+0x0/0x48c) from [<800b6fc8>] (core_sys_select+0x32c/0x348)
<4>[<800b6c9c>] (core_sys_select+0x0/0x348) from [<800b70c0>] (sys_select+0xdc/0x1ec)
<4>[<800b6fe4>] (sys_select+0x0/0x1ec) from [<800238e0>] (ret_fast_syscall+0x0/0x2c)
<0>Kernel panic - not syncing: ar7wdt_hw_reboot: delayed watchdog expired
<0>
-----
(first) sent on: Wed Feb 22 14:27:52 2017 UTC by support data
----------
END SECTION '/proc/avm/log_sd/panic'

==========
##### END SECTION PANICLOG

 

[PeterPawn]

Dank fehlender Formatierung ist das fast nicht zu lesen (und wohl auch schon mind. 5 Tage her, daß der letzte Absturz erfolgte), aber ich würde mal die Behauptung wagen, daß der "telefon"-Daemon nicht zum Zuge kommt, wenn es um die "Bedienung" eines zyklischen Watchdogs geht.

Das könnte nun z.B. an der Priorisierung der Prozesse durch AVM liegen - wobei hier eindeutig auch zuviel "Kontext" fehlt.

Zwar ist die CPU am Anschlag, wie man auch sehen kann, aber welcher Prozess da jetzt "der Schuldige" ist, kann man schlecht beurteilen.

Ich würde zunächst mal darauf tippen, daß die Box hier gnadenlos überfordert wird, weil auch der geschilderte Kopiervorgang noch über WLAN erfolgt (und da hat die Box eben zusätzlich an der Verschlüsselung zu knabbern) - jedenfalls ist bei den 100% Auslastung vor dem Crash dann irgendein Prozess mit "ath" mit bei der Musik, auch wenn der es nur auf 6% Utilization bringt.

Entweder man entlastet die Box ein wenig (z.B. indem man von einem per LAN-Kabel angeschlossenen Gerät kopiert oder auch mal das WLAN komplett abschaltet zum Testen) oder man drosselt eben die beiden Clients ein wenig - je nachdem, was man da zum Datentransfer verwendet. "rsync" hätte z.B. all die notwendigen Vorkehrungen "on-board", vom Beschränken der Kopieraktion auf die wirklich unterschiedlichen Blöcke bis zur Limitierung der Netzwerk-Benutzung durch das Kopieren und notfalls sogar direkt die SSH-Benutzung, was dann das AVM-VPN an dieser Stelle überflüssig werden läßt.

Das ist ja nun auch nicht die erste FRITZ!Box, die solche Neustarts bei Überlastung hinlegt ... einige werden sich vielleicht noch an die Probleme mit irgendeiner 7270 (bzw. dem SP W920V - oder so ähnlich) am VDSL50-Anschluß erinnern können, wo auch schon das (unverschlüsselte) Kopieren größerer Datenmengen mal so einen watchdog-basierten Neustart auslösen konnte, weil einfach die CPU zu schwach war, um das alles parallel zu stemmen.

 

[vaxinf]

Der Transfer erfolgt über ein LAN-Kabel (1GB/s bzw. 100MB/s für LAN1) und am WLAN hängt nur ein gelangweiltes Smartphone.

Eine Reduktion der Transferrate habe ich bereits versucht (winscp hat da Einstellmöglichkeiten), aber
egal wie weit ich die Transferrate runterdrehe, irgendwann gibts den crash.

Eberhard
PS: Wo finde ich die Formatierungsvorlagen des Forums?

 

[PeterPawn]

Ich habe keine Idee, warum bei unbenutztem WLAN dann irgendein Prozess mit "ath" im Namen 6% der Last verursacht, auch wenn der "gptimer" sich halt 41% gönnt. Letzterer ist m.W. ein Daemon, der einen genaueren Timer-Service (Auflösung wohl im Normalfall 50ms) für die anderen DOCSIS-Komponenten bereitstellt. Nun mag der zwar als "Verteiler" für die anderen Prozesse auch heftig zu tun haben, aber 41% (ziemlich am Ende des Protokolls) sind dann schon ganz schön hastig.

Ich hätte zwar nach den Daten im Protokoll darauf gewettet, daß da eine FRITZ!-irgendwas-App im WLAN unterwegs ist und weil der "telefon"-Daemon da auch involviert ist (bzw. sogar der Verursacher des protokollierten Absturzes ist), hätte ich auf eine FRITZ!App Fon auf einem WLAN-Gerät getippt ... aber offensichtlich liege ich da meilenweit daneben und damit kann ich dann auch nicht mehr mit irgendwelchen Ideen aushelfen und bin daher hier raus.

Wäre ich noch dabei, würde ich versuchen, den Fehler gezielt zu reproduzieren und dann die Umstände zu vergleichen ... allerdings auch wirklich nur dann, wenn man selbst nach einer möglichen Lösung (die kann ja auch nur ein Workaround sein, weil man das Problem kaum selbst beheben können wird) suchen will.

Nochmal: Das testweise Abschalten des WLANs wäre die billigste Variante für einen Test, ob es am WLAN und irgendeiner App auf dem Smartphone liegt, die ihrerseits irgendwie dazu beiträgt, daß da der "telefon"-Daemon sich zu einem Aufruf von "capi_oslib_write()" veranlaßt sieht, was man ja im Backtrace sehen kann. Es mag ja sein, daß das alles gar nichts damit zu tun hat und anstelle des "telefon"-Daemons dann auch ein beliebiger anderer Dienst den Absturz verursachen könnte - aber ohne gezielten Test wird man das wohl auch kaum sicher feststellen können.

 

[chilango79]

wie wäre es denn den Transfer mit ftp also unverschlüsselt zu probieren?
Deine arme Fritzbox muss erst für sftp verschlüsseln und dann ein zweites mal im VPN.

 

[vaxinf]

Soweit ist mich entsinne, hatte ich das Abschalten vom WLAN schon ausprobiert, aber das kann ich gerne noch einmal testen.

Die VPN-Verbindung über den Kabelanschluss ist übrigens nicht von dem Problem betroffen. Allerdings erreicht man über das Kabel
nicht die I/O-Raten wie über LAN1 (5 MBit/s vs. 100/1000 MBit/s). Vielleicht hat man den Puffer des VPN-Prozesses zu klein gewählt.

Eberhard

- - - Aktualisiert - - -

Hier meine neuesten Tests: mit WLAN aus, 100 Mbit/s statt 1GB/s Einstellung von LAN1 und Begrenzung auf 1024 KB/s im winscp bekommt zwar keinen Response von FB, aber der Transfer läuft durch. Damit kann ich, glaube ich, leben.

eberhard

 

[PeterPawn]

Ok, das kann man aus #1 zwar auch tatsächlich "erraten" (aus der Zeile "Hier Konfig: ..."), wenn man es dann auf anderem Weg "erfahren" hat ... aber da kann ich den AVM-Support dann sogar verstehen, wenn die hier einfach "abschalten".

Wer von einem Puma5-Prozessor (selbst von einem VR9) die klaglose Bedienung einer FastEthernet-Verbindung mit VPN-Daten erwartet und das noch bei vollem Durchsatz, der geht m.E. ohnehin von vollkommen falschen Annahmen aus. Hatte ich nicht etwas über Versuche mit gedrosselter Übertragung gelesen? Da meinte ich ja eine Drosselung noch unter das Niveau, das eine 6360 an einem Kabel-Anschluß (100/6 ist m.W. das, was die 6360 noch hinbekommt) erreichen würde.

Wobei es da vielleicht tatsächlich ein "Problem(chen)" in der Firmware für die 6360 gibt (wo man einiges an Ressourcen durch manuellen Eingriff dann wohl "einsparen" könnte), wenn die Box hier bereits im LAN1-Modus läuft.

Denn in der Liste oben sind die ganzen Prozesse für die Bedienung des DOCSIS-Interfaces aktiv ... wenn auch nur für 4/4-Kanäle. Mehr als die Hälfte der oben sichtbaren Prozesse beschäftigen sich mit dem DOCSIS-Interface und würden (vermutlich, ich habe keine 6360 mehr zum Test) bei der Umschaltung vom "production mode" in einen weniger umfangreichen Modus (durch Änderung der NvramDb und das Abschalten von "startup") gar nicht mehr benötigt. Wobei das FRITZ!OS m.W. niemals für den dauerhaften Betrieb in diesem Modus vorgesehen war und ggf. einige Abhängigkeiten dann doch wieder zu anderen Abstürzen führen könnten.

Auch wenn es mich schon irritiert, daß bei "LAN1-Modus" der DOCSIS-Teil nicht automatisch gestoppt wird ... aber dieser Modus ist ganz offensichtlich ja auch kein wirkliches "Einsatzziel" derartiger Geräte (keines der DOCSIS-Handbücher beschreibt den Einsatz als Router im LAN1-Modus, bei den DSL-Modellen hingegen ist das schon der Fall) und mehr ein Abfallprodukt, weil die DSL-Modelle auch einen solchen Modus bieten und der daher nicht wirklich "extra gebaut", sondern nur etwas angepaßt werden mußte. Da "stört" aber ein weiterhin aktives Modem (was m.W. aber auch abgeschaltet ist) deutlich weniger, weil bei den DSL-Modellen weniger von der Arbeit bei der Bedienung des Modem-Teils beim Prozessor verbleibt.

Welcher "Puffer" da für VPN zu klein gewählt sein soll, verstehe ich nicht ... das Ver- und Entschlüsseln des IPSec-Traffics läuft bei AVM auf der Kernel-Ebene (man kann sich ansehen, wo die Prozessor-Zeit "draufgeht", wenn viel VPN-Traffic zu verarbeiten ist) und die dürfte immer Vorrang vor irgendeinem Userland-Prozess haben (und der "telefon"-Daemon ist ein solcher). Wenn da also zuviel VPN-Traffic vorhanden ist, dann kommt der Prozessor gar nicht mehr aus dem "Kernel-Mode" heraus und so bleibt am Ende für die verschiedenen Userland-Prozesse einfach nicht mehr genug Zeit übrig und wenn dann einer von diesem Prozessen seine eigenen Watchdogs nicht mehr rechtzeitig zurücksetzen kann, dann schlägt eben einer von diesen "Wachhunden" an und am Ende auch zu.

- - - Aktualisiert - - -

EDIT: Ok, das mit der Begrenzung auf 1 MByte/s sind ja immer noch knapp 10 MBit/s (mit allem Overhead) im Durchsatz und da ist eine "unresponsive" FRITZ!Box (gerade die 6360) auch normal. Das hatte ich über zwei Jahre sogar schon, wenn ich bei einem 100/6-Anschluß von KDG Daten bei "Vollast" über das VPN an einen VDSL50-Anschluß senden ließ.
Ich hatte etwas länger gebraucht zum Schreiben (wurde zwischendrin abgelenkt) und habe den Nachtrag erst nach dem Senden gesehen.

 

[vaxinf]

Ich wäre echt froh, wenn ich den DOCSIS-Teil in der 6360 stilllegen könnte.

Eberhard

 

[PeterPawn]

Dann mach das doch bzw. versuche es wenigstens.

Das Kommando dazu wäre - wenn man es in Analogie zu anderen CEFDK-basierten Firmwares umsetzt - folgendes:

setstartup -d

Das muß man also nur auf der Box irgendwie ausführen lassen (es setzt auch nur "temporär" die Einstellung "disabled" für den DOCSIS-Autostart und ist mit dem nächsten Werksreset wieder Geschichte, weil das in der NvramDb von Intel abgelegt wird) und dafür muß man dann eben eine der bekannten Lücken verwenden. Welche davon nun genau bei der 06.52 der 6360 funktioniert oder nicht, muß man halt probieren.

 

[vaxinf]

Das kann ich versuchen. Die images von 6.52 habe ich ja aus- und woanders wieder eingelesen.
Danke für den Tipp.
eberhard

- - - Aktualisiert - - -

Hier meine neuesten Ergebnisse:

FB6360 auf FW 6.33 geswitched, um telnet-Zugang zu bekommen.

Befehl abgesetzt:
setstartup -d

Ergebnis:
Kabel deaktiviert.

Im Energiemonitor sieht man, dass DOCSIS viel Platz im Speicher verbraucht und dieser Memoryplatz nun verfügbar ist.

Beim Umschalten auf FW 6.52 per linux_fs_start Änderung bleibt das Kabel deaktivert.

Ein Werksreset kommt hoffentlich nicht so häufig vor,

Ich werde noch einmal testen, ob damit das ftp/sftp-VPN-Problem entschärft wird, wobei mir die
Erklärung einleuchtet, dass es ein Kernel-Problem ist, das sich durch zusätzlich freies Memory
nicht beseitigen lässt.

Eberhard

 

[chilango79]

Wie gesagt. Entweder VPN/FTP oder SFTP

 

[vaxinf]

Noch einmal:

Auch ftp über VPN crash die FB6360.

Das einzige, was hilft ist, sftp/ftp in der Datenrate zu begrenzen oder über eine Portfreigabe VPN für diese Fälle zu vermeiden.

Eberhard

Eberhard

 

[vaxinf]

Hier meine neuesten Erkenntnisse:

Das VPN-Problem ist bei der FB6490 mit FW 6.83 nicht vorhanden.
Interessanterweise, darf die entfernte Box eine 6360 sein, ohne dass der sftp-transfer über die VPN-Verbindung die FB crashed.

Eberhard

 

[Shirocco88]

Das VPN-Problem ist bei der FB6490 mit FW 6.83 nicht vorhanden.
Interessanterweise, darf die entfernte Box eine 6360 sein, ohne dass der sftp-transfer über die VPN-Verbindung die FB crashed.

welche VPN-Settings benutzt Du ? Compression=None, AH-Encryption-Mode=None

vpn.cfg:
(...)
mode = phase1_mode_aggressive;
phase1ss = "all/all/all";
(...)
phase2ss = "esp-aes256-3des-sha/ah-no/comp-no/pfs";
(...)

welche Download-/Upload-Raten haben die entsprechenden Kabelanschlusse

ohne diese Angaben ist der Beitrag nicht belastbar.