Bug#314289: experiencing the same issue
I'm experiencing the same issue with this package. Here's an strace -f of
the sshd process, starting after I typed my password (password removed).
Process 5023 attached - interrupt to quit
read(6, "\0\0\0\21", 4) = 4
read(6, "4\0\0\0\1\0\0\0\10", 17) = 17
write(7, "\0\0\0\r\6", 5) = 5
write(7, "\0\0\0\10", 12) = 12
--- SIGCHLD (Child exited) @ 0 (0) ---
rt_sigaction(SIGCHLD, NULL, {0x8064a10, [], 0}, 8) = 0
rt_sigaction(SIGCHLD, {SIG_DFL}, NULL, 8) = 0
waitpid(5027, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG) = 5027
sigreturn() = ? (mask now [])
write(6, "\0\0\0\0055", 5) = 5
write(6, "\0\0\0\1", 4) = 4
read(6, "\0\0\0\1", 4) = 4
read(6, "2", 1) = 1
read(7, "\0\0\0\27", 4) = 4
read(7, "\0\0\0\0\2OK\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0", 23) = 23
write(6, "\0\0\0\0213", 5) = 5
write(6, "\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0", 16) = 16
read(6, "\0\0\0\5", 4) = 4
read(6, "4\0\0\0\0", 5) = 5
write(6, "\0\0\0\0055", 5) = 5
write(6, "\0\0\0\0", 4) = 4
read(6, "\0\0\0\1", 4) = 4
read(6, "6", 1) = 1
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
kill(5027, SIGTERM) = -1 ESRCH (No such process)
close(7) = 0
close(8) = 0
write(6, "\0\0\0\0017", 5) = 5
read(6, "\0\0\0\1", 4) = 4
read(6, ".", 1) = 1
write(6, "\0\0\0\t/", 5) = 5
write(6, "\0\0\0\1\0\0\0\0", 8) = 8
--- SIGCHLD (Child exited) @ 0 (0) ---
time([1120254395]) = 1120254395
getpid() = 5023
rt_sigaction(SIGPIPE, {0xb7de4a70, [], 0}, {SIG_IGN}, 8) = 0
send(4, "<38>Jul 1 14:46:35 sshd[5023]: "..., 111, 0) = 111
rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
close(4) = 0
read(6, "\0\0\4\207", 4) = 4
read(6, "\30\0\0\0\24_\231\34X#8@\200s6\26>\267\274\362M.|RX\0\0"..., 1159) = 1159
close(6) = 0
mmap2(NULL, 1310720, PROT_READ|PROT_WRITE, MAP_SHARED|MAP_ANONYMOUS, -1, 0) = 0xb7a34000
munmap(0xb7fd9000, 65536) = 0
waitpid(5024, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 5024
alarm(0) = 570
close(5) = 0
socketpair(PF_FILE, SOCK_STREAM, 0, [4, 5]) = 0
fcntl64(4, F_SETFD, FD_CLOEXEC) = 0
fcntl64(5, F_SETFD, FD_CLOEXEC) = 0
clone(Process 5029 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d0f648) = 5029
[pid 5023] close(4) = 0
[pid 5023] rt_sigaction(SIGHUP, NULL, {SIG_DFL}, 8) = 0
[pid 5023] rt_sigaction(SIGHUP, {0x805e2c0, [], 0}, NULL, 8) = 0
[pid 5023] rt_sigaction(SIGTERM, NULL, {SIG_DFL}, 8) = 0
[pid 5023] rt_sigaction(SIGTERM, {0x805e2c0, [], 0}, NULL, 8) = 0
[pid 5023] read(5, <unfinished ...>
[pid 5029] close(5) = 0
[pid 5029] getuid32() = 0
[pid 5029] setgid32(1000) = 0
[pid 5029] open("/etc/group", O_RDONLY) = 5
[pid 5029] fcntl64(5, F_GETFD) = 0
[pid 5029] fcntl64(5, F_SETFD, FD_CLOEXEC) = 0
[pid 5029] _llseek(5, 0, [0], SEEK_CUR) = 0
[pid 5029] fstat64(5, {st_mode=S_IFREG|0644, st_size=777, ...}) = 0
[pid 5029] mmap2(NULL, 777, PROT_READ, MAP_SHARED, 5, 0) = 0xb7fe8000
[pid 5029] _llseek(5, 777, [777], SEEK_SET) = 0
[pid 5029] fstat64(5, {st_mode=S_IFREG|0644, st_size=777, ...}) = 0
[pid 5029] munmap(0xb7fe8000, 777) = 0
[pid 5029] close(5) = 0
[pid 5029] setgroups32(9, [1000, 4, 6, 20, 24, 25, 29, 40, 44]) = 0
[pid 5029] getuid32() = 0
[pid 5029] getuid32() = 0
[pid 5029] ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffe954) = -1 ENOTTY (Inappropriate ioctl for device)
[pid 5029] time([1120254395]) = 1120254395
[pid 5029] getpid() = 5029
[pid 5029] rt_sigaction(SIGPIPE, {0xb7de4a70, [], 0}, {SIG_IGN}, 8) = 0
[pid 5029] socket(PF_FILE, SOCK_DGRAM, 0) = 5
[pid 5029] fcntl64(5, F_SETFD, FD_CLOEXEC) = 0
[pid 5029] connect(5, {sa_family=AF_FILE, path="/dev/log"}, 16) = 0
[pid 5029] send(5, "<38>Jul 1 14:46:35 sshd[5029]: "..., 86, 0) = 86
[pid 5029] rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
[pid 5029] open("/etc/motd", O_RDONLY) = 6
[pid 5029] fstat64(6, {st_mode=S_IFREG|0644, st_size=373, ...}) = 0
[pid 5029] read(6, "Linux maguro.burlingame.ibm.com "..., 373) = 373
[pid 5029] close(6) = 0
[pid 5029] stat64("/var/mail/amckenna", 0xbfffeb8c) = -1 ENOENT (No such file or directory)
[pid 5029] open("/etc/passwd", O_RDONLY) = 6
[pid 5029] fcntl64(6, F_GETFD) = 0
[pid 5029] fcntl64(6, F_SETFD, FD_CLOEXEC) = 0
[pid 5029] _llseek(6, 0, [0], SEEK_CUR) = 0
[pid 5029] fstat64(6, {st_mode=S_IFREG|0644, st_size=2000, ...}) = 0
[pid 5029] mmap2(NULL, 2000, PROT_READ, MAP_SHARED, 6, 0) = 0xb7fe8000
[pid 5029] _llseek(6, 2000, [2000], SEEK_SET) = 0
[pid 5029] munmap(0xb7fe8000, 2000) = 0
[pid 5029] close(6) = 0
[pid 5029] getrlimit(RLIMIT_CPU, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_FSIZE, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_DATA, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_CORE, {rlim_cur=0, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_RSS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_NPROC, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_NOFILE, {rlim_cur=1024, rlim_max=1024}) = 0
[pid 5029] getrlimit(RLIMIT_MEMLOCK, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_AS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] getrlimit(RLIMIT_LOCKS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] open("/etc/security/limits.conf", O_RDONLY) = 6
[pid 5029] fstat64(6, {st_mode=S_IFREG|0644, st_size=1519, ...}) = 0
[pid 5029] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fe8000
[pid 5029] read(6, "# /etc/security/limits.conf\n#\n#E"..., 4096) = 1519
[pid 5029] read(6, "", 4096) = 0
[pid 5029] close(6) = 0
[pid 5029] munmap(0xb7fe8000, 4096) = 0
[pid 5029] setrlimit(RLIMIT_CPU, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_FSIZE, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_DATA, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_CORE, {rlim_cur=0, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_RSS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_NPROC, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_NOFILE, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = -1 EPERM (Operation not permitted)
[pid 5029] setrlimit(RLIMIT_MEMLOCK, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_AS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setrlimit(RLIMIT_LOCKS, {rlim_cur=RLIM_INFINITY, rlim_max=RLIM_INFINITY}) = 0
[pid 5029] setpriority(PRIO_PROCESS, 0, 0) = 0
[pid 5029] open("/etc/security/pam_env.conf", O_RDONLY) = 6
[pid 5029] fstat64(6, {st_mode=S_IFREG|0644, st_size=3101, ...}) = 0
[pid 5029] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fe8000
[pid 5029] read(6, "# $Date: 2002/09/21 18:37:34 $\n#"..., 4096) = 3101
[pid 5029] read(6, "", 4096) = 0
[pid 5029] close(6) = 0
[pid 5029] munmap(0xb7fe8000, 4096) = 0
[pid 5029] open("/etc/environment", O_RDONLY) = 6
[pid 5029] fstat64(6, {st_mode=S_IFREG|0644, st_size=12, ...}) = 0
[pid 5029] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fe8000
[pid 5029] read(6, "\nLANG=en_US\n", 4096) = 12
[pid 5029] read(6, "", 4096) = 0
[pid 5029] close(6) = 0
[pid 5029] munmap(0xb7fe8000, 4096) = 0
[pid 5029] time([1120254395]) = 1120254395
[pid 5029] getpid() = 5029
[pid 5029] rt_sigaction(SIGPIPE, {0xb7de4a70, [], 0}, {SIG_IGN}, 8) = 0
[pid 5029] send(5, "<34>Jul 1 14:46:35 sshd[5029]: "..., 76, 0) = 76
[pid 5029] rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
[pid 5029] close(5) = 0
[pid 5029] getuid32() = 0
[pid 5029] time([1120254395]) = 1120254395
[pid 5029] getpid() = 5029
[pid 5029] rt_sigaction(SIGPIPE, {0xb7de4a70, [], 0}, {SIG_IGN}, 8) = 0
[pid 5029] socket(PF_FILE, SOCK_DGRAM, 0) = 5
[pid 5029] fcntl64(5, F_SETFD, FD_CLOEXEC) = 0
[pid 5029] connect(5, {sa_family=AF_FILE, path="/dev/log"}, 16) = 0
[pid 5029] send(5, "<38>Jul 1 14:46:35 sshd[5029]: "..., 75, 0) = 75
[pid 5029] rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
[pid 5029] munmap(0xb7baf000, 14548) = 0
[pid 5029] munmap(0xb7b97000, 93032) = 0
[pid 5029] munmap(0xb7b95000, 7384) = 0
[pid 5029] munmap(0xb7b92000, 12128) = 0
[pid 5029] munmap(0xb7b8e000, 15600) = 0
[pid 5029] munmap(0xb7b78000, 14676) = 0
[pid 5029] exit_group(255) = ?
Process 5029 detached
<... read resumed> "", 4) = 0
munmap(0xb7baf000, 14548) = 0
munmap(0xb7b97000, 93032) = 0
munmap(0xb7b95000, 7384) = 0
munmap(0xb7b92000, 12128) = 0
munmap(0xb7b8e000, 15600) = 0
munmap(0xb7b78000, 14676) = 0
exit_group(255) = ?
Process 5023 detached
--Adam
Reply to: