Package: openntpd Version: 20080406p-4 Severity: critical Justification: breaks the whole system
Dear Maintainer,
when
a) openntpd is configured to listen on some interface and
b) openntpd is configured to step the time on start-up and
c) the DNS servers are not reachable for any reason,
the openntpd if-up.d hook will delay system boot indefinitely. Even in
single-user mode neither sshd nor a login shell are started before this
happens.
Excerpt from console log (manually killing ntpd using the OOM killer via
magic SysRq):
=== Begin ===
[....] Configuring network interfaces...device lan0 entered promiscuous mode
IPv6: ADDRCONF(NETDEV_UP): lanbr: link is not ready
Waiting for lanbr to get ready (MAXWAIT is 32 seconds).
u32 classifier
Performance counters on
input device check on
Actions configured
Mirror/redirect action on
Installing knfsd (copyright (C) 1996 [email protected]).
mv643xx_eth_port mv643xx_eth_port.0 lan0: link up, 1000 Mb/s, full duplex, flow
control disabled
lanbr: port 1(lan0) entered forwarding state
lanbr: port 1(lan0) entered forwarding state
IPv6: ADDRCONF(NETDEV_CHANGE): lanbr: link becomes ready
Starting rpcbind daemon...Already running..
Starting NFS common utilities: statd idmapd.
mount.nfs4: Failed to resolve server bbox: Name or service not known
Restarting openntpd: ntp_adjtime returns frequency of 52.990387ppm
lanbr: port 1(lan0) entered forwarding state
--- BREAK active ---
--- BREAK inactive ---
SysRq : Manual OOM execution
kworker/0:4 invoked oom-killer: gfp_mask=0xd0, order=0, oom_score_adj=0
CPU: 0 PID: 161 Comm: kworker/0:4 Not tainted 3.18.0-openrd-1-00001-gff3a1b1 #16
Workqueue: events moom_callback
[<c0013674>] (unwind_backtrace) from [<c00107e0>] (show_stack+0x10/0x14)
[<c00107e0>] (show_stack) from [<c077b514>] (dump_header.isra.15+0x50/0x154)
[<c077b514>] (dump_header.isra.15) from [<c00a16e0>]
(oom_kill_process+0xa0/0x374)
[<c00a16e0>] (oom_kill_process) from [<c00a1e04>] (out_of_memory+0x2d8/0x320)
[<c00a1e04>] (out_of_memory) from [<c03d1b44>] (moom_callback+0x20/0x28)
[<c03d1b44>] (moom_callback) from [<c0032460>] (process_one_work+0x1c4/0x370)
[<c0032460>] (process_one_work) from [<c00328f0>] (worker_thread+0x2b8/0x440)
[<c00328f0>] (worker_thread) from [<c0035ea0>] (kthread+0xb8/0xcc)
[<c0035ea0>] (kthread) from [<c000de10>] (ret_from_fork+0x14/0x24)
Mem-info:
Normal per-cpu:
CPU 0: hi: 186, btch: 31 usd: 61
active_anon:770 inactive_anon:31 isolated_anon:0
active_file:3066 inactive_file:2094 isolated_file:0
unevictable:471 dirty:0 writeback:0 unstable:0
free:116988 slab_reclaimable:1298 slab_unreclaimable:1042
mapped:908 shmem:54 pagetables:99 bounce:0
free_cma:0
Normal free:467952kB min:2848kB low:3560kB high:4272kB active_anon:3080kB
inactive_anon:124kB active_file:12264kB inactive_file:8376kB unevictable:1884kB
isolated(anon):0kB isolated(file):0kB present:524288kB managed:507456kB
mlocked:1884kB dirty:0kB writeback:0kB mapped:3632kB shmem:216kB
slab_reclaimable:5192kB slab_unreclaimable:4168kB kernel_stack:720kB
pagetables:396kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB
pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0
Normal: 124*4kB (UEM) 78*8kB (UEM) 67*16kB (UEM) 19*32kB (UEM) 6*64kB (UEM)
7*128kB (UEM) 4*256kB (UE) 2*512kB (U) 1*1024kB (U) 5*2048kB (UEM) 110*4096kB
(MR) = 467952kB
5595 total pagecache pages
0 pages in swap cache
Swap cache stats: add 0, delete 0, find 0/0
Free swap = 0kB
Total swap = 0kB
131072 pages of RAM
117226 free pages
4208 reserved pages
2025 slab pages
271341 pages shared
0 pages swap cached
[ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name
[ 190] 0 190 537 176 5 0 0 init
[ 191] 0 191 437 276 4 0 0 rc
[ 200] 0 200 504 472 5 0 0 startpar
[ 314] 0 314 697 516 5 0 -1000 udevd
[ 428] 0 428 696 438 5 0 -1000 udevd
[ 432] 0 432 696 438 5 0 -1000 udevd
[ 618] 0 618 545 305 6 0 0 bootlogd
[ 619] 0 619 423 324 4 0 0 startpar
[ 1797] 0 1797 437 267 4 0 0 networking
[ 1805] 0 1805 425 285 4 0 0 ifup
[ 1974] 0 1974 588 434 5 0 -1000 rpcbind
[ 1997] 104 1997 668 540 5 0 -1000 rpc.statd
[ 2021] 0 2021 702 354 5 0 -1000 rpc.idmapd
[ 2133] 0 2133 437 299 5 0 0 sh
[ 2134] 0 2134 418 269 4 0 0 run-parts
[ 2230] 0 2230 437 297 5 0 0 openntpd
[ 2232] 0 2232 437 286 4 0 0 invoke-rc.d
[ 2249] 0 2249 437 266 4 0 0 openntpd
[ 2253] 0 2253 1037 678 5 0 0 ntpd
[ 2254] 103 2254 1004 633 5 0 0 ntpd
Out of memory: Kill process 2253 (ntpd) score 5 or sacrifice child
Killed process 2254 (ntpd) total-vm:4016kB, anon-rss:268kB, file-rss:2264kB
dispatch_imsg in main: pipe closed
Lost child: child terminated; signal 9 (Killed)
Terminating
ntpd.
Restarting openntpd: ntp_adjtime returns frequency of 52.990387ppm
--- BREAK active ---
--- BREAK inactive ---
SysRq : Manual OOM execution
kworker/0:4 invoked oom-killer: gfp_mask=0xd0, order=0, oom_score_adj=0
CPU: 0 PID: 161 Comm: kworker/0:4 Not tainted 3.18.0-openrd-1-00001-gff3a1b1 #16
Workqueue: events moom_callback
[<c0013674>] (unwind_backtrace) from [<c00107e0>] (show_stack+0x10/0x14)
[<c00107e0>] (show_stack) from [<c077b514>] (dump_header.isra.15+0x50/0x154)
[<c077b514>] (dump_header.isra.15) from [<c00a16e0>]
(oom_kill_process+0xa0/0x374)
[<c00a16e0>] (oom_kill_process) from [<c00a1e04>] (out_of_memory+0x2d8/0x320)
[<c00a1e04>] (out_of_memory) from [<c03d1b44>] (moom_callback+0x20/0x28)
[<c03d1b44>] (moom_callback) from [<c0032460>] (process_one_work+0x1c4/0x370)
[<c0032460>] (process_one_work) from [<c00328f0>] (worker_thread+0x2b8/0x440)
[<c00328f0>] (worker_thread) from [<c0035ea0>] (kthread+0xb8/0xcc)
[<c0035ea0>] (kthread) from [<c000de10>] (ret_from_fork+0x14/0x24)
Mem-info:
Normal per-cpu:
CPU 0: hi: 186, btch: 31 usd: 62
active_anon:771 inactive_anon:29 isolated_anon:0
active_file:3153 inactive_file:2009 isolated_file:0
unevictable:471 dirty:2 writeback:0 unstable:0
free:116988 slab_reclaimable:1298 slab_unreclaimable:1042
mapped:908 shmem:53 pagetables:97 bounce:0
free_cma:0
Normal free:467952kB min:2848kB low:3560kB high:4272kB active_anon:3084kB
inactive_anon:116kB active_file:12612kB inactive_file:8036kB unevictable:1884kB
isolated(anon):0kB isolated(file):0kB present:524288kB managed:507456kB
mlocked:1884kB dirty:8kB writeback:0kB mapped:3632kB shmem:212kB
slab_reclaimable:5192kB slab_unreclaimable:4168kB kernel_stack:720kB
pagetables:388kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB
pages_scanned:0 all_unreclaimable? no
lowmem_reserve[]: 0 0
Normal: 100*4kB (UEM) 84*8kB (UEM) 66*16kB (UEM) 19*32kB (UEM) 7*64kB (UEM)
7*128kB (UEM) 4*256kB (UE) 2*512kB (U) 1*1024kB (U) 5*2048kB (UEM) 110*4096kB
(MR) = 467952kB
5596 total pagecache pages
0 pages in swap cache
Swap cache stats: add 0, delete 0, find 0/0
Free swap = 0kB
Total swap = 0kB
131072 pages of RAM
117227 free pages
4208 reserved pages
2025 slab pages
271330 pages shared
0 pages swap cached
[ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name
[ 190] 0 190 537 176 5 0 0 init
[ 191] 0 191 437 276 4 0 0 rc
[ 200] 0 200 504 472 5 0 0 startpar
[ 314] 0 314 697 516 5 0 -1000 udevd
[ 428] 0 428 696 438 5 0 -1000 udevd
[ 432] 0 432 696 438 5 0 -1000 udevd
[ 618] 0 618 545 305 6 0 0 bootlogd
[ 619] 0 619 423 324 4 0 0 startpar
[ 1797] 0 1797 437 267 4 0 0 networking
[ 1805] 0 1805 425 285 4 0 0 ifup
[ 1974] 0 1974 588 434 5 0 -1000 rpcbind
[ 1997] 104 1997 668 540 5 0 -1000 rpc.statd
[ 2021] 0 2021 702 354 5 0 -1000 rpc.idmapd
[ 2261] 0 2261 437 299 4 0 0 sh
[ 2262] 0 2262 418 269 5 0 0 run-parts
[ 2285] 0 2285 437 278 5 0 0 openntpd
[ 2287] 0 2287 437 283 4 0 0 invoke-rc.d
[ 2304] 0 2304 437 289 4 0 0 openntpd
[ 2308] 0 2308 1037 691 4 0 0 ntpd
[ 2309] 103 2309 1004 646 4 0 0 ntpd
Out of memory: Kill process 2308 (ntpd) score 5 or sacrifice child
Killed process 2309 (ntpd) total-vm:4016kB, anon-rss:268kB, file-rss:2316kB
dispatch_imsg in main: pipe closed
Lost child: child terminated; signal 9 (Killed)
Terminating
ntpd.
ifup: interface lanbr already configured
done.
[ ok ] Starting rpcbind daemon...[....] Already running..
=== End ===
The reason for the hang (ntpd never daemonizing itself) can be
replicated on a fully booted system by disconnecting the network and
invoking "/etc/init.d/openntpd force-reload". For some reason it _does_
daemonize correctly while being traced with strace, though. :-/
-- System Information:
Debian Release: 7.7
APT prefers stable-updates
APT policy: (500, 'stable-updates'), (500, 'stable'), (1, 'experimental')
Architecture: armel (armv5tel)
Kernel: Linux 3.18.0-openrd-1-00001-gff3a1b1
Locale: LANG=en_GB, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages openntpd depends on:
ii adduser 3.113+nmu3
ii libc6 2.13-38+deb7u6
ii libssl1.0.0 1.0.1e-2+deb7u13
ii netbase 5.0
openntpd recommends no packages.
openntpd suggests no packages.
-- Configuration Files:
/etc/default/openntpd changed:
DAEMON_OPTS="-s -f /etc/openntpd/ntpd.conf"
/etc/openntpd/ntpd.conf changed:
listen on *
servers 0.debian.pool.ntp.org
servers 1.debian.pool.ntp.org
servers 2.debian.pool.ntp.org
servers 3.debian.pool.ntp.org
-- no debconf information
-- debsums errors found:
debsums: changed file /var/lib/openntpd/ntpd.drift (from openntpd package)
pgprFV3xB2Vuz.pgp
Description: PGP signature
