Twitter iPhone pliant OnePlus 11 PS5 Disney+ Orange Livebox Windows 11

Lenteur généralisée depuis changement matériel

25 réponses
Avatar
Bastien Durel
Bonjour,

Suite à un crash matériel, j'ai du changer la carte mère (et donc la
mémoire et le CPU) d'une de mes machines. Depuis lors, le système est
très fortement ralenti sans que j'arrive à en déduire la cause.
Rien que le boot est très lent à partir du moment où init prend la main
(plusieurs minutes sur le message "Init version 2.86 booting")
Certaines opération se font en temps normal, te d'autres non. si ls est
ralenti, je ne le vois pas, mais il me faut près d'une minute pour me
logger -- dont 50s d'attente *après* l'affichage de /etc/motd -- , un
logcheck prend plus de deux heures (60 fois plus long qu'avant avec un
CPU plus musclé), spamd fait souvent un timeout, et j'ai même vu udev
faire de même.
j'ai recompilé le noyau en spécifiant l'architecture du nouveau CPU
(C3->PENTIUM4) sans constater d'amélioration significative.
Avez-vous d'autres pistes ?

Merci,

--
Bastien

10 réponses

1 2 3
Avatar
Bastien Durel
Bastien Durel :

Certaines opération se font en temps normal, te d'autres non. si ls est
ralenti, je ne le vois pas, mais il me faut près d'une minute pour me
logger -- dont 50s d'attente *après* l'affichage de /etc/motd --


Est-ce que le disque tourne à ce moment là? Que donne

hdparm -tT /dev/ledisquedur

Pendant le login :

:~$ sudo hdparm -tT /dev/hda

/dev/hda:
Timing cached reads: 1296 MB in 2.00 seconds = 648.50 MB/sec
Timing buffered disk reads: 206 MB in 3.02 seconds = 68.25 MB/sec

Après le login :
:~$ sudo hdparm -tT /dev/hda

/dev/hda:
Timing cached reads: 960 MB in 2.00 seconds = 479.83 MB/sec
Timing buffered disk reads: 218 MB in 3.02 seconds = 72.30 MB/sec

? Est-ce que si, après, tu te logues dans une console à côté, ça rame autant?
Oui :/


Si oui, tu peux essayer dans la première console où tu es logué de lancer

strace -p piddugettylancedanslasecondeconsoleoutuvasteloguer

puis te loguer dans la console à côté, revenir dans la console où tu as
lancé le strace, et voir ce qu'il se passe pendant les moments de rame.
pas grand chose ; le temps que je retourne à ma console, getty est dans

un wait4().

avec un -f, il semble que bash passe beaucoup de temps à faire des
getdents64 (il reste plusieurs secondes sur chacun)
[pid 15862] getdents64(3, /* 73 entries */, 4096) = 2656

J'ai dumpé le processus ici :
http://www.geekwu.org/~bastien/strace.log


