[Pkg-varnish-devel] Bug#874455: varnish fails to install due to varnishncsa start fail (systemd on LXC)

Tom LAREDO tom.laredo at gmail.com
Wed Sep 6 10:11:02 UTC 2017


Package: varnish
Version: 5.0.0-7+deb9u1
Severity: important

Dear Maintainer,

The issue happens on a fresh LXC container (Debian Stretch LXC template) created on a Debian Jessie host running Proxmox 4 (proxmox-ve 4.4-94).
Systemd is install by default on the LXC container.

Here is the trace of the failed package installation and some details (netstat, ps, journalctl -xe):

########
proxmox4-staging:/home/tom# pct create 176 /var/lib/vz/template/cache/debian-9.0-standard_9.0-2_amd64.tar.gz --arch amd64 --cpulimit 0 --cpuunits 800 --description "CT for test purpose." --hostname "machine.domain.com" --memory 2048 -net0 "name=eth0,bridge=vmbr2,gw=11.22.33.254,ip=11.22.33.44/26,type=veth" --onboot 1 --ostype debian --password --storage local --swap 512 --rootfs "local:5"
Enter password: ************
Retype password: ************
[...]

########
root at machine:/# apt-get update
[...]
root at machine:/# apt-get upgrade
[...]
root at machine:/# apt-get install varnish
[...]
Created symlink /etc/systemd/system/multi-user.target.wants/varnish.service -> /lib/systemd/system/varnish.service.
Created symlink /etc/systemd/system/multi-user.target.wants/varnishncsa.service -> /lib/systemd/system/varnishncsa.service.
Job for varnishncsa.service failed because the control process exited with error code.
See "systemctl status varnishncsa.service" and "journalctl -xe" for details.
invoke-rc.d: initscript varnishncsa, action "start" failed.
 varnishncsa.service - Varnish HTTP accelerator log daemon
   Loaded: loaded (/lib/systemd/system/varnishncsa.service; enabled; vendor preset: enabled)
   Active: failed (Result: exit-code) since Wed 2017-09-06 08:21:15 UTC; 8ms ago
     Docs: https://www.varnish-cache.org/docs/4.1/
           man:varnishncsa
  Process: 7867 ExecStart=/usr/bin/varnishncsa -a -w /var/log/varnish/varnishncsa.log -D -P /run/varnishncsa/varnishncsa.pid (code=exited, status=225/NETWORK)

Sep 06 08:21:15 machine systemd[1]: Starting Varnish HTTP accelerator log daemon...
Sep 06 08:21:15 machine systemd[1]: varnishncsa.service: Control process exited, code=exited status=225
Sep 06 08:21:15 machine systemd[1]: Failed to start Varnish HTTP accelerator log daemon.
Sep 06 08:21:15 machine systemd[1]: varnishncsa.service: Unit entered failed state.
Sep 06 08:21:15 machine systemd[1]: varnishncsa.service: Failed with result 'exit-code'.
dpkg: error processing package varnish (--configure):
 subprocess installed post-installation script returned error exit status 1
Processing triggers for libc-bin (2.24-11+deb9u1) ...
Processing triggers for systemd (232-25+deb9u1) ...
Errors were encountered while processing:
 varnish
E: Sub-process /usr/bin/dpkg returned an error code (1)

########
root at machine:/# dpkg -l | grep -v ii   
Desired=Unknown/Install/Remove/Purge/Hold
| Status=Not/Inst/Conf-files/Unpacked/halF-conf/Half-inst/trig-aWait/Trig-pend
|/ Err?=(none)/Reinst-required (Status,Err: uppercase=bad)
||/ Name                          Version                        Architecture Description
+++-=============================-==============================-============-===============================================================================
iF  varnish                       5.0.0-7+deb9u1                 amd64        state of the art, high-performance web accelerator

########
root at machine:/# netstat -nutelap | grep 'LISTEN.*varnish'
tcp        0      0 0.0.0.0:6081            0.0.0.0:*               LISTEN      0          1413461796 7824/varnishd       
tcp        0      0 127.0.0.1:6082          0.0.0.0:*               LISTEN      0          1413461804 7824/varnishd       
tcp6       0      0 :::6081                 :::*                    LISTEN      0          1413461797 7824/varnishd       
tcp6       0      0 ::1:6082                :::*                    LISTEN      0          1413461803 7824/varnishd       


########
root at machine:/# ps auxwwwf | grep varnish
vcache    7824  0.0  0.0 127116  3816 ?        Ss   08:21   0:00 /usr/sbin/varnishd -j unix,user=vcache -F -a :6081 -T localhost:6082 -f /etc/varnish/default.vcl -S /etc/varnish/secret -s malloc,256m
vcache    7894  0.0  2.0 315044 87728 ?        Sl   08:21   0:00  \_ /usr/sbin/varnishd -j unix,user=vcache -F -a :6081 -T localhost:6082 -f /etc/varnish/default.vcl -S /etc/varnish/secret -s malloc,256m

