EPG und Swap über NFS

[Lack]

Nach langer DBox Abstinenz hab ich das Teil wieder reaktiviert, und kann mir nicht helfen, aber das macht irgendwie noch immer mehr Spaß als Dreambox - und alte Erinnerungen werden wach

Liebäugel daher schon mit Coolstream, speziell weil ihr da ja auch am Imagebasteln seid...

 

Aber zum Thema:

Hab nun EPG und Swap über NFS eingerichtet - beides läuft soweit (Daten werden geschrieben, Swap wird bei "Speicherauslastung" angezeigt), nur booten bzw runter fahren dauert tw extrem lang.

 

Paar Eckdaten:

Keywelt_V2_Juli_2x_SQUASHFS_2012

Nokia DBox2 Kabel Avia 500 2xI <=> Crossover (Halfduplex) <=> Windows Server 2008 R2

Netzwerk ist gut konfiguriert, komme auf Schreib- bzw Lesegeschwindikeiten von bis zu 8500 bzw 9000.

EPG-Einstellungen sind auf Standard. Swap ist 80MB.

 

EPG über NFS:

Beim Booten nur wenig Verzögerung.

Beim runter Fahren dauerts aber mehr als eine Minute.

An der Datenmenge liegts sicher nicht, denke daher es ist vlt die CPU überfordert, wenn sie über 100 XMLs schreiben muss.

 

Problematischer ist aber Swap:

Booten dauert über 5min, und dafür fehlt mir die Erklärung, speziell weil die Netzwerkaktivität während dieser Zeit bei Null ist.

Runter fahren geht soweit. Allerdings nur wenn nicht noch zusätzlich EPG über NFS aktiviert ist, dann stellt sich die Box nämlich auf, da hab ich letztens nach ca 15min Stecker gezogen.

 

Zusammenfassend:

Booten mit Swap dauer viel zu lange.

Runter fahren mit EPG + Swap geht gar nicht.

 

 

Frage wäre nun, ob andere ähnliche Erfahrungen gemacht haben, bzw ob man an der Config etwas drehen kann damit das runder läuft?

Hab jetzt beides wieder deaktiviert, weils auf Dauer einfach nicht praktikabel ist, immer so lang warten zu müssen.

bearbeitet 15. August 2012 von Lack

[SnowHead]

@Lack

 

Deine Erfahrungen sind normal. Swap über LAN ist nur temporär zu empfehlen, z.B. wenn man zusätzlichen

Platz braucht um SquashEdi zu nutzen. Für die Geschwindigkeit ist Swap generell kontraproduktiv und bringt

keinen Geschwindigkeitszuwachs sondern bremst aufgrund der hohen CPU-Last eher.

Die EPG-Speicherung ist beim Runterfahren eine echte Bremse. Je nach eingestellter Speichertiefe der EPG-

Daten kommen da schnell mal 20-30 MB zusammen, da diese Daten umständlich in XML-Format codiert und

dann geschrieben werden. Das dauert fürchterlich lange. Beim Booten fällt das nicht gar so in's Gewicht, da

die Box nicht wartet, bis der sectionsd alle Files eingelesen hat, sondern einfach weiterbootet. Daher wird das

EPG unmittelbar nach dem Start auch noch nicht lückenlos angezeigt, sondern erst nach und nach gefüllt, so

wie die XML-Files Stück für Stück eingelesen und ausgewertet werden.

[Lunitec]

Kann ich nur bestätigen. Dasselbe Problem habe ich schon in einem anderen Topic geschildert (siehe Dbox2/Allgemein: "portmap: server localhost not responding, timed out"). Mit aktiviertem LAN Swapfile auf externer Festplatte (NFS-Freigabe) dauert das Booten 6-7 min ab "Lade Neutrino..." bis zum TV-Bild.

 

Laut Bootlog vergehen mehrere time-outs:

 

portmap: server localhost not responding, timed out

portmap: server localhost not responding, timed out

lockd_up: makesock failed, error=-5

portmap: server localhost not responding, timed out

Adding Swap: 81992k swap-space (priority -1)

 

dann wird erfolgreich die Swapdatei geschrieben (siehe letzte Zeile)

 

EPG hatte ich ebenfalls auf meiner NAS-Platte aktiviert. SnowHead, du hast recht, geschrieben wird tatsächlich erst beim Herunterfahren/Neustarten der Box. Je nach EPG-Menge zirka 1-2 min länger. Ich konnte mir das auch nicht erklären, warum die Box ewig hing (Lautsprechersymbol durchgestrichen, trotzdem Ton; ewiges Shutdown Logo im TV und LCD) Nach Abschalten des EPG-Speicherverzeichnis gehts wieder flott.

 

Habe jetzt beides wieder deaktiviert der Geschwindigkeit wegen. Merkwürdig trotzdem, warum es solang dauert. Fehlerhaftes Startscript (init.d/start_swapfile) oder unvollständige Konfigurationsdatei (swapfile.conf) ?

bearbeitet 6. Oktober 2012 von Lunitec

[Lack]

EPG sind bei mir nur 1 bis 2 MB.

Dass die CPU der Box dann beim Shutdown für das Generieren der etwa 100 bis 300 XMLs trotzdem 1 bis 2 min braucht kommt mir mittlerweile schon recht plausibel vor.

 

6 - 7 min Booten mit Swapfile über LAN (kann ich bestätigen) und find ich allerdings nicht mehr plausibel.

Dafür sind dann offenbar die Errors und Timeouts aus deinem Bootlog verantwortlich. Hab mir das selber nicht angeschaut - vor meinem ersten Post.

 

Wenn ich mich aber nicht täusche dann ist die Auslastung des RAMs nach dem letzten Root-Update etwas geringer. War vorher ohne Swap und ohne zusätzliche Plugins (außer CCcam), nach einiger Zeit im Betrieb, immer über 90% (im Schitt würd ich sagen 95%). Und jetzt meist nur um die 85.

