r267 - in trunk/varnish-cache: bin/varnishd bin/varnishlog include

[phk at projects.linpro.no]

Author: phk
Date: 2006-06-29 17:14:15 +0200 (Thu, 29 Jun 2006)
New Revision: 267

Modified:
   trunk/varnish-cache/bin/varnishd/cache_vcl.c
   trunk/varnish-cache/bin/varnishd/cache_vrt.c
   trunk/varnish-cache/bin/varnishlog/varnishlog.c
   trunk/varnish-cache/include/shmlog_tags.h
Log:
Improve shm-logging of VCL activity


Modified: trunk/varnish-cache/bin/varnishd/cache_vcl.c
===================================================================
--- trunk/varnish-cache/bin/varnishd/cache_vcl.c	2006-06-29 14:37:15 UTC (rev 266)
+++ trunk/varnish-cache/bin/varnishd/cache_vcl.c	2006-06-29 15:14:15 UTC (rev 267)
@@ -227,9 +227,10 @@
 {						\
 						\
 	sp->handling = 0;			\
+	VSL(SLT_VCL_call, sp->fd, "%s", #func); 	\
 	sp->vcl->func##_func(sp);		\
 	CheckHandling(sp, #func, (bitmap));	\
-	VSL(SLT_vcl_##func, sp->fd, "0x%x %s", sp->handling, HandlingName(sp->handling)); \
+	VSL(SLT_VCL_return, sp->fd, "%s", HandlingName(sp->handling)); \
 }
 
 #define VCL_RET_MAC(l,u,b)

Modified: trunk/varnish-cache/bin/varnishd/cache_vrt.c
===================================================================
--- trunk/varnish-cache/bin/varnishd/cache_vrt.c	2006-06-29 14:37:15 UTC (rev 266)
+++ trunk/varnish-cache/bin/varnishd/cache_vrt.c	2006-06-29 15:14:15 UTC (rev 267)
@@ -36,7 +36,7 @@
 VRT_count(struct sess *sp, unsigned u)
 {
 	
-	VSL(SLT_VCL, sp->fd, "%u %d.%d", u,
+	VSL(SLT_VCL_trace, sp->fd, "%u %d.%d", u,
 	    sp->vcl->ref[u].line,
 	    sp->vcl->ref[u].pos);
 }

Modified: trunk/varnish-cache/bin/varnishlog/varnishlog.c
===================================================================
--- trunk/varnish-cache/bin/varnishlog/varnishlog.c	2006-06-29 14:37:15 UTC (rev 266)
+++ trunk/varnish-cache/bin/varnishlog/varnishlog.c	2006-06-29 15:14:15 UTC (rev 267)
@@ -46,14 +46,39 @@
 		ob[u] = sbuf_new(NULL, NULL, 0, SBUF_AUTOEXTEND);
 		assert(ob[u] != NULL);
 	}
-	sbuf_printf(ob[u], "%02x %3d %4d %-12s",
-	    p[0], p[1], u, tagnames[p[0]]);
-	if (p[1] > 0) {
-		sbuf_cat(ob[u], " <");
-		sbuf_bcat(ob[u], p + 4, p[1]);
-		sbuf_cat(ob[u], ">");
+	switch (p[0]) {
+	case SLT_VCL_call:
+		sbuf_printf(ob[u], "%02x %3d %4d %-12s",
+		    p[0], p[1], u, tagnames[p[0]]);
+		if (p[1] > 0) {
+			sbuf_cat(ob[u], " <");
+			sbuf_bcat(ob[u], p + 4, p[1]);
+		}
+		break;
+	case SLT_VCL_trace:
+		if (p[1] > 0) {
+			sbuf_cat(ob[u], " ");
+			sbuf_bcat(ob[u], p + 4, p[1]);
+		}
+		break;
+	case SLT_VCL_return:
+		if (p[1] > 0) {
+			sbuf_cat(ob[u], " ");
+			sbuf_bcat(ob[u], p + 4, p[1]);
+			sbuf_cat(ob[u], ">\n");
+		}
+		break;
+	default:
+		sbuf_printf(ob[u], "%02x %3d %4d %-12s",
+		    p[0], p[1], u, tagnames[p[0]]);
+		if (p[1] > 0) {
+			sbuf_cat(ob[u], " <");
+			sbuf_bcat(ob[u], p + 4, p[1]);
+			sbuf_cat(ob[u], ">");
+		}
+		sbuf_cat(ob[u], "\n");
+		break;
 	}
-	sbuf_cat(ob[u], "\n");
 	if (u == 0) {
 		sbuf_finish(ob[u]);
 		printf("%s", sbuf_data(ob[u]));

Modified: trunk/varnish-cache/include/shmlog_tags.h
===================================================================
--- trunk/varnish-cache/include/shmlog_tags.h	2006-06-29 14:37:15 UTC (rev 266)
+++ trunk/varnish-cache/include/shmlog_tags.h	2006-06-29 15:14:15 UTC (rev 267)
@@ -18,11 +18,6 @@
 SLTM(BackendClose)
 SLTM(HttpError)
 SLTM(ClientAddr)
-#define VCL_RET_MAC(l,u,b)
-#define VCL_MET_MAC(l,u,b) SLTM(vcl_##l)
-#include "vcl_returns.h"
-#undef VCL_MET_MAC
-#undef VCL_RET_MAC
 SLTM(Backend)
 SLTM(Request)
 SLTM(Response)
@@ -32,7 +27,9 @@
 SLTM(Header)
 SLTM(BldHdr)
 SLTM(LostHeader)
-SLTM(VCL)
+SLTM(VCL_call)
+SLTM(VCL_trace)
+SLTM(VCL_return)
 SLTM(XID)
 SLTM(ExpPick)
 SLTM(ExpKill)