à toutes fins utiles :
:~$ sudo strace -cf -p 14474
Process 14474 attached - interrupt to quit
Process 14617 attached
Process 14474 suspended
Process 14618 attached
Process 14619 attached
Process 14618 suspended
Process 14618 resumed
Process 14619 detached
Process 14618 detached
Process 14620 attached
Process 14621 attached
Process 14620 suspended
Process 14620 resumed
Process 14621 detached
Process 14620 detached
Process 14622 attached
Process 14623 attached
Process 14622 suspended
Process 14622 resumed
Process 14623 detached
Process 14622 detached
Process 14627 attached
Process 14628 attached
Process 14627 suspended
Process 14627 resumed
Process 14628 detached
Process 14627 detached
Process 14632 attached
Process 14633 attached
Process 14632 suspended
Process 14632 resumed
Process 14633 detached
Process 14632 detached
<--- ici on est bloqué longtemps
Process 14798 attached
Process 14799 attached
Process 14798 suspended
Process 14798 resumed
Process 14799 detached
Process 14798 detached
Process 14800 attached
Process 14801 attached
Process 14800 suspended
Process 14800 resumed
Process 14801 detached
Process 14800 detached
Process 14802 attached
Process 14617 suspended
Process 14617 resumed
Process 14802 detached
Process 14803 attached
Process 14804 attached
Process 14617 suspended
Process 14617 resumed
Process 14803 detached
Process 14617 suspended
Process 14617 resumed
Process 14804 detached
Process 14805 attached
Process 14806 attached
Process 14617 suspended
Process 14617 resumed
Process 14805 detached
Process 14617 suspended
Process 14617 resumed
Process 14806 detached
Process 14807 attached
Process 14808 attached
Process 14617 suspended
Process 14617 resumed
Process 14807 detached
Process 14617 suspended
Process 14617 resumed
Process 14808 detached
Process 14809 attached
Process 14810 attached
Process 14617 suspended
Process 14617 resumed
Process 14809 detached
Process 14617 suspended
Process 14617 resumed
Process 14810 detached
Process 14811 attached
Process 14812 attached
Process 14617 suspended
Process 14617 resumed
Process 14811 detached
Process 14617 suspended
Process 14617 resumed
Process 14812 detached
Process 14813 attached
Process 14814 attached
Process 14617 suspended
Process 14617 resumed
Process 14813 detached
Process 14617 suspended
Process 14617 resumed
Process 14814 detached
Process 14815 attached
Process 14816 attached
Process 14617 suspended
Process 14617 resumed
Process 14815 detached
Process 14617 suspended
Process 14617 resumed
Process 14816 detached
Process 14817 attached
Process 14818 attached
Process 14617 suspended
Process 14617 resumed
Process 14817 detached
Process 14617 suspended
Process 14617 resumed
Process 14818 detached
Process 14819 attached
Process 14820 attached
Process 14819 suspended
Process 14819 resumed
Process 14820 detached
Process 14819 detached
Process 14859 attached
Process 14860 attached
Process 14859 suspended
Process 14859 resumed
Process 14860 detached
Process 14859 detached
Process 14869 attached
Process 14875 attached
Process 14869 suspended
Process 14869 resumed
Process 14875 detached
Process 14869 detached
Process 14876 attached
Process 14877 attached
Process 14876 suspended
Process 14876 resumed
Process 14877 detached
Process 14876 detached
<--- ici on est loggué
Process 14896 attached
Process 14617 suspended
Process 14617 resumed
Process 14896 detached
Process 14474 resumed
Process 14617 detached
Process 14474 detached
% time seconds usecs/call calls errors syscall
------ ----------- ----------- --------- --------- ----------------
57.19 0.192971 192971 1 wait4
37.24 0.125669 1745 72 32 waitpid
4.17 0.014072 454 31 execve
0.55 0.001852 43 43 write
0.33 0.001121 2 618 rt_sigprocmask
0.18 0.000595 15 41 clone
0.14 0.000484 1 391 read
0.04 0.000140 0 377 57 open
0.04 0.000122 0 519 mmap2
0.03 0.000092 7 14 13 connect
0.03 0.000090 0 476 33 close
0.01 0.000045 0 259 brk
0.01 0.000032 0 164 55 stat64
0.01 0.000031 0 135 munmap
0.01 0.000030 0 179 175 access
0.01 0.000028 1 31 mprotect
0.01 0.000026 0 101 10 ioctl
0.01 0.000022 1 38 dup2
0.01 0.000021 0 118 1 fcntl64
0.00 0.000000 0 1 chdir
0.00 0.000000 0 519 time
0.00 0.000000 0 1 chmod
0.00 0.000000 0 2 lseek
0.00 0.000000 0 10 getpid
0.00 0.000000 0 30 alarm
0.00 0.000000 0 1 kill
0.00 0.000000 0 1 dup
0.00 0.000000 0 20 pipe
0.00 0.000000 0 4 setpgid
0.00 0.000000 0 3 umask
0.00 0.000000 0 10 getppid
0.00 0.000000 0 9 getpgrp
0.00 0.000000 0 15 1 setrlimit
0.00 0.000000 0 1 getpriority
0.00 0.000000 0 1 setpriority
0.00 0.000000 0 32 sigreturn
0.00 0.000000 0 10 uname
0.00 0.000000 0 70 _llseek
0.00 0.000000 0 563 rt_sigaction
0.00 0.000000 0 24 getrlimit
0.00 0.000000 0 300 fstat64
0.00 0.000000 0 19 getuid32
0.00 0.000000 0 13 getgid32
0.00 0.000000 0 14 geteuid32
0.00 0.000000 0 13 getegid32
0.00 0.000000 0 12 getgroups32
0.00 0.000000 0 2 setgroups32
0.00 0.000000 0 1 chown32
0.00 0.000000 0 1 setuid32
0.00 0.000000 0 1 setgid32
0.00 0.000000 0 14 getdents64
0.00 0.000000 0 31 set_thread_area
0.00 0.000000 0 14 socket
0.00 0.000000 0 2 send
------ ----------- ----------- --------- --------- ----------------
100.00 0.337443 5372 377 total