bearbeitet 19. Oktober 2012 von Lack

[merkwuerden]

Lasst die Finger von diesem LAN-Swap-Murks. Das bringt null Nutzen, weil es zudem extrem lahmarschig ist, da die CPU die ganze Arbeit mit der Speicherverschieberei übernehmen muss und das Netzwerk auch nicht mehr als 8 bis 9 MBit/s packt. LAN-Swap kann man maximal temporär mal aktivieren, falls man unbedingt den Squash-Edi brauchen sollte. Für den dauerhaften Betrieb ist LAN-Swap absolut unsinnig und bremst die Box nur sinnlos aus. Und nach meiner Erfahrung bekommt man damit auch nicht mehr physikalischen RAM frei. Und das gilt auch, wenn man das Swap-File auf eine SD oder interne HDD schreiben lässt. Zuerst wird der physikalische RAM vollgeschlichtet, bevor auf Swap ausgelagert wird.

 

Meine Box lief übrigens etliche Wochen lang dauerhaft, ohne dass ihr der RAM knapp wurde. Und falls es doch mal passierte (merkt man z.B., wenn der Teletext nicht mehr funktionieren will), wird EPG und RAM mit meinem EPG-RAM-Cleaner (irgendwo im Plugin-Bereich zu finden) einfach mal geputzt, und die Box hat danach wieder 10 MB frei, das reicht dann wieder für viele Tage. Vorausgesetzt, man hält nicht etliche tausend EPG-Events im Speicher.

[Lack]

War eigentlich nie geplant das dauerhaft zu nutzen.

Vom Standpunkt eines "Erfahrungsberichts" (der es sein sollte) muss man aber sagen, dass beim Hochfahren irgendwas nicht richtig läuft.

Fürs gelegntliche nutzen von Squash-Edi (falls mal nötig wird) kann man natürlich auch die 6min warten.

 

Und im übrigen schiebt die Box nur dann etwas über LAN ins Swap, wenns absolut nötig wird. Was bedeutet dass der LAN-Swap die Box im normalen Betrieb überhaupt nicht ausbremst - zumindest nach meiner Erfahrung nicht.

Aber selbst wenn man Files auf die Box lädt die nicht mehr in den RAM passen, konnte ich nicht feststellen dass es dadurch merkliche Verzögerungen gibt - liegt dann eben nur das für den Betrieb unnötige Zeug im Swap - wie es scheint - und im RAM lässt sie trotzdem noch Platz für häufig gebrauchtes.

Der Linuxkernel kann effektiv mit RAM und Swap umgehen, und alleine die Erweiterung des Adressbereichs auf externe Medien kostet normal noch kaum Resourcen - soweit ich weiß.

bearbeitet 20. Oktober 2012 von Lack

[Don de Deckelwech]

Hi,

@Lack und @Lunitec: ich kann da im Prinzip nix zu sagen, aber: ohne vollständige Logs geht garnix. Es scheint ja wohl nach ca. 6 Minuten ein Timeout zu greifen, bloss, welcher genau? Der vom NFS-Server (oder vom entspr Client der dBox), oder der "vom Swap" (Ok, wahrscheinlich Blödsinn )? Aber: ihr setzt es ein, dann macht doch ihr auch wenigstens ein Log, das kann ja (den Devs) nur helfen...

 

Ciao,

DdD.

[Lunitec]

Hallo DdD,

 

dieses Thema ist mit Bootlog-Auszügen und swapfile.conf Inhalt schon in einem anderem Topic behandelt worden,

siehe Thema "portmap: server localhost not responding, timed out" unter Keywelt Board → Dbox2 → Allgemein

 

Kann man die beiden Topics nicht zusammenfassen?

 

Habe mich damals zeitgleich beim Booten der Box mit PuTTY Konsole eingeloggt und das Bootgeschehen verfolgt (dmesg nach und nach aufgerufen).

Der erste Hänger kam wie gesagt nach "Starte Neutrino..."

Etwa 2 min später erschien im Bootlog portmap: server localhost not responding, timed out

Nach weiteren 2 min die gleiche Meldung portmap: server localhost not responding, timed out und lockd_up: makesock failed, error=-5

Nach weiteren 2 min endlich portmap: server localhost not responding, timed out und Adding Swap: 81992k swap-space (priority -1)

 

Alles weitere dann normal, Bild- und Tonaufbau folgt, alles flüssig. Die lange Bootzeit ist nicht normal. Linux sollte eigentlich keine Probleme machen mit Anlegen einer Swap-Datei. Die Ursachen liegen da an anderer Stelle?

 

Da ich ebenso wie LACK nicht vorhabe, diese Funktion dauerhaft zu nutzen, wäre mir die Anwort rein interessehalber lieb.

[merkwuerden]

Ohne ein vollständiges und lückenloses serielles Bootlog ist eine brauchbare Ursachenforschung trotzdem nicht möglich. Umsonst hat DdD nicht darauf hingewiesen:

ohne vollständige Logs geht garnix

Aber das wird ja geflissentlich überlesen oder ignoriert.

 

Das Problem könnte daran liegen, dass das Swap-File angelegt werden soll, wenn das Filesystem bzw. Netzwerk noch gar nicht bereit dazu ist, sprich noch nicht initialisiert wurde. Das lässt sich aber aus den paar hier aus dem Zusammenhang raus gelösten her geschmissenen Brocken nicht erkennen. Dann hilft halt nur der Hellseher. Meine Glaskugel ist jedenfalls kaputt, und das wird anderen Leuten wohl auch so gehen. Also ohne Log keine Hilfe.

[Lunitec]

Ok, dann also mal das komplette LOG vom COM-Terminal. Hab 3x das Booten mitgeloggt, falls es interessiert:

 

1.) Booten ohne swap

2.) Erster Neustart mit Neuanlegen dbox_swapfile im LAN