########
root at machine:/# systemctl start varnishncsa
Job for varnishncsa.service failed because the control process exited with error code.
See "systemctl status varnishncsa.service" and "journalctl -xe" for details.

########
root at machine:/# systemctl status varnishncsa.service
 varnishncsa.service - Varnish HTTP accelerator log daemon
   Loaded: loaded (/lib/systemd/system/varnishncsa.service; enabled; vendor preset: enabled)
   Active: failed (Result: exit-code) since Wed 2017-09-06 08:52:12 UTC; 27s ago
     Docs: https://www.varnish-cache.org/docs/4.1/
           man:varnishncsa
  Process: 8538 ExecStart=/usr/bin/varnishncsa -a -w /var/log/varnish/varnishncsa.log -D -P /run/varnishncsa/varnishncsa.pid (code=exited, status=225/NETWORK)

Sep 06 08:52:12 machine systemd[1]: Starting Varnish HTTP accelerator log daemon...
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Control process exited, code=exited status=225
Sep 06 08:52:12 machine systemd[1]: Failed to start Varnish HTTP accelerator log daemon.
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Unit entered failed state.
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Failed with result 'exit-code'.

########
root at machine:/# journalctl -xe
Sep 06 08:49:25 machine systemd[1]: systemd-journal-flush.service: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: rsyslog.service: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: postfix.service: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: system-getty.slice: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: systemd-tmpfiles-setup.service: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: proc-diskstats.mount: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: sys-devices-virtual-net.mount: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: proc-stat.mount: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: proc-cpuinfo.mount: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: systemd-journald.service: Failed to reset devices.list: Operation not permitted
Sep 06 08:49:25 machine systemd[1]: varnishncsa.service: Control process exited, code=exited status=225
Sep 06 08:49:25 machine systemd[1]: Failed to start Varnish HTTP accelerator log daemon.
-- Subject: Unit varnishncsa.service has failed
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- Unit varnishncsa.service has failed.
-- 
-- The result is failed.
Sep 06 08:49:25 machine systemd[1]: varnishncsa.service: Unit entered failed state.
Sep 06 08:49:25 machine systemd[1]: varnishncsa.service: Failed with result 'exit-code'.
Sep 06 08:52:12 machine systemd[1]: Failed to set devices.allow on /system.slice/varnishncsa.service: Operation not permitted
Sep 06 08:52:12 machine systemd[1]: Failed to set devices.allow on /system.slice/varnishncsa.service: Operation not permitted
Sep 06 08:52:12 machine systemd[1]: Starting Varnish HTTP accelerator log daemon...
-- Subject: Unit varnishncsa.service has begun start-up
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- Unit varnishncsa.service has begun starting up.
Sep 06 08:52:12 machine systemd[8538]: varnishncsa.service: Failed at step NETWORK spawning /usr/bin/varnishncsa: Permission denied
-- Subject: Process /usr/bin/varnishncsa could not be executed
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- The process /usr/bin/varnishncsa could not be executed and failed.
-- 
-- The error number returned by this process is 13.
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Control process exited, code=exited status=225
Sep 06 08:52:12 machine systemd[1]: Failed to start Varnish HTTP accelerator log daemon.
-- Subject: Unit varnishncsa.service has failed
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- Unit varnishncsa.service has failed.
-- 
-- The result is failed.
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Unit entered failed state.
Sep 06 08:52:12 machine systemd[1]: varnishncsa.service: Failed with result 'exit-code'.

-- System Information:
Debian Release: 9.1
  APT prefers stable
  APT policy: (500, 'stable')
Architecture: amd64 (x86_64)

Kernel: Linux 4.4.67-1-pve (SMP w/8 CPU cores)
Locale: LANG=C, LC_CTYPE=C (charmap=ANSI_X3.4-1968), LANGUAGE=C (charmap=ANSI_X3.4-1968)
Shell: /bin/sh linked to /bin/bash
Init: systemd (via /run/systemd/system)

Versions of packages varnish depends on:
ii  adduser               3.115
ii  gcc                   4:6.3.0-4
ii  init-system-helpers   1.48
ii  libbsd0               0.8.3-1
ii  libc6                 2.24-11+deb9u1
ii  libc6-dev [libc-dev]  2.24-11+deb9u1
ii  libedit2              3.1-20160903-3
ii  libjemalloc1          3.6.0-9.1
ii  libncurses5           6.0+20161126-1
ii  libpcre3              2:8.39-3
ii  libtinfo5             6.0+20161126-1
ii  libvarnishapi1        5.0.0-7+deb9u1
ii  lsb-base              9.20161125

varnish recommends no packages.

Versions of packages varnish suggests:
pn  varnish-doc  <none>

-- no debconf information



More information about the Pkg-varnish-devel mailing list