Ça ressemble beaucoup à ce que fait une machine saine.

--
Bastien


Avatar
Bastien Durel
Bastien Durel :

(dont 12% rien que pour le top)


Wow... Tu as bien réglé la vitesse de ton processeur?
/proc/cpuinfo a l'air cohérent


:~$ cat /proc/cpuinfo
processor : 0
vendor_id : GenuineIntel
cpu family : 15
model : 4
model name : Intel(R) Celeron(R) CPU 2.80GHz
stepping : 9
cpu MHz : 2800.506
cache size : 256 KB
fdiv_bug : no
hlt_bug : no
f00f_bug : no
coma_bug : no
fpu : yes
fpu_exception : yes
cpuid level : 5
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic mtrr pge mca
cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe lm
constant_tsc pni monitor ds_cpl tm2 cid cx16 xtpr lahf_lm
bogomips : 5603.70
clflush size : 64

--
Bastien


Avatar
Bastien Durel
Bastien Durel :

(dont 12% rien que pour le top)


Wow... Tu as bien réglé la vitesse de ton processeur?
/proc/cpuinfo a l'air cohérent


:~$ cat /proc/cpuinfo
processor : 0
vendor_id : GenuineIntel
cpu family : 15
model : 4
model name : Intel(R) Celeron(R) CPU 2.80GHz
stepping : 9
cpu MHz : 2800.506
cache size : 256 KB
fdiv_bug : no
hlt_bug : no
f00f_bug : no
coma_bug : no
fpu : yes
fpu_exception : yes
cpuid level : 5
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic mtrr pge mca
cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe lm
constant_tsc pni monitor ds_cpl tm2 cid cx16 xtpr lahf_lm
bogomips : 5603.70
clflush size : 64

Mais bon, je *sais* aussi qu'il y a un problème.
Le load average qui est passé de 0.8 à 3 de moyenne est un autre
indicateur fort. La config n'a pas changé (sauf le kernel, et encore,
c'était pareil avec celui "optimisé" pour C3)

--
Bastien


Avatar
Bastien Durel
On Tue, 20 Nov 2007 23:07:54 +0100, Bastien Durel
:

Je n'ai pas de lecteur de CD


Il existe des "live-clé-USB".

Oui, mais je ne peux pas booter sur une clef usb avec cette carte mère.

Ou avec ma clef et cette carte mère.

Blague à part, si je gravais un live-CD et que je montais un lecteur
optique dans cette machine, je regarderais quoi ?


Pour commencer, si le problème vient du matériel ou de ton
installation de Linux.

Je suis en train de booter sur un sysrescuecd (récent, noyau 2.6.22), et

c'est très très lent. Les modules sont montés à la vitesse d'un
escargot, les services démarrent à la vitesse d'un escargot asmathique,
et la détéction matérielle à celle d'un escargot qui s'est cassé une
jambe ;)
Par contre, le login se fait sans souci

--
Bastien


Avatar
Luc.Habert.00__arjf
Bastien Durel :

/dev/hda:
Timing cached reads: 1296 MB in 2.00 seconds = 648.50 MB/sec
Timing buffered disk reads: 206 MB in 3.02 seconds = 68.25 MB/sec

Après le login :
:~$ sudo hdparm -tT /dev/hda

/dev/hda:
Timing cached reads: 960 MB in 2.00 seconds = 479.83 MB/sec
Timing buffered disk reads: 218 MB in 3.02 seconds = 72.30 MB/sec


Donc ce n'est pas un problème de disque qui rame.

avec un -f


Oui, j'ai oublié le -f, heureusement que tu y as pensé.

il semble que bash passe beaucoup de temps à faire des getdents64 (il
reste plusieurs secondes sur chacun) [pid 15862] getdents64(3, /* 73
entries */, 4096) = 2656


Il faudrait voir sur quel répertoire il fait ses readdir, par exemple avec

ls -l /proc/piddebash/fd

J'ai dumpé le processus ici :
http://www.geekwu.org/~bastien/strace.log


ERROR

The requested URL could not be retrieved

-------------------------------------------------------------------------------

While trying to retrieve the URL: http://www.geekwu.org/~bastien/strace.log

The following error was encountered:

* Unable to forward this request at this time.

This request could not be forwarded to the origin server or to any parent
caches. The most likely cause for this error is that:

* The cache administrator does not allow this cache to make direct
connections to origin servers, and
* All configured parent caches are currently unreachable.

Your cache administrator is webmaster.
-------------------------------------------------------------------------------