3.) Nächster Bootlauf (und weitere) mit vorhandenem dbox_swapfile

 

Weils alles soviel werden würden, hier nur das Bootlog aus 3.)

 

PES, queue 0 normal.

[pmt] set update filter, sid 0x2ee3 pid 0x2c version 1

debug: DDF: Calibrating delay loop... debug: DDF: 67.79 BogoMIPS

debug: BMon V1.0b.84.02.07.00.00-30

debug: HWrev X5 SWrev 0.81

debug: B/Ex/Fl(MB) 32/00/08

WATCHDOG reset enabled

dbox2:root> debug:

BOOTP/TFTP bootstrap loader (v0.3)

debug:

debug: Transmitting BOOTP request via broadcast

debug: Given up

 

Found Flash-FS superblock version 3.1

Found file /root/platform/nokia-dbox2/kernel/os in Flash-FS

debug: Got Block #0036

 

will verify ELF image, start= 0x800000, size= 169856

verify sig: 262

Branching to 0x4012 - 22:56:52)

 

CPU: PPC823ZTnnA at 67.200 MHz: 2 kB I-Cache 1 kB D-Cache

*** Warning: CPU Core has Silicon Bugs -- Check the Errata ***

Board: DBOX2, Nokia, BMon V1.0

Watchdog enabled

I2C: ready

DRAM: 32 MiB

Flash: 8 MiB

Scanning JFFS2 FS: ..... done.

env: found console with value ttye 15

FB: ready

In: serial

Out: serial

Err: serial

Net: SCC

LCD: ready

 

Options:

1: Console on null

2: Console on ttyS0

3: Console on framebuffer

Select option (1-3), other keys to stop au......................................

......................... done

Un-Protected 63 sectors

### FS (squashfs) loading 'vmlinuz' to 0x200000

### FS load complete: 661780 bytes loaded to 0x200000

## Booting kernel from Legacy I PowerPC Linux Kernel Image (gzip compressed)

Data Size: 661716 Bytes = 646.2 KiB

Load Address: 00000000

Entry Point: 00000000

Verifying Checksum ... OK

Uncompressing Kernel Image ... OK

Linux version 2.4.37.11-dbox2 (image@server) (gcc version 4.1.2) #1 Mi 12. Sep 2

2:42:46 CEST 2012

On node 0 totalpages: 8192

zone(0): 8192 pages.

zone(1): 0 pages.

zohfs console=ttyS0,9600 dbox_duplex=

Decrementer Frequency = 252000000/60

m8xx_wdt: active wdt found (SWTC: 0xFFFF, SWP: 0x1)

m8xx_wdt: keep-alive trigger installed (PITC: 0x12C0)

Console: colour dummy device 80x25

Calibrating delay loop... 66.96 BogoMIPS

Memory: 30848k available (1124k kernel code, 336k data, 60k init, 0k highmem)

Dentry cache hash table entries: 4096 (order: 3, 32768 bytes)

Inode cache hash table entries: 2048 (order: 2, 16384 bytes)

Mount cache hash table entries: 512 (order: 0, 4096 bytes)

Buffer cache hash table entries: 1024 (order: 0, 4096 bytes)

Page-cache hash table entries: 8192 (order: 3, 32768 bytes)

POSIX conformance testing by UNIFIX

Linux NET4.0 for Linux 2.4

Based upon Swansea Univers

devfs: v1.12c (20020818) Richard Gooch (rgooch@atnf.csiro.au)

devfs: boot_options: 0x1

JFFS2 version 2.2. (NAND) © 2001-2003 Red Hat, Inc.

squashfs: version 3.0 (2006/03/15) Phillip Lougher

i2c-core.o: i2c core module version 2.6.1 (20010830)

i2c-dev.o: i2c /dev entries driver module version 2.6.1 (20010830)

CPM UART driver version 0.04

ttyS0 at 0x0280 is on SMC1 using BRGttyS1 at 0x0380 is on SMC2 using BRG2

pty: 256 Unix98 SCC2, 00:50:9c:15:7c:4c

loop: loaded (max 8 devices)

D-Box 2 flash driver (size->0x800000 mem->0x10000000)

D-Box 2 flash memory: Found 2 x16 devices at 0x0 in 32-bit bank

Intel/Sharp Extended Query Table at 0x0035

cfi_cmdset_0001: Erase suspend on write enabled

Creating 6 MTD partitions on "D-Box 2 flash memory":

0x00000000-0x00020000 : "BR bootloader"

0x00020000-0x00040000 : "FLFS (U-Boot)"

0x00040000-0x005e0000 : "root (squashfs+lzma)"

0x005e0000-0x00800000 : 00-0x00800000 : "Complete Flash"

Linux video capture interface: v1.00

mice: PS/2 mouse device common for all mice

NET4: Linux TCP/IP 1.0 for NET4.0

IP Protocols: ICMP, UDP, TCP

IP: routing cache hash table of 512 buckets, 4Kbytes

TCP: Hash tables configured (established 2048 bind 4096)

NET4: Unix domain sockets 1.0/SMP for Linux NET4.0.

VFS: Mounted root (squashfs filesystem) readonly.

Mounted devfs on /dev

Freeing unused kernel memory: 60k init

init started: B5 (2012-09-12 23:37:41 CEST)

starting pid 8, tty '': '/etc/init.d/sysinit'

mount: using /etc/fstab

starting pid 22, tty '': '/etc/init.d/rcS'

 

Please press Enter to activate this console.

 

##### Image-Version: Keywelt_Jul2012_V2.10 #####

 

Sat Jan 1 00:00:00 UTC 2000

tuxbox: no IDE-IDetected STB:

Model: D-BOX2 (2 flash chips)

event: $Id: event.c,v 1.12 2003/09/30 05:45:38 obi Exp $

[i2c-8xx]: mpc 8xx i2c init

[i2c-8xx]: adapter: 0

lcd.o: init lcd driver module

lcd.o: found KS0713/SED153X lcd interface

