Mailing List Archive

one cpu in 100% after simple url.purge ??
Hi all

I just noticed something I did not expect... I had to purge two small
images from te cache - they have a ttl of ten minutes.

I telnet into varnish and write

url.purge *varsel_oversigt.png
I get a 200

I write

url.purge *varsel_markering.*
I get a 200

I log out of telnetpromt

and notice that the "root-driven" varnishd is now in 100% cpu usage it has
been there since (? an hour).
There is no problem for the users (I think) as the "nobody-driven" varnishd
serves them and only uses around 8% cpu.

What is varnishd using one whole cpu for ?

Regards
Eivind

--
Eivind Bengtsson
Systemadministrator - Cand.merc.(dat)
Danmarks Meteorologiske Institut
Lyngbyvej 100
2100 K?benhavn ?
Direkte tlf. : 39157544
Email: ebe at dmi.dk
echo 'This is not a pipe.' | cat -> /dev/tty
one cpu in 100% after simple url.purge ?? [ In reply to ]
Hi in reply to my own mail ...

Varnishd is using one cpu for this :

poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2498) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966356511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2498) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966436511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2498) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966514511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2498) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966588511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2498) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966663511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2497) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966743511}) = 0
poll([{fd=6, events=POLLIN}, {fd=14, events=POLLIN}, {fd=10, events=POLLIN,
revents=POLLNVAL}, {fd=14, events=POLLIN}], 4, 2497) = 1
clock_gettime(CLOCK_MONOTONIC, {764359, 966818511}) = 0

and so on ....

phk indiates on irc that it could be caused by the telnet...
Just for the record ;-)...
only escape is to restart varnishd.

/Eivind
ps Many thanks to the developers for quick help on diagnose


Eivind Bengtsson wrote:
> Hi all
>
> I just noticed something I did not expect... I had to purge two small
> images from te cache - they have a ttl of ten minutes.
>
> I telnet into varnish and write
>
> url.purge *varsel_oversigt.png
> I get a 200
>
> I write
>
> url.purge *varsel_markering.*
> I get a 200
>
> I log out of telnetpromt
>
> and notice that the "root-driven" varnishd is now in 100% cpu usage it has
> been there since (? an hour).
> There is no problem for the users (I think) as the "nobody-driven" varnishd
> serves them and only uses around 8% cpu.
>
> What is varnishd using one whole cpu for ?
>
> Regards
> Eivind
>


--
Eivind Bengtsson
Systemadministrator - Cand.merc.(dat)
Danmarks Meteorologiske Institut
Lyngbyvej 100
2100 K?benhavn ?
Direkte tlf. : 39157544
Email: ebe at dmi.dk
echo 'This is not a pipe.' | cat -> /dev/tty