[Varnish] #1054: Child not responding to CLI, killing it

[Varnish]

#1054: Child not responding to CLI, killing it
---------------------------+-----------------------
 Reporter:  scorillo       |       Owner:  lkarsten
     Type:  defect         |      Status:  reopened
 Priority:  normal         |   Milestone:
Component:  documentation  |     Version:  3.0.2
 Severity:  normal         |  Resolution:
 Keywords:                 |
---------------------------+-----------------------

Comment (by scorillo):

 Hi,

 I don't think it is a memory problem, but a problem somehow related to CPU
 (iowait).

 Take a look:

 {{{
 /var/log/messages-20121216.gz:Dec 14 04:12:02 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:12:12 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:12:22 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:12:33 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:12:43 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:12:53 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:03 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:13 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:23 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:33 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:43 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:13:53 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:14:03 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:14:06 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 /var/log/messages-20121216.gz:Dec 14 04:14:06 black-varnish
 varnishd[7071]: Child (7072) not responding to CLI, killing it.
 }}}

 {{{
 [root at black-varnish src]# sar -f /var/log/sa/sa14
 Linux 2.6.32-279.14.1.el6.x86_64 (black-varnish.okazii.ro)      12/14/2012
 _x86_64_        (2 CPU)

 12:00:01 AM     CPU     %user     %nice   %system   %iowait    %steal
 %idle
 ...
 04:10:01 AM     all      0.22      0.00      0.11      0.62      0.00
 99.05
 04:20:01 AM     all      0.22      0.00      0.11     27.46      0.00
 72.22
 04:30:01 AM     all      0.21      0.00      0.10      0.45      0.00
 99.24
 }}}

 And here:

 {{{
 Dec 16 04:10:02 black-varnish varnishd[7071]: Child (25212) not responding
 to CLI, killing it.
 Dec 16 04:10:02 black-varnish varnishd[7071]: Child (25212) not responding
 to CLI, killing it.
 }}}

 {{{
 Linux 2.6.32-279.14.1.el6.x86_64 (black-varnish.okazii.ro)      12/16/2012
 _x86_64_        (2 CPU)

 12:00:01 AM     CPU     %user     %nice   %system   %iowait    %steal
 %idle
 ...
 04:00:01 AM     all      0.23      0.00      0.12      0.12      0.00
 99.53
 04:10:01 AM     all      0.23      0.00      0.12      3.29      0.00
 96.35
 04:20:01 AM     all      0.22      0.00      0.12      2.42      0.00
 97.25
 04:30:01 AM     all      0.22      0.00      0.12      0.46      0.00
 99.21
 }}}

 An finally here:

 {{{
 Dec 17 16:11:52 black-varnish varnishd[7071]: Child (14654) not responding
 to CLI, killing it.
 Dec 17 16:11:56 black-varnish varnishd[7071]: Child (14654) not responding
 to CLI, killing it.
 Dec 17 16:11:56 black-varnish varnishd[7071]: Child (14654) not responding
 to CLI, killing it.
 }}}

 {{{
 Linux 2.6.32-279.14.1.el6.x86_64 (black-varnish.okazii.ro)      12/17/2012
 _x86_64_        (2 CPU)

 12:00:01 AM     CPU     %user     %nice   %system   %iowait    %steal
 %idle
 ...
 04:10:01 PM     all      0.25      0.00      0.14      0.65      0.00
 98.96
 04:20:01 PM     all      0.64      0.00      0.21      8.00      0.00
 91.15
 04:30:01 PM     all      0.25      0.00      0.15      0.37      0.00
 99.24
 }}}

 Thank you,
 Cristian

-- 
Ticket URL: <https://www.varnish-cache.org/trac/ticket/1054#comment:16>
Varnish <https://varnish-cache.org/>
The Varnish HTTP Accelerator