$Id: cam.c,v 1.33 2011/06/19 11:49:27 rhabarber1848 Exp $

$Id: avia_napi.c,v 1.18 2003/11/24 09:53:01 obi Exp $

DVB: registering new adapter (C-Cube AViA GTX/eNX with AViA 500/600).

dvb_i2c_bridge: enabled DVB i2$Id: cam_napi.c,v 1.8 2003/09/30 05:45:34 obi Exp

$

avia_av: $Id: avia_av_core.c,v 1.106 2011/06/19 11:49:27 rhabarber1848 Exp $

avia_av_core: Starting avia_av_wdt thread.

avia_av: AVIA 500 LB4 found, sptsfix is off

avia_av_event: $Id: avia_av_event.c,v 1.11 2003/10/26 16:32:51 obi Exp $

avia_av_proc: $Id: avia_av_proc.c,v 1.15 2007/07/29 18:14:12 papst Exp $

avia_gt_core: $Id: avia_gt_core.c,v 1.48 2004/12/20 01:01:22 carjay Exp $

avia_gt_core: autodetecting chip type... GTX

avia_gt_gtx: $Id: avia_gt_gtx.c,v 1.24 2003/09/30 05:45:35 obi Exp $

avia_gt_accel: $Id: avia_gt_accel.c,v 1.19 2003/09/30 05:45:35 obi Exp $

avia_gt_dmx: $Id: avia_gt_dmx.c,v 1.216 2012/03/07 18:31:52 rhabarber1848 Exp $

avia_gt_core: masking unhandled irq reg 1 bit 11

avia_gt_core: masking unhandled irq reg 1 bit 13

avia_gt_ucode: loaded ucode v0014

avia_gt_ucode: ucode section filters disabled.

avia_gt_dmx: warning, misaligned queue 0 (is 0xFD200, size 65536), aligning...

avia_gt_core: mask8 16:44:56 carjay Exp $

avia_gt_gv: set_input_size (width=720, height=576)

avia_gt_pcm: $Id: avia_gt_pcm.c,v 1.29 2004/01/29 19:38:20 zwen Exp $

avia_gt_pcm_set_rate(44100)

avia_gt_capture: $Id: avia_gt_capture.c,v 1.32 2003/09/30 05:45:35 obi Exp $

avia_gt_pig: $Id: avia_gt_pig.c,v 1.40 2003/09/30 05:45:35 obi Exp $

avia_gt_vbi: $Id: avia_gt_vbi.c,v 1.26 2003/08/01 17:31:22 obi Exp $

avia_gt_core: Loaded AViA eNX/GTX driver

avia_gt_fb: $Id: avia_gt_fb_core.c,v 1.54 2004/03/17 18:42:18 zwen Exp $

avia_gt_gv: set_input_mode (mode=2)

avia_gt_gv: set_input_size (width=720, height=576)

avia_gt_gv: set_input_mode (mode=2)

avia_gt_gv: set_input_size (width=720, height=576)

avia_gt_gv: set_input_mode (mode=2)

avia_gt_gv: set_input_size (width=720, height=576)

Console: switching to colour frame buffer device 82x32

avia_gt_fb: fb0: AViA eNX/GTX Framebuffavia_gt_lirc: $Id: avia_gt_lirc.c,v 1.14

2003/09/30 05:45:35 obi Exp $

avia_gt_ir: $Id: avia_gt_ir.c,v 1.30 2003/09/30 05:45:35 obi Exp $

avia_oss: $Id: avia_gt_oss.c,v 1.28 2009/03/22 12:37:58 rhabarber1848 Exp $

avia_gt_pcm_set_rate(44100)

avia_gt_v4l2: $Id: avia_gt_v4l2.c,v 1.14 2011/06/19 11:49:27 rhabarber18wget: ca

n't connect to remote host (127.0.0.1): Connection refused

DVB: VES1820(0): pwm=0x48

DVB: registering frontend 0:0 (VES1820 based DVB-C frontend)...

avia_av_napi.c: $Id: avia_av_napi.c,v 1.33 2004/03/11 15:30:27 derget Exp $

avia_gt_napi: $Id: avia_gt_napi.c,v 1.208 2011/06/19 11:51:17 rhabarber1848 Exp

$

insmod: warning: kernel-module version mismatch

multicam was compiled for kernel version 2.4.37-dbox2

while this kernel is version 2.4.37.11-dbox2

DBox2 Multicam Driver v1.01 skars & doz21

starting /var/etc/init.d/S10rtc ...

starting /var/etc/init.d/S12squashedit ...

starting /var/etc/init.d/S15syslogd ...

starting /var/etc/init.d/S16kb2rcd ...

starting /var/etc/init.d/S16lircd ...

starting /var/etc/init.d/S30autofs ...

starting /var/etc/init.d/S30dropbear ...

starting /var/etc/init.d/S31nfstarting /var/etc/init.d/S31sambaserver ...

starting /var/etc/init.d/S39lanswap ...

Aktiviere Swapfile...

portmap: server localhost not responding, timed out

portmap: server localhost not responding, timed out

lockd_up: makesock failed, error=-5

portmap: server localhost not responding, timed out

Setting up swapspace version 1, size = 83963904 bytes

Adding Swap: 81992k swap-space (priority -1)

Swapfile aktiviert auf '/dev/loop/0' (NFS)

starting /var/etc/init.d/S40tuxcald ...

starting /var/etc/init.d/S40tuxmaild ...

starting /var/etc/init.d/S99gui ...

$Id: sectionsd.cpp,v 1.343 2012/06/30 10:54:17 rhabarber1848 Exp $

[sectionsd] FreeSat enabled

[sectionsd] Caching max 6000 events

[sectionsd] Caching 14 days

[sectionsd] Caching 12 hours Extended Text

[sectionsd] Events are old 60min after their end time

/var/tuxbox/config/zapit/epgfilter.xml: No such file or directory