Generated Tue, 20 Nov 2007 23:48:11 GMT by kaitain.geekwu.org (squid/
2.6.STABLE5)

Avatar
Bastien Durel
Bastien Durel :

/dev/hda:
Timing cached reads: 1296 MB in 2.00 seconds = 648.50 MB/sec
Timing buffered disk reads: 206 MB in 3.02 seconds = 68.25 MB/sec

Après le login :
:~$ sudo hdparm -tT /dev/hda

/dev/hda:
Timing cached reads: 960 MB in 2.00 seconds = 479.83 MB/sec
Timing buffered disk reads: 218 MB in 3.02 seconds = 72.30 MB/sec


Donc ce n'est pas un problème de disque qui rame.

avec un -f


Oui, j'ai oublié le -f, heureusement que tu y as pensé.

il semble que bash passe beaucoup de temps à faire des getdents64 (il
reste plusieurs secondes sur chacun) [pid 15862] getdents64(3, /* 73
entries */, 4096) = 2656


Il faudrait voir sur quel répertoire il fait ses readdir, par exemple avec

ls -l /proc/piddebash/fd

Sur mon répertoire personnel (/home/bastien)


un "strace -tt ls /home/bastien" ne donne pas du tout le même genre de
résultat
01:32:47.640527 getdents64(3, /* 123 entries */, 4096) = 4096
01:32:47.647403 getdents64(3, /* 73 entries */, 4096) = 2656
01:32:47.651852 getdents64(3, /* 113 entries */, 4096) = 4072
01:32:47.660908 getdents64(3, /* 78 entries */, 4096) = 2624
01:32:47.665984 getdents64(3, /* 129 entries */, 4096) = 4072
01:32:47.673097 getdents64(3, /* 50 entries */, 4096) = 1592
01:32:47.677015 getdents64(3, /* 0 entries */, 4096) = 0


J'ai dumpé le processus ici :
http://www.geekwu.org/~bastien/strace.log


ERROR

The requested URL could not be retrieved
Oui, tu as du faire cette requête pendant le reboot (test avec un

livecd), apache est de nouveau up maintenant.

--
Bastien


Avatar
Fabien LE LEZ
On Wed, 21 Nov 2007 00:33:13 +0100, Bastien Durel
:

Oui, mais je ne peux pas booter sur une clef usb avec cette carte mère.


Je vois trois explications :
- ta carte mère date de 1995, et c'est normal que le système
aille lentement ;
- tu as désactivé le boot sur USB dans le BIOS, auquel cas tu
peux le réactiver ;
- le système a un gros problème matériel (ports USB en panne ?),
et faut pas chercher la cause de ton souci dans Linux.

Avatar
Bastien Durel
On Wed, 21 Nov 2007 00:33:13 +0100, Bastien Durel
:

Oui, mais je ne peux pas booter sur une clef usb avec cette carte mère.


Je vois trois explications :
- ta carte mère date de 1995, et c'est normal que le système
aille lentement ;
- tu as désactivé le boot sur USB dans le BIOS, auquel cas tu
peux le réactiver ;
- le système a un gros problème matériel (ports USB en panne ?),
et faut pas chercher la cause de ton souci dans Linux.

Le boot sur USB est prévu dans le BIOS, mais ma clef s'éteint pendant le

POST ... Seulement, elle est capricieuse, ma clef.

--
Bastien


Avatar
Fabien LE LEZ
On Wed, 21 Nov 2007 08:15:05 +0100, Bastien Durel :

mais ma clef s'éteint pendant le
POST ... Seulement, elle est capricieuse, ma clef.


Je ne connais pas ton budget, mais n'as-tu pas moyen d'investir une
dizaine d'euros dans une clé qui fonctionne ? Ça t'éviterait pas mal
de pertes de temps...

Avatar
Bastien Durel
On 21/11/2007 17:56, Fabien LE LEZ wrote:
On Wed, 21 Nov 2007 08:15:05 +0100, Bastien Durel :

mais ma clef s'éteint pendant le
POST ... Seulement, elle est capricieuse, ma clef.


Je ne connais pas ton budget, mais n'as-tu pas moyen d'investir une
dizaine d'euros dans une clé qui fonctionne ? Ça t'éviterait pas mal
de pertes de temps...

C'est surtout une question de flemme pour aller en quérir une.

Enfin, là, pour le coup, j'ai monté un lecteur de CD, et c'est toujours
lent. seulement, j'ai du mal à estimer la part du fs sur un liveCD dans
la lenteur du machin.

--
Bastien


1 2 3