ernsthaftes syslog problem unter Lenny

ccc · Beitrag von **ccc** » 25.06.2009 17:23:28

hallo

Ich habe auf meinem Lenny (upgrade von Etch) sysklogd installiert und benutze als remote login server
für die firewall und spam appliance.

Sobald ich sysklogd mit der option:

Code: Alles auswählen

SYSLOGD="-r"

in /etc/default/syslogd aktiviere, dann häng der ganze server extrem beim austarten.

Mein /etc/syslog.conf:

Code: Alles auswählen

auth,authpriv.*			/var/log/auth.log
*.*;auth,authpriv.none		-/var/log/syslog
#cron.*				/var/log/cron.log
daemon.*			-/var/log/daemon.log
kern.*				-/var/log/kern.log
lpr.*				-/var/log/lpr.log
mail.*				-/var/log/mail.log
user.*				-/var/log/user.log

#
# Logging for the mail system.  Split it up so that
# it is easy to write scripts to parse these files.
#
mail.info			-/var/log/mail.info
mail.warn			-/var/log/mail.warn
mail.err			/var/log/mail.err

# Logging for INN news system
#
news.crit			/var/log/news/news.crit
news.err			/var/log/news/news.err
news.notice			-/var/log/news/news.notice

#
# Some `catch-all' logfiles.
#
*.=debug;\
	auth,authpriv.none;\
	news.none;mail.none	-/var/log/debug
*.=info;*.=notice;*.=warn;\
	auth,authpriv.none;\
	cron,daemon.none;\
	mail,news.none		-/var/log/messages

#
# Emergencies are sent to everybody logged in.
#
*.emerg				*

#
# I like to have messages displayed on the console, but only on a virtual
# console I usually leave idle.
#
#daemon,mail.*;\
#	news.=crit;news.=err;news.=notice;\
#	*.=debug;*.=info;\
#	*.=notice;*.=warn	/dev/tty8

# The named pipe /dev/xconsole is for the `xconsole' utility.  To use it,
# you must invoke `xconsole' with the `-file' option:
# 
#    $ xconsole -file /dev/xconsole [...]
#
# NOTE: adjust the list below, or you'll go crazy if you have a reasonably
#      busy site..
#
daemon.*;mail.*;\
	news.err;\
	*.=debug;*.=info;\
	*.=notice;*.=warn	|/dev/xconsole

local0.*                /var/log/firewall/messages.log
local7.*                /var/log/spamappliance/messages.log

Wenn ich einstelle:

Code: Alles auswählen

SYSLOGD=""

in /etc/default/syslogd, dann die ganze maschine startet sehr scnell, ohne Probleme.
Wie kann ich dieses problem beheben?

rendegast · Beitrag von **rendegast** » 25.06.2009 19:00:34

'man syslogd' hat geschrieben: If the remote hostname cannot be resolved at startup, because the name-
server might not be accessible (it may be started after syslogd) you
don't have to worry. Syslogd will retry to resolve the name ten times
and then complain. Another possibility to avoid this is to place the
hostname in /etc/hosts.

Steht zwar unter forwarding, aber auch andere Startverzögerungen haben oft mit DNS zu tun.

ccc · Beitrag von **ccc** » 25.06.2009 20:29:19

yep, aber diesmal scheint syslogd ein problem zu verursachen.
Irgendwelche Lösung Vorschläge?

nepos · Beitrag von **nepos** » 25.06.2009 21:30:00

Manuell beenden und dann halt mal so, wie er vom Startup-Skript gestartet wird manuell starten und dabei strace mitlaufen lassen. Dann siehst du, was der syslog da so treibt.

ccc · Beitrag von **ccc** » 25.06.2009 21:48:24

nepos hat geschrieben:Manuell beenden und dann halt mal so, wie er vom Startup-Skript gestartet wird manuell starten und dabei strace mitlaufen lassen. Dann siehst du, was der syslog da so treibt.

danke, aber wie starte ich strace?