/var/tuxbox/config/zapit/dvbtimefilter.xml: No such file or directory

/var/tuxbox/config/mybouquets.xml: No such file or directory

21:17:32.017 [timeThread] Time set via NTP, going to sleep for 1800 seconds.

[timerd] woke up from timer? false!

/var/plugins/oped_init

[timerd] using config file /var/tuxbox/config/timerd.conf

21:17:33.023 dmx/var/plugins/operations cardserver_start

$Id: zapit.cpp,v 1.463 2012/08/14 18:24:12 Markham & Worschter & SnowHead Exp $

[zapit] PMT update enabled

[zapit] Load ScanSetup Setting: 0 0.000000 0.000000 1 1 8

[frontend] uncommitted_switch_mode 0 auto_fec 0

avia_gt_core: masking unhandled irq reg 0 bit 7

/var/tuxbox/config/zapit/ubouquets.xml: No s21:17:37.120 eit_set_update_filter,

servicekey = 0x0, current version 0xff got events 0

/tmp/currentservices.xml: No such file or directory

[controld] Boxtype detected: ([controld]: ROUTEVIDEO v1 = 5 a1 = 1 v2 = 1 a2 = 1

v3 = 0 a3 = 1 fblk=1

/var/plugins/operations sect_renice

[CVideo::setVideoFormat] output format: 4:3(LB)

/var/plugins/operations camd_start

neutrino: /lib/libpng12.so.0: no version information available (required by neut

rino)

neutrino: /lib/libpng12.so.0: no version information availstarting /bin/nece cre

ated

812k video mem

avia_gt_gv: set_input_mode (mode=2)

avia_gt_gv: set_input_size (width=720, height=576)

[neutrino] enable flash

[neutrino] Software update enabled

starte capmtserv

capmtserver provides pmt info, for non-enigma platforms

 

starte CCcam

[lcdd] time-skin not found -> using default...

[lcdd] weekday-s using default...

[lcdd] date-skin not found -> using default...

[lcdd] month-skin not found -> using default...

[LCDFONT] initializing core...

[LCDFONT] adding font /share/fonts/12.pcf.gz...OK (Fix12/SemiCondensed)

[LCDFONT] adding font /share/fonts/14B.pcf.gz...OK (Fix14/Bold)

[LCDFONT] adding font /share/fonts/15B.pcf.gz...OK (Fix15/Bold)

[LCDFONT] Intializing font cache...

[LCDFONT] FTC_Face_Requester (Fix14/Bold)

[neutrino] SetupFonts filename: /share/fonts/micron.ttf fontname: Micron

[rcinput] no file /var/tuxbox/config/rc.conf was found

/dev/input/event1: No such file or directory[CFSMounter] Mount(0) 192.168.1.8:/m

nt/hda/mm/Filme -> /mnt/filme

[CFSMounter] Moumm/Musik -> /mnt/mp3

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Bilder -> /mnt/bilder

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Record -> /mnt/record

[network config] Instance created

[neutrino] menue setup

[neutrino] init menus...

[neutrino] GUI-Personalize instance created...

[neutrino] found esound, adding personalized esound entry to mainmenue

[neutrino] setRepeat: delay=25ent

[scan-setup] rec[CVideo::setVideoFormat] output format: 4:3(LB)

[LCDFONT] FTC_Face_Requester (Fix15/Bold)

PES, queue 0 normal.

[pmt] set update filter, sid 0x2ef4 pid 0x2e version 1

avia_gt_core: masking unhandled irq reg 1 bit 15

[neutrino] no file /var/tuxbox/config/init.end was found

[neutrino] initialized eve[LCDFONT] FTC_Face_Requester (Fix12/SemiCondensed)

[controld] VIDEO_EVENT_SIZE_CHANGED 720x576 (4:3 -> 16:9)

[CVideo::setVideoFormat] output format: 16:9

21:18:03.392 eit_set_update_filter, servicekey = 0x4410001/bin/nhttpd: /lib/libp

ng12.so.0: no version information available (required by /lib/liblcddisplay.so.0

)

[neutrino] timeset event. difference is 0 s, nothing to do...

21:18:04.[yhttpd] Webserver nhttpd/3.1.8 (yhttpd_core/1.2.0)

[LCDFONT] initializing core...

[LCDFONT] adding font /share/fonts/micron.ttf...OK (Micron/Regular)

[LCDFONT] adding font /share/fonts/micron_bold.ttf...OK (Micron/Bold)

[LCDFONT] adding font /share/fonts/pakenham.ttf...OK (Pakenham/Regular)

[LCDFONT] Intializing font cache...

[yhttpd] Webserver starting...

 

 

 

Ok, das war's. Hab nochmal die Stoppuhr mitlaufen lassen, ab da, wo es hängt:

 

. . .

[0:00 min] Aktiviere Swapfile...

[1:50 min] portmap: server portmap: server localhost not responding, timed out

[3:40 min] portmap: server localhost not responding, timed out

lockd_up: makesock failed, error=-5

[5:30 min] portmap: server localhost not responding, timed out

Adding Swap: 81992k swap-space (priority -1)

. . .

 

Also exakt immer timeouts von 110 sek.

 

Kann damit was angefangen werden?

[Lack]

Danke Lunitec für Logs.

Denke das Thema ist vlt eher etwas für Entwickler von CVS. Dass es schon mal angesprochen wurde, wusste ich nicht.

Trotzdem find ich es super was hier nach wie vor geleistet wird - damit können wir bei ZD nicht mithalten.

Und Coolstream kaufen rückt für mich immer näher - was Neutrino aus einer Box raus holt wird Dream eh niemals schaffen. Back to the roots!

[merkwuerden]

Ich weiß nicht, ob das unbedingt ein CVS-Problem ist. Ist in reinen CVS-Images eine Option LAN-Swap mit drin? Habe keines da zum nachsehen, da der Server tuxbox2.trale.de (wo immer aktuelle Images und YADDs aus dem CVS verfügbar waren) scheinbar nicht mehr existiert. Jedenfalls ist die Seite jedes mal nicht erreichbar, wenn ich dort nachsehe. Selber baue ich schon lange keine Images mehr.

 

Müsste sich vielleicht mal @Markham ansehen, ob da nicht vielleicht irgendwo in den Startscripten was ungünstig abläuft. Früher mit irgend einem älteren Image hat LAN-Swap zumindest das Booten nicht behindert, ich hatte das mal paar Tage lang getestet, bevor ich zu dem Beschluss kam, dass diese Geschichte nicht wirklich praxistauglich ist.

 

Wie oben schon geschrieben: falls man den Squash-Edi braucht, mal temporär nützlich, sonst für den praktischen Betrieb nicht recht brauchbar, weil die Box sowieso zuerst den RAM voll schlichtet und erst dann, wenn aus dem RAM wirklich nichts freiwillig mehr rauszuholen ist, dann auslagert. Und dafür ist LAN dann auch noch zu langsam, ich hatte die Box damals praktisch gezwungen auszulagern, weil ich den RAM mit einer 12 MB großen Dummydatei (in /tmp geschmissen) blockiert hatte. Das Ergebnis war extrem zähe Reaktion der Box in allen Bereichen, weil dann wirklich laufend auf Swap zugegriffen wurde. Kann man echt nicht brauchen. Also besser keine Gedanken drüber machen.

[Don de Deckelwech]

Hi,

@ merkwuerden: nimm http://dietmarw.polsum.net/ , hat sich in der Tat geändert...

 

Also ich hab mich heute mal etwas damit beschäftigt, ich vermute eine inkompatibilität vom Busybox-Mount-Kommando oder vom sunrpc.o-Kernelmodul. Zumindest haben meine Google-Suchen nur dahingehend Ergebnisse geliefert, dass entweder der Portmapper (=sunrpc) auf Clientseite (also dBox) nicht läuft, oder es irgendwas mit dem "nolock"-Parameter zu tun hat, welcher zwar im Keyweltimage verwendet wird, aber halt evtl vom Mount-Kommando der Busybox nicht (richtig) verarbeitet wird.

Frage: gibts iwo ein statisches mount-Bin als Ersatz für das in Busybox eingebaute?

 

Ciao,

DdD.

 

PS: nur um sicher zu gehen: der Fehler tritt nur auf, wenn der NFS-Mount verfügbar ist? Aber wenn er das nicht ist (zB durch Abziehen des NW-Kabels), dann gibts auch keine Probleme?

[merkwuerden]

@DdD

Danke für den Link. Hab schon fast Angst gehabt, dass man die Sache aufgegeben hat.

 

Mit dem "nolock"-Parameter sollte das doch eigentlich nichts zu tun haben? Zumal ja das normale Mounten (wenn die Box hochgefahren ist) funktioniert. Gegenteiliges wurde ja jedenfalls nicht geschrieben. Läge es an fehlerhafter Verarbeitung von Parametern, würden ziemlich sicher auch andere NFS-Mounts nicht klappen bzw. ewig brauchen, bis der Mount steht.

 

Mal bitte prüfen, ob andere NFS-Mounts sofort da sind oder auch erst nach längerem Warten und Time-Out.

[Lunitec]

Danke erstmal für das rege Interesse !

 

@DdD:

Hab mal gecheckt, wie es ohne LAN-Verbindung bootet (NW-Stecker gezogen). Siehe da, läuft nach kurzen Ruckler weiter. Das Bootlog bezeugt es (hier ein Auszug):

 

. . .

starting /var/etambaserver ...

starting /var/etc/init.d/S39lanswap ...

Aktiviere Swapfile...

mount: RPC: Unable to receive; errno = No route to host

mount: mounting 192.168.1.8:/mnt/hda/mm/Record on /mnt/swap failed: Bad file descriptor

Error: Mounten der Freigabe fehlgeschlagen !!!

starting /var/etc/init.d/S40tuxcald ...

starting /var/etc/init.d/S40tuxmaild ...

. . .

 

@merkwuerden:

Jo, andere NFS-Mounts werden sofort angelegt, keine Timeouts, keine Fehlermeldungen im Bootlog:

 

. . .

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Filme -> /mnt/filme

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Musik -> /mnt/mp3

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Bilder -> /mnt/bilder

[CFSMounter] Mount(0) 192.168.1.8:/mnt/hda/mm/Record -> /mnt/record

. . .

 

Hm, was nu? Jetzt sind Linuxer gefragt...

[Don de Deckelwech]

Hi,

das hat mich heute auch gewundert, weil, da ich keinerlei NFS-Freigabe (angelegt) habe, ist das auch einfach so wie du gerade beschrieben hast durchgelaufen. Eher verwunderlich, dass es zu solchen Timeouts kommt, wenn etwas verfügbar ist, man sollte eher meinen, dass es dazu kommt, wenn etwas nicht verfügbar ist...

 

Wie gesagt, laut Google-Recherche scheint es iwie mit sunrpc oder mit dem Mount-Befehl zu tun zu haben... wäre ja nicht das erste Mal, dass die Busybox-Implementationen subtile Fehler aufweisen, welche in den statischen Bins nicht drin sind...

 

Hast du mal ein älteres Image probiert? Ist es da anders?

 

Ciao,

DdD.

bearbeitet 1. November 2012 von Don de Deckelwech

[Lunitec]

Das mit dem älteren Image werde ich morgen mal probieren...

 

Meine Vermutung liegt vielleicht in einem Fehler im Startscript "S39lanswap" (KW init script for Lanswap) , welches ein weiteres Script "start_swapfile" aufruft.

Hier endet mein Latein, kann nicht sagen, ob da intern was falsch läuft. Vermutlich klappt der Start der Kernelmodule sunrpc und lockd nicht.

 

"start_swapfile" benötigt swapfile.conf. Hier der Inhalt aus meinem Beispiel:

 

###### LAN-Swapfile-Einstellungen #######

SERVER_TYP=NFS

SERVER_IP=192.168.1.8

FREIGABE=/mnt/hda/mm/Record

USER=root

PASSWORT=xxxx

MOUNTPUNKT=/mnt/swap

MOUNTOPTIONEN1=rw,soft,udp,async,nolock

MOUNTOPTIONEN2=rsize=32768,wsize=32768

SWAPFILE=/mnt/swap/dbox_swapfile

 

Diese Übergabeparameter unterscheiden sich insofern von den anderen sofort funktionierenden NFS-Mounts (laut neutrino.conf):

 

network_nfs_mount_options1=rw,soft,udp

network_nfs_mount_options2=nolock,rsize=8192,wsize=8192

 

Wie man sieht, ist "nolock" ebenfalls enthalten und es funktioniert. Was zu denken gibt, ist die Puffergröße für Schreib/Leseoperationen. Ist diese in den LAN-Swapfileinstellungen nicht zu groß aufgeführt? Ich hab mal gelesen, Standard sei 4096, 8192 ist empfohlene Maximalgröße. Ich prüf' das mal noch in einem älteren Image...

bearbeitet 1. November 2012 von Lunitec

[Markham]

Ungetestet: mount-Standalone 426kb. Ich habs zum Testen mal angehängt.

mount.rar

[merkwuerden]

Der Inhalt der Datei sollte passen, Fehler sehe ich keine. Also muss das Mounten auch funktionieren. Tut es ja im Prinzip auch, aber eben erst nach den ominösen fünfeinhalb Minuten.

 

Da andere Mounts funktionieren, kann es eigentlich nicht an einem Fehler der Busybox oder im Portmapper liegen, denn dann müsste das Problem auch mit den anderen Mounts auftreten. Alles andere wäre unlogisch.

 

Was zu denken gibt, ist die Puffergröße für Schreib/Leseoperationen. Ist diese in den LAN-Swapfileinstellungen nicht zu groß aufgeführt? Ich hab mal gelesen, Standard sei 4096, 8192 ist empfohlene Maximalgröße.

Das ist Käse. Die Blockgröße (das ist nämlich kein Puffer, sondern die maximale Größe der zusammenhängend übertragenen Datenblocks) ist einzig und allein davon abhängig, was der NFS-Server zulässt. Maximum kann die dBox2 32768 mounten, Du kannst zwar höhere Werte eintragen, aber das ist dem Client der Box wurscht, er kann nicht mehr, Schaden würde es aber auch nicht anrichten. Lässt der NFS-Server weniger als 32768 zu, dann kriegt die Box das vom Server aufgezwungen und mountet entsprechend weniger. Du kannst also problemlos 32768 eintragen, macht der Server als Beispiel nur 8192 mit, dann wird auch nur 8192 gemountet.

 

Folgendes gilt als Richtlinie zur Blockgröße, vorausgesetzt der NFS-Server macht seine Arbeit richtig und das Netzwerk (auch die Netzwerkkarte im Server) funktioniert korrekt): Je höher die Blockgröße, um so höher der Schreib- bzw. Lesedurchsatz. Leider gibt es immer noch genug Schrott, sowohl hardware- als auch softwareseitig, so dass man zwar 32768 mounten kann, dabei aber alles zusammenbricht.

