See below for an output of strace attached to the main varnish process and
varnishstat before restart.
stefan@DCVARN01:~$ sudo strace -p 17970
Process 17970 attached - interrupt to quit
restart_syscall(<... resuming interrupted call ...>) = 1
read(8, "ping\n", 8191) = 5
writev(11, [{"200 19 \n", 13}, {"PONG 1369292498 1.0", 19}, {"\n", 1}], 3)
= 33
poll([{fd=8, events=POLLIN}], 1, -1) = 1 ([{fd=8, revents=POLLIN}])
read(8, "ping\n", 8191) = 5
writev(11, [{"200 19 \n", 13}, {"PONG 1369292501 1.0", 19}, {"\n", 1}], 3)
= 33
poll([{fd=8, events=POLLIN}], 1, -1) = 1 ([{fd=8, revents=POLLIN}])
read(8, "ping\n", 8191) = 5
writev(11, [{"200 19 \n", 13}, {"PONG 1369292504 1.0", 19}, {"\n", 1}], 3)
= 33
poll([{fd=8, events=POLLIN}], 1, -1) = 1 ([{fd=8, revents=POLLIN}])
read(8, "ping\n", 8191) = 5
writev(11, [{"200 19 \n", 13}, {"PONG 1369292507 1.0", 19}, {"\n", 1}], 3)
= 33
poll([{fd=8, events=POLLIN}], 1, -1) = 1 ([{fd=8, revents=POLLIN}])
read(8, "ping\n", 8191) = 5
writev(11, [{"200 19 \n", 13}, {"PONG 1369292510 1.0", 19}, {"\n", 1}], 3)
= 33
poll([{fd=8, events=POLLIN}], 1, -1^C <unfinished ...>
Process 17970 detached
client_conn 184625 2.31 Client connections accepted
client_drop 0 0.00 Connection dropped, no sess/wrk
client_req 2642174 33.10 Client requests received
cache_hit 2603852 32.62 Cache hits
cache_hitpass 0 0.00 Cache hits for pass
cache_miss 33665 0.42 Cache misses
backend_conn 3241 0.04 Backend conn. success
backend_unhealthy 23 0.00 Backend conn. not attempted
backend_busy 0 0.00 Backend conn. too many
backend_fail 0 0.00 Backend conn. failures
backend_reuse 35211 0.44 Backend conn. reuses
backend_toolate 2825 0.04 Backend conn. was closed
backend_recycle 38040 0.48 Backend conn. recycles
backend_retry 0 0.00 Backend conn. retry
fetch_head 0 0.00 Fetch head
fetch_length 27204 0.34 Fetch with Length
fetch_chunked 10987 0.14 Fetch chunked
fetch_eof 0 0.00 Fetch EOF
fetch_bad 0 0.00 Fetch had bad headers
fetch_close 10 0.00 Fetch wanted close
fetch_oldhttp 0 0.00 Fetch pre HTTP/1.1 closed
fetch_zero 0 0.00 Fetch zero len
fetch_failed 0 0.00 Fetch failed
fetch_1xx 0 0.00 Fetch no body (1xx)
fetch_204 0 0.00 Fetch no body (204)
fetch_304 249 0.00 Fetch no body (304)
n_sess_mem 53 . N struct sess_mem
n_sess 12 . N struct sess
n_object 14036 . N struct object
n_vampireobject 0 . N unresurrected objects
n_objectcore 14076 . N struct objectcore
n_objecthead 12899 . N struct objecthead
n_waitinglist 97 . N struct waitinglist
n_vbc 5 . N struct vbc
n_wrk 800 . N worker threads
n_wrk_create 800 0.01 N worker threads created
n_wrk_failed 0 0.00 N worker threads not created
n_wrk_max 0 0.00 N worker threads limited
n_wrk_lqueue 0 0.00 work request queue length
n_wrk_queued 1 0.00 N queued work requests
n_wrk_drop 0 0.00 N dropped work requests
n_backend 3 . N backends
n_expired 19278 . N expired objects
n_lru_nuked 0 . N LRU nuked objects
n_lru_moved 222935 . N LRU moved objects
losthdr 85 0.00 HTTP header overflows
n_objsendfile 0 0.00 Objects sent with sendfile
n_objwrite 2636194 33.02 Objects sent with write
n_objoverflow 0 0.00 Objects overflowing workspace
s_sess 184624 2.31 Total Sessions
s_req 2642174 33.10 Total Requests
s_pipe 1 0.00 Total pipe
s_pass 4813 0.06 Total pass
s_fetch 38123 0.48 Total fetch
s_hdrbytes 1389306713 17402.23 Total header bytes
s_bodybytes 43940615416 550392.88 Total body bytes
sess_closed 146837 1.84 Session Closed
sess_pipeline 0 0.00 Session Pipeline
sess_readahead 0 0.00 Session Read Ahead
sess_linger 2641231 33.08 Session Linger
sess_herd 210605 2.64 Session herd
shm_records 119945812 1502.42 SHM records
shm_writes 3554505 44.52 SHM writes
shm_flushes 0 0.00 SHM flushes due to overflow
shm_cont 15217 0.19 SHM MTX contention
shm_cycles 48 0.00 SHM cycles through buffer
sms_nreq 198 0.00 SMS allocator requests
sms_nobj 0 . SMS outstanding allocations
sms_nbytes 0 . SMS outstanding bytes
sms_balloc 136307 . SMS bytes allocated
sms_bfree 136307 . SMS bytes freed
backend_req 38451 0.48 Backend requests made
n_vcl 1 0.00 N vcl total
n_vcl_avail 1 0.00 N vcl available
n_vcl_discard 0 0.00 N vcl discarded
n_ban 1 . N total active bans
n_ban_add 1 0.00 N new bans added
n_ban_retire 0 0.00 N old bans deleted
n_ban_obj_test 0 0.00 N objects tested
n_ban_re_test 0 0.00 N regexps tested against
n_ban_dups 0 0.00 N duplicate bans removed
hcb_nolock 2637212 33.03 HCB Lookups without lock
hcb_lock 26131 0.33 HCB Lookups with lock
hcb_insert 26131 0.33 HCB Inserts
esi_errors 0 0.00 ESI parse errors (unlock)
esi_warnings 0 0.00 ESI parse warnings (unlock)
accept_fail 0 0.00 Accept failures
client_drop_late 0 0.00 Connection dropped late
uptime 79835 1.00 Client uptime
dir_dns_lookups 0 0.00 DNS director lookups
dir_dns_failed 0 0.00 DNS director failed lookups
dir_dns_hit 0 0.00 DNS director cached lookups hit
dir_dns_cache_full 0 0.00 DNS director full dnscache
vmods 0 . Loaded VMODs
n_gzip 23999 0.30 Gzip operations
n_gunzip 43432 0.54 Gunzip operations
LCK.sms.creat 1 0.00 Created locks
LCK.sms.destroy 0 0.00 Destroyed locks
LCK.sms.locks 594 0.01 Lock Operations
LCK.sms.colls 0 0.00 Collisions
LCK.smp.creat 0 0.00 Created locks
LCK.smp.destroy 0 0.00 Destroyed locks
LCK.smp.locks 0 0.00 Lock Operations
LCK.smp.colls 0 0.00 Collisions
LCK.sma.creat 2 0.00 Created locks
LCK.sma.destroy 0 0.00 Destroyed locks
LCK.sma.locks 160471 2.01 Lock Operations
LCK.sma.colls 0 0.00 Collisions
LCK.smf.creat 0 0.00 Created locks
LCK.smf.destroy 0 0.00 Destroyed locks
LCK.smf.locks 0 0.00 Lock Operations
LCK.smf.colls 0 0.00 Collisions
LCK.hsl.creat 0 0.00 Created locks
LCK.hsl.destroy 0 0.00 Destroyed locks
LCK.hsl.locks 0 0.00 Lock Operations
LCK.hsl.colls 0 0.00 Collisions
LCK.hcb.creat 1 0.00 Created locks
LCK.hcb.destroy 0 0.00 Destroyed locks
LCK.hcb.locks 39858 0.50 Lock Operations
LCK.hcb.colls 0 0.00 Collisions
LCK.hcl.creat 0 0.00 Created locks
LCK.hcl.destroy 0 0.00 Destroyed locks
LCK.hcl.locks 0 0.00 Lock Operations
LCK.hcl.colls 0 0.00 Collisions
LCK.vcl.creat 1 0.00 Created locks
LCK.vcl.destroy 0 0.00 Destroyed locks
LCK.vcl.locks 138 0.00 Lock Operations
LCK.vcl.colls 0 0.00 Collisions
LCK.stat.creat 1 0.00 Created locks
LCK.stat.destroy 0 0.00 Destroyed locks
LCK.stat.locks 53 0.00 Lock Operations
LCK.stat.colls 0 0.00 Collisions
LCK.sessmem.creat 1 0.00 Created locks
LCK.sessmem.destroy 0 0.00 Destroyed locks
LCK.sessmem.locks 190640 2.39 Lock Operations
LCK.sessmem.colls 0 0.00 Collisions
LCK.wstat.creat 1 0.00 Created locks
LCK.wstat.destroy 0 0.00 Destroyed locks
LCK.wstat.locks 435092 5.45 Lock Operations
LCK.wstat.colls 0 0.00 Collisions
LCK.herder.creat 1 0.00 Created locks
LCK.herder.destroy 0 0.00 Destroyed locks
LCK.herder.locks 1 0.00 Lock Operations
LCK.herder.colls 0 0.00 Collisions
LCK.wq.creat 4 0.00 Created locks
LCK.wq.destroy 0 0.00 Destroyed locks
LCK.wq.locks 1035110 12.97 Lock Operations
LCK.wq.colls 0 0.00 Collisions
LCK.objhdr.creat 26172 0.33 Created locks
LCK.objhdr.destroy 13272 0.17 Destroyed locks
LCK.objhdr.locks 10595547 132.72 Lock Operations
LCK.objhdr.colls 0 0.00 Collisions
LCK.exp.creat 1 0.00 Created locks
LCK.exp.destroy 0 0.00 Destroyed locks
LCK.exp.locks 132421 1.66 Lock Operations
LCK.exp.colls 0 0.00 Collisions
LCK.lru.creat 2 0.00 Created locks
LCK.lru.destroy 0 0.00 Destroyed locks
LCK.lru.locks 33315 0.42 Lock Operations
LCK.lru.colls 0 0.00 Collisions
LCK.cli.creat 1 0.00 Created locks
LCK.cli.destroy 0 0.00 Destroyed locks
LCK.cli.locks 26611 0.33 Lock Operations
LCK.cli.colls 0 0.00 Collisions
LCK.ban.creat 1 0.00 Created locks
LCK.ban.destroy 0 0.00 Destroyed locks
LCK.ban.locks 132423 1.66 Lock Operations
LCK.ban.colls 0 0.00 Collisions
LCK.vbp.creat 1 0.00 Created locks
LCK.vbp.destroy 0 0.00 Destroyed locks
LCK.vbp.locks 0 0.00 Lock Operations
LCK.vbp.colls 0 0.00 Collisions
LCK.vbe.creat 1 0.00 Created locks
LCK.vbe.destroy 0 0.00 Destroyed locks
LCK.vbe.locks 6477 0.08 Lock Operations
LCK.vbe.colls 0 0.00 Collisions
LCK.backend.creat 3 0.00 Created locks
LCK.backend.destroy 0 0.00 Destroyed locks
LCK.backend.locks 96597 1.21 Lock Operations
LCK.backend.colls 0 0.00 Collisions
SMA.s0.c_req 70266 0.88 Allocator requests
SMA.s0.c_fail 0 0.00 Allocator failures
SMA.s0.c_bytes 4218323837 52838.03 Bytes allocated
SMA.s0.c_freed 3569121024 44706.22 Bytes freed
SMA.s0.g_alloc 28953 . Allocations outstanding
SMA.s0.g_bytes 649202813 . Bytes outstanding
SMA.s0.g_space 5793248131 . Bytes available
SMA.Transient.c_req 9888 0.12 Allocator requests
SMA.Transient.c_fail 0 0.00 Allocator failures
SMA.Transient.c_bytes 635777238 7963.64 Bytes allocated
SMA.Transient.c_freed 635777238 7963.64 Bytes freed
SMA.Transient.g_alloc 0 . Allocations outstanding
SMA.Transient.g_bytes 0 . Bytes outstanding
SMA.Transient.g_space 0 . Bytes available
VBE.freddev(10.0.102.88,,80).vcls 1 . VCL references
VBE.freddev(10.0.102.88,,80).happy 0 . Happy health probes
VBE.default(10.0.100.180,,80).vcls 1 . VCL references
VBE.default(10.0.100.180,,80).happy 0 . Happy health
probes
VBE.fred(10.0.102.93,,80).vcls 1 . VCL references
VBE.fred(10.0.102.93,,80).happy 0 . Happy health
probes