nepos · Beitrag von **nepos** » 26.06.2009 08:23:17

Code: Alles auswählen

strace /usr/sbin/syslogd

Alles weitere steht in der Manpage zu strace... wie immer eigentlich.

ccc · Beitrag von **ccc** » 26.06.2009 11:30:11

nepos hat geschrieben:
Code: Alles auswählen
strace /usr/sbin/syslogd

sieht jemand da was faules?

Code: Alles auswählen

# strace /sbin/syslogd
execve("/sbin/syslogd", ["/sbin/syslogd"], [/* 15 vars */]) = 0
brk(0)                                  = 0x9ab9000
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7                                              fdc000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY)      = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=54326, ...}) = 0
mmap2(NULL, 54326, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7fce000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i686/cmov/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260e\1\0004\0\0\0\4"...                                              , 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1413540, ...}) = 0
mmap2(NULL, 1418864, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb                                              7e73000
mmap2(0xb7fc8000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRI                                              TE, 3, 0x155) = 0xb7fc8000
mmap2(0xb7fcb000, 9840, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOU                                              S, -1, 0) = 0xb7fcb000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7                                              e72000
set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e726b0, limit:1048575, seg_                                              32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, usea                                              ble:1}) = 0
mprotect(0xb7fc8000, 4096, PROT_READ)   = 0
munmap(0xb7fce000, 54326)               = 0
getpid()                                = 2793
chdir("/")                              = 0
brk(0)                                  = 0x9ab9000
brk(0x9ada000)                          = 0x9ada000
open("/var/run/syslogd.pid", O_RDONLY|O_LARGEFILE) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=5, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7                                              fdb000
read(3, "1961\n"..., 4096)              = 5
close(3)                                = 0
munmap(0xb7fdb000, 4096)                = 0
kill(1961, SIG_0)                       = 0
write(2, "syslogd: Already running.\n"..., 26syslogd: Already running.
) = 26
exit_group(1)                           = ?
ns2:~# strace /sbin/syslogd
execve("/sbin/syslogd", ["/sbin/syslogd"], [/* 15 vars */]) = 0
brk(0)                                  = 0x950b000
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f22000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY)      = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=54326, ...}) = 0
mmap2(NULL, 54326, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f14000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i686/cmov/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260e\1\0004\0\0\0\4"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1413540, ...}) = 0
mmap2(NULL, 1418864, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7db9000
mmap2(0xb7f0e000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x155) = 0xb7f0e000
mmap2(0xb7f11000, 9840, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f11000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7db8000
set_thread_area({entry_number:-1 -> 6, base_addr:0xb7db86b0, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
mprotect(0xb7f0e000, 4096, PROT_READ)   = 0
munmap(0xb7f14000, 54326)               = 0
getpid()                                = 2820
chdir("/")                              = 0
brk(0)                                  = 0x950b000
brk(0x952c000)                          = 0x952c000
open("/var/run/syslogd.pid", O_RDONLY|O_LARGEFILE) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=5, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f21000
read(3, "1961\n"..., 4096)              = 5

rendegast · Beitrag von **rendegast** » 26.06.2009 12:09:20

Neeh, so bringt das nichts.

Code: Alles auswählen

strace -o /dev/shm/LOG.strace -f -tt /etc/init.d/sysklogd start

sonst verwendet syslog zBsp nicht die Option "-r".
Da Du sagst "er hängt", braucht es noch die Angaben der Zeiten im strace '-tt'.
Um nicht allzuviel Verluste beim Schreiben zu bekommen, habe ich hier "/dev/shm" eingesetzt.
".strace", weil zBsp vim dafür ein syntax-Highlighting bereitstellt (was bei mir nicht funktioniert?)

Hinweise vielleicht auch mit

Code: Alles auswählen

strace -f -c /etc/init.d/sysklogd start

strace -o /dev/shm/LOG.strace -f -r /etc/init.d/sysklogd start
# und da nach den "Großverbrauchern" suchen

ccc · Beitrag von **ccc** » 14.07.2009 17:32:36

rendegast hat geschrieben:Neeh, so bringt das nichts.
Code: Alles auswählen
strace -o /dev/shm/LOG.strace -f -tt /etc/init.d/sysklogd start
sonst verwendet syslog zBsp nicht die Option "-r".
Da Du sagst "er hängt", braucht es noch die Angaben der Zeiten im strace '-tt'.
Um nicht allzuviel Verluste beim Schreiben zu bekommen, habe ich hier "/dev/shm" eingesetzt.
".strace", weil zBsp vim dafür ein syntax-Highlighting bereitstellt (was bei mir nicht funktioniert?)

Hinweise vielleicht auch mit
Code: Alles auswählen
strace -f -c /etc/init.d/sysklogd start

strace -o /dev/shm/LOG.strace -f -r /etc/init.d/sysklogd start
# und da nach den "Großverbrauchern" suchen

ich bekome folgendes:

Code: Alles auswählen

# /etc/init.d/sysklogd stop
# strace -o /dev/shm/LOG.strace -f -tt /etc/init.d/sysklogd start
Starting system log daemon....

# /etc/init.d/sysklogd stop
# strace -f -c /etc/init.d/sysklogd start
Starting system log daemon...Process 2929 attached
Process 2929 detached
Process 2930 attached
Process 2930 detached
Process 2931 attached
Process 2931 detached
Process 2932 attached
Process 2933 attached
Process 2928 suspended
Process 2928 resumed
Process 2932 detached
Process 2934 attached
Process 2934 detached
Process 2935 attached
Process 2935 detached
Process 2936 attached
Process 2936 detached
Process 2937 attached
Process 2937 detached
Process 2938 attached
Process 2938 detached
.
Process 2939 attached
Process 2939 detached
Process 2940 attached
Process 2940 detached
^CProcess 2933 detached
% time     seconds  usecs/call     calls    errors syscall
------ ----------- ----------- --------- --------- ----------------
 48.30    0.001239           9       142           fsync
 16.22    0.000416           0      1846      1021 close
  8.54    0.000219           0      1106           poll
  4.41    0.000113           0       336        11 stat64
  4.29    0.000110           0       255         9 open
  3.39    0.000087           0       553           gettimeofday
  2.69    0.000069           3        22        11 waitpid
  2.69    0.000069           0       564           socket
  2.46    0.000063           0       695           recvfrom
  1.91    0.000049           0       598        31 ioctl
  1.60    0.000041           0       511           writev
  1.52    0.000039           0       553           send
  1.09    0.000028           0       142           select
  0.90    0.000023           0       579           rt_sigprocmask
  0.00    0.000000           0       355           read
  0.00    0.000000           0         8           write
  0.00    0.000000           0         1         1 unlink
  0.00    0.000000           0        13           execve
  0.00    0.000000           0         2           chdir
  0.00    0.000000           0       144           time
  0.00    0.000000           0         1           chmod
  0.00    0.000000           0         2           getpid
  0.00    0.000000           0         1           alarm
  0.00    0.000000           0        75        66 access
  0.00    0.000000           0         1           kill
  0.00    0.000000           0         3           pipe
  0.00    0.000000           0        72           brk
  0.00    0.000000           0         1           umask
  0.00    0.000000           0         8           dup2
  0.00    0.000000           0         1           getppid
  0.00    0.000000           0         1           getpgrp
  0.00    0.000000           0         1           setsid
  0.00    0.000000           0         1           symlink
  0.00    0.000000           0       171           munmap
  0.00    0.000000           0        11           sigreturn
  0.00    0.000000           0        12           clone
  0.00    0.000000           0         4           uname
  0.00    0.000000           0        13           mprotect
  0.00    0.000000           0        10           _llseek
  0.00    0.000000           0         2           flock
  0.00    0.000000           0       126           rt_sigaction
  0.00    0.000000           0         5           getrlimit
  0.00    0.000000           0       303           mmap2
  0.00    0.000000           0       224           fstat64
  0.00    0.000000           0         6           getuid32
  0.00    0.000000           0         6           getgid32
  0.00    0.000000           0         5           geteuid32
  0.00    0.000000           0         5           getegid32
  0.00    0.000000           0      1124           fcntl64
  0.00    0.000000           0         3           futex
  0.00    0.000000           0        13           set_thread_area
  0.00    0.000000           0         1           set_tid_address
  0.00    0.000000           0         1           fchownat
  0.00    0.000000           0         1           fstatat64
  0.00    0.000000           0         1           unlinkat
  0.00    0.000000           0         1           fchmodat
  0.00    0.000000           0         1           set_robust_list
  0.00    0.000000           0         2           bind
  0.00    0.000000           0       562         9 connect
  0.00    0.000000           0         1           setsockopt
------ ----------- ----------- --------- --------- ----------------
100.00    0.002565                 11207      1159 total

rendegast hat geschrieben:sonst verwendet syslog zBsp nicht die Option "-r".

Wenn ich -r option nicht verwende, dann funktionieren die remote logins nicht.

nepos · Beitrag von **nepos** » 14.07.2009 22:35:25

Ich meinte eigentlich, mit strace den syslogd direkt anzusprechen:

Code: Alles auswählen

strace -o /tmp/syslogd.trace -tt /usr/sbin/syslogd -r ...

Sonst traced du den ganzen Shell-Skript-Kram drum rum ja auch nicht mit, was ja nicht sonderlich hilfreich ist

ccc · Beitrag von **ccc** » 15.07.2009 13:35:58

bekomme folgendes:

Code: Alles auswählen

# /etc/init.d/sysklogd stop
Stopping system log daemon....
# strace -o /tmp/syslogd.trace -tt /sbin/syslogd -r
#

# cat  /tmp/syslogd.trace
13:48:39.137700 execve("/sbin/syslogd", ["/sbin/syslogd", "-r"], [/* 15 vars */]) = 0
13:48:39.138255 brk(0)                  = 0x823a000
13:48:39.138352 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
13:48:39.138452 mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fe1000
13:48:39.138534 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory)
13:48:39.138608 open("/etc/ld.so.cache", O_RDONLY) = 3
13:48:39.138677 fstat64(3, {st_mode=S_IFREG|0644, st_size=54326, ...}) = 0
13:48:39.138774 mmap2(NULL, 54326, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7fd3000
13:48:39.138829 close(3)                = 0
13:48:39.138885 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
13:48:39.138966 open("/lib/i686/cmov/libc.so.6", O_RDONLY) = 3
13:48:39.139034 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260e\1\0004\0\0\0\4"..., 512) = 512
13:48:39.139122 fstat64(3, {st_mode=S_IFREG|0755, st_size=1413540, ...}) = 0
13:48:39.139206 mmap2(NULL, 1418864, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7e78000
13:48:39.139278 mmap2(0xb7fcd000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x155) = 0xb7fcd000
13:48:39.139356 mmap2(0xb7fd0000, 9840, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7fd0000
13:48:39.139428 close(3)                = 0
13:48:39.139505 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7e77000
13:48:39.139572 set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e776b0, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
13:48:39.139779 mprotect(0xb7fcd000, 4096, PROT_READ) = 0
13:48:39.139860 munmap(0xb7fd3000, 54326) = 0
13:48:39.139963 getpid()                = 3280
13:48:39.140019 chdir("/")              = 0
13:48:39.140216 brk(0)                  = 0x823a000
13:48:39.140266 brk(0x825b000)          = 0x825b000
13:48:39.140336 open("/var/run/syslogd.pid", O_RDONLY|O_LARGEFILE) = 3
13:48:39.140458 fstat64(3, {st_mode=S_IFREG|0644, st_size=5, ...}) = 0
13:48:39.140543 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fe0000
13:48:39.140602 read(3, "3267\n"..., 4096) = 5
13:48:39.140701 close(3)                = 0
13:48:39.140755 munmap(0xb7fe0000, 4096) = 0
13:48:39.140818 kill(3267, SIG_0)       = 0
13:48:39.140881 write(2, "syslogd: Already running.\n"..., 26) = 26
13:48:39.141120 exit_group(1)           = ?

rendegast · Beitrag von **rendegast** » 15.07.2009 16:09:25

13:48:39.140881 write(2, "syslogd: Already running.\n"..., 26) = 26

Erst den laufenden noch beenden

Braucht ein einfach mit '/usr/sbin/syslogd -r' gestarteter syslog denn auch soviel Zeit zum Starten?

ccc · Beitrag von **ccc** » 15.07.2009 18:39:12

Code: Alles auswählen

# /etc/init.d/sysklogd stop
# strace -o /tmp/syslogd.trace -tt /sbin/syslogd -r
# cat /tmp/syslogd.trace

18:27:19.686470 execve("/sbin/syslogd", ["/sbin/syslogd", "-r"], [/* 16 vars */]) = 0
18:27:19.687035 brk(0)                  = 0x8f76000
18:27:19.687132 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18:27:19.687234 mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f1e000
18:27:19.687312 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory)
18:27:19.687391 open("/etc/ld.so.cache", O_RDONLY) = 3
18:27:19.687459 fstat64(3, {st_mode=S_IFREG|0644, st_size=54326, ...}) = 0
18:27:19.687557 mmap2(NULL, 54326, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f10000
18:27:19.687612 close(3)                = 0
18:27:19.687671 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18:27:19.687752 open("/lib/i686/cmov/libc.so.6", O_RDONLY) = 3
18:27:19.687818 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260e\1\0004\0\0\0\4"..., 512) = 512
18:27:19.687906 fstat64(3, {st_mode=S_IFREG|0755, st_size=1413540, ...}) = 0
18:27:19.687991 mmap2(NULL, 1418864, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7db5000
18:27:19.688088 mmap2(0xb7f0a000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x155) = 0xb7f0a000
18:27:19.688170 mmap2(0xb7f0d000, 9840, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f0d000
18:27:19.688243 close(3)                = 0
18:27:19.688320 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7db4000
18:27:19.688386 set_thread_area({entry_number:-1 -> 6, base_addr:0xb7db46b0, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
18:27:19.688594 mprotect(0xb7f0a000, 4096, PROT_READ) = 0
18:27:19.688672 munmap(0xb7f10000, 54326) = 0
18:27:19.688774 getpid()                = 5101
18:27:19.688829 chdir("/")              = 0
18:27:19.688999 brk(0)                  = 0x8f76000
18:27:19.689050 brk(0x8f97000)          = 0x8f97000
18:27:19.689123 open("/var/run/syslogd.pid", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory)
18:27:19.689217 rt_sigaction(SIGTERM, {0x80498c0, [TERM], SA_RESTART}, {SIG_DFL}, 8) = 0
18:27:19.689307 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7db46f8) = 5102
18:27:19.692357 --- SIGTERM (Terminated) @ 0 (0) ---
18:27:19.692446 exit_group(0)           = ?

rendegast · Beitrag von **rendegast** » 15.07.2009 19:12:40

Das ist ja nur eine hundertstel Sekunde, also keine Verzögerung.
Fehlen vielleicht forkende Prozesse?

Code: Alles auswählen

strace -o /tmp/syslogd.trace -tt -f /sbin/syslogd -r

Oder verpack doch mal in ein Skript.sh (ausführbar):
(denn ein 'strace /etc/init.d/sysklogd start' kommt bei mir nicht zur Kommandozeile zurück,
ich brauche ein 'killall strace')

Code: Alles auswählen

#!/bin/sh
/etc/init.d/sysklogd start
echo MARKER
/etc/init.d/sysklogd stop

(das 'echo MARKER' zur Orientierung im Logfile)

Code: Alles auswählen

time ./Skript.sh
strace -o /tmp/Skript.strace -tt -f ./Skript.sh

ccc · Beitrag von **ccc** » 16.07.2009 19:15:39

Danke, habe gemacht wie oben beschrieben und bekomme folgendes:

Code: Alles auswählen

# cat Skript.sh
#!/bin/sh
/etc/init.d/sysklogd start
echo MARKER
/etc/init.d/sysklogd stop 

# time ./Skript.sh
-bash: ./Skript.sh: /bin/sh^M: bad interpreter: No such file or directory

real    0m0.002s
user    0m0.000s
sys     0m0.004s

# strace -o /tmp/Skript.strace -tt -f ./Skript.sh
strace: exec: No such file or directory

# cat Skript.strace
11351 19:11:56.994862 execve("./Skript.sh", ["./Skript.sh"], [/* 16 vars */]) = -1 ENOENT (No such file or directory)
11351 19:11:56.995842 dup(2)            = 3
11351 19:11:56.995925 fcntl64(3, F_GETFL) = 0x8002 (flags O_RDWR|O_LARGEFILE)
11351 19:11:56.996031 fstat64(3, {st_mode=S_IFCHR|0600, st_rdev=makedev(136, 0), ...}) = 0
11351 19:11:56.996140 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f09000
11351 19:11:56.996228 _llseek(3, 0, 0xbf8260dc, SEEK_CUR) = -1 ESPIPE (Illegal seek)
11351 19:11:56.996362 write(3, "strace: exec: No such file or dir"..., 40) = 40
11351 19:11:56.996597 close(3)          = 0
11351 19:11:56.996687 munmap(0xb7f09000, 4096) = 0
11351 19:11:56.996787 exit_group(1)     = ?

Ich verzweifle langsam mit diesem Problem.

rendegast · Beitrag von **rendegast** » 17.07.2009 00:46:13

# time ./Skript.sh
-bash: ./Skript.sh: /bin/sh^M: bad interpreter: No such file or directory

Ist die Quelle des Problems?
Stelle den Link her:

Code: Alles auswählen

cd /bin
ln -s bash sh

# strace -o /tmp/Skript.strace -tt -f ./Skript.sh

Wenn beim obigen 'time ./Skript.sh' schon keine Meldung über die Ausführung der Startskripte kommt,
dann ist auch ein 'strace' sinnlos.

ccc · Beitrag von **ccc** » 17.07.2009 02:10:52

Vielen herzlichen dank, aber inzwischen habe die Nerven verloren und sysklod sowie klogd vollständig deinstalliert.
Anschliessend habe rsyslog installiert und dieses Problem scheint jetzt behoben zu sein.

BTW beim Upgrade zu Lenny default syslog daemon wird nicht automatisch ersetzt und man braucht etwas Handarbeit:

Code: Alles auswählen

# apt-get remove --purge sysklogd klogd
# update-rc.d -f sysklogd remove 
# update-rc.d -f klogd remove
# apt-get install rsyslog

gruss
ccc

nepos · Beitrag von **nepos** » 17.07.2009 08:27:27

ccc hat geschrieben:Danke, habe gemacht wie oben beschrieben und bekomme folgendes:
Code: Alles auswählen
# cat Skript.sh
#!/bin/sh
/etc/init.d/sysklogd start
echo MARKER
/etc/init.d/sysklogd stop 

# time ./Skript.sh
-bash: ./Skript.sh: /bin/sh^M: bad interpreter: No such file or directory
Ich verzweifle langsam mit diesem Problem.

Wenn du schon ein Shell-Skript bastelst, dann doch bitte auch mit UNIX-Zeilenenden und nicht im Windows-Format. Unix hat nur \n, Windows \r\n! Dieses ^M entspricht \r und hat in einem Shellscript nix zu suchen.

debianforum.de

ernsthaftes syslog problem unter Lenny

ernsthaftes syslog problem unter Lenny

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem

Re: sysklogd problem