Ob Dein NFS-Server da mitspielt, kannst Du mit dem NFS-Geschwindigkeitstest aus dem Streaming-Bereich hier im Board testen.

 

Ganz wichtig: die Gegenstelle der dBox2 muss zwingend auf Half Duplex laufen, über Router oder Switch 100 Half (1000 gibt es nicht als Half), bei Direktverbindung 10 Half. Andernfalls verschluckt sich der Datentransfer in der Richtung Server -> Box, weil die Box nur Half Duplex beherrscht. Was dann über Router/Switch zu massiven Datenkollisionen bis hin zu komplettem Datenverlust bei größeren Blöcken führt, weil die meisten bezahlbaren Switches und Router einen Mischbetrieb zwischen Half und Full in Verbindung mit der dBox2 nicht vernünftig auf die Reihe bekommen, was aber an der dBox2 liegt, in "normalen" Netzwerken machen die Switches ihre Arbeit schon ordentlich, nur die dBox2 haut da quer mit ihrem kastrierten Netzwerkinterface. Oder Du baust die Box mit dem Full Duplex Mod um (in meinen Augen bringt das aber keine Pluspunkte), dazu benötigst Du dann allerdings zwingend einen managebaren Switch, wo Du den Port der dBox2 fest auf 10 Full Duplex einstellen kannst. Mit einem normalen Switch geht das nicht, da die NIC der Box generell Half Duplex meldet, auch wenn Du sie moddest. Ein normaler Switch wird sich damit immer auf Half Duplex einstellen, ist die Box auf Full Duplex gemodded, funktioniert dann gar nichts mehr im Netzwerk.

 

Sehr viel Information zum Thema Netzwerk findest Du im bereits genannten Streamingbereich hier im Board. Mache da mal den NFS-Geschwindigkeitstest, dann siehst Du, was blockgrößenmäßig in Verbindung mit Deinem NFS-Server funktioniert. Die Werte solltest Du dann auch beim Swapfile nutzen.

 

Kannst ja mal testweise beide Blockgrößen in der swapfile.conf auf 8192 oder 4096 reduzieren. Ich kann Dir aber sagen, dass das nicht der Knackpunkt sein wird, denn die Fehlermeldung

server localhost not responding

ist ein anderes Problem, und das liegt direkt auf der Box. Sie ist nämlich lokal schon nicht bereit (lokalhost ist die IP der lokalen box-internen Kommunikation 127.0.0.1). Und wenn der nicht reagiert, ist die lokale Kommunikation da irgendwie gestört.

 

Ich denke schon, dass da irgendwo in den Startscripten was ungünstig oder daneben läuft, sprich Swap zu zeitig angestoßen wird. Komisch ist nur, dass die Box weitermacht, wenn das Netzwerk abgetrennt ist. Könnte schon Richtung Portmapper liegen, denn der wird erst bemüht, wenn die Route zum Server gefunden wurde. Ist die schon nicht da, dann braucht's ja auch keine Portzuweisungen. Andererseits: wenn der Portmapper Unsinn machen sollte, warum funktionieren dann andere Mounts sofort und ohne Mecker?

Rätselhafte Geschichte, die keinen rechten Sinn ergibt...

[Markham]

mount: mounting 192.168.1.8:/mnt/hda/mm/Record on /mnt/swap failed: Bad file descriptor

 

Bitte start_swapfile tauschen und testen.

start_swapfile.rar

[Lunitec]

Danke an Markham, alles super!!!! Test erfolgreich! Dein Startscript ist jetzt fehlerbereinigt! Klasse Zuarbeit.

 

... und alles nur, weil ein "T" fehlte. Deshalb wurden die $MOUN(T)OPTIONEN nicht übernommen. Wenn man nur kurz 'drüberfliegt, sieht man es einfach nicht. Die Änderung muss unbedingt in's nächste Image.

 

Dann kann dieses Thema ja erfolgreich geschlossen werden.

[Don de Deckelwech]

Hi,

also schlagt mich tot, aber mir war das mit den MOUNTOPTIONEN auch aufgefallen, aber ich hatte verdammt nochmal in der /var/tuxbox/config/swapfile.conf nachgesehen, und da stand es genauso drin. Allerdings bin ich mir jetzt nicht mehr sicher, ob das nicht noch mit dem älteren Image so war, bevor ich das aktuelle Keywelt-Image geflasht hatte...

Kann es sein, dass dieser Typo irgendwann mal geändert wurde (also im KW-Neutrino bei der Erstellung der swapfile.conf), aber dann nicht in der start_swapfile??? Oder ich war gestern wirklich total Blind...

 

Aber, um es festzuhalten: dann lags wohl doch am dann fehlenden nolock-Parameter???

 

Ciao,

DdD.

bearbeitet 2. November 2012 von Don de Deckelwech

[Lunitec]

Aber, um es festzuhalten: dann lags wohl doch am dann fehlenden nolock-Parameter???

 

Es fehlten ALLE Übergabeparamter, u.a. auch die Option nolock. Dadurch wurde lockd gestartet (was ja nolock verhindern sollte), was im Zusammenhang mit

älteren NFS-Servern scheitern kann.

 

Zitat:.

nolock

Disable NFS locking. Do not start lockd. This has to be

used with some old NFS servers that don’t support locking.

usw. usf.

Ist aber irre, über was für Umwege man zur Fehlerursache kommt...

[merkwuerden]

In dem Fall dürfte dann tatsächlich das fehlende "nolock" der Übeltäter gewesen sein. Und das dann auch fehlende "soft" könnte ebenfalls quer gehauen haben. Mir erschließt sich dann allerdings nicht, warum dann der Portmapper in Verbindung mit localhost ins Time-Out rennt.

 

Ich hatte früher mal bei diversen Tests mit Windows-NFS-Servern und auch eine Asus WLAN HDD eine ähnliche Erscheinung, dass NFS-Freigaben nach Eingabe des Mountbefehls (manuell über telnet) erst nach 2 oder 3 Minuten wirklich gemountet wurden. Fehler bezüglich irgendwelcher Time-Outs gab es damals im Log allerdings nicht, die Box hat da einfach ohne Rückmeldung im Hintergrund rumgemehrt. Irgendwann stand der Mount dann, und der Consolen-Prompt war wieder da, die Box also fertig. Weiß jetzt allerdings nicht mehr, ob es am fehlenden "nolock" oder am fehlenden "soft" lag, das ist schon über 5 Jahre her. Einer der beiden Parameter war es aber.

 

Naja, ist dann auch wurscht, wenn es jetzt funktioniert. Drauf kommen muss man erst mal.

[Don de Deckelwech]

Hi,

also schlagt mich tot, aber mir war das mit den MOUNTOPTIONEN auch aufgefallen, aber ich hatte verdammt nochmal in der /var/tuxbox/config/swapfile.conf nachgesehen, und da stand es genauso drin. Allerdings bin ich mir jetzt nicht mehr sicher, ob das nicht noch mit dem älteren Image so war, bevor ich das aktuelle Keywelt-Image geflasht hatte...

Kann es sein, dass dieser Typo irgendwann mal geändert wurde (also im KW-Neutrino bei der Erstellung der swapfile.conf), aber dann nicht in der start_swapfile??? Oder ich war gestern wirklich total Blind...

Da es mir keine Ruhe gelassen hat, hab ich das eben nochmal nachvollzogen.

Es war so, dass ich eine Testbox genommen hatte, auf welchem ein 2009er-Keywelt-Image drauf war. Nach einigen rumprobieren, hatte ich dann das aktuelle geflasht, um es dort nachvollziehen zu können.

 

Heute habe ich dann erneut ein 2009er geflasht, und dort ist tatsächlich der Typo mit dem T drin, allerdings sowohl in der swapfile.conf, als auch in der start_swapfile, so dass sich das in Summe nicht ausgewirkt hat!

 

Der Typo muss also in einem späteren Image in Neutrino (Keywelt-Settings->swapfile.conf-Erstellung) gefixt worden sein, dabei aber der gleiche Typo in der start_swapfile leider nicht. Deshalb hat das also in früheren Image alles geklappt, nur in den neueren iwann nicht mehr.

 

Nungut, das ist ja jetzt mit vereinten Kräften erledigt und das Kw-Image ein wenig besser geworden. Und vor allem: ich bin nicht blind!

 

Ciao,

DdD.