Closed csandanov closed 4 years ago
Hi,
Before we start digging too deep, what branch are you using, and what varnish version are you running? (varnishd -V
)
Varnish 6.0.5 (tried 6.0.4 which also fails).
I use master branch which I guess is the problem here. I tried 0.15.0 and it compiles without errors. The reason I didn't use the latest stable release because make check
from releases (0.15.0) fails as I previously reported in https://github.com/varnish/varnish-modules/issues/115#issuecomment-446543425. And I've been using master branch for quite a while and it worked for me until recently.
Anyway, here's the failed make check
:
================================================
varnish-modules 0.15.0: src/test-suite.log
================================================
# TOTAL: 49
# PASS: 48
# SKIP: 0
# XFAIL: 0
# FAIL: 1
# XPASS: 0
# ERROR: 0
.. contents:: :depth: 2
FAIL: tests/tcp/02-congestion
=============================
**** top 0.0 extmacro def pwd=/tmp/varnish-modules-0.15.0/src
**** top 0.0 extmacro def vmod_builddir=/tmp/varnish-modules-0.15.0/src
**** top 0.0 extmacro def vmod_directors=directors from "/usr/lib/varnish/vmods/libvmod_directors.so"
**** top 0.0 extmacro def localhost=127.0.0.1
**** top 0.0 extmacro def bad_backend=127.0.0.1 34211
**** top 0.0 extmacro def bad_ip=192.0.2.255
**** top 0.0 macro def testdir=/tmp/varnish-modules-0.15.0/src/./tests/tcp
**** top 0.0 macro def tmpdir=/tmp/vtc.1914.6e3b3a08
* top 0.0 TEST ./tests/tcp/02-congestion.vtc starting
** top 0.0 === varnishtest "Test tcp vmod"
* top 0.0 TEST Test tcp vmod
** top 0.0 === feature cmd "uname | grep Linux"
** top 0.0 === server s1 {
** s1 0.0 Starting server
**** s1 0.0 macro def s1_addr=127.0.0.1
**** s1 0.0 macro def s1_port=43527
**** s1 0.0 macro def s1_sock=127.0.0.1 43527
* s1 0.0 Listen on 127.0.0.1 43527
** top 0.0 === varnish v1 -vcl+backend {
** s1 0.0 Started on 127.0.0.1 43527 (1 iterations)
** v1 0.0 Launch
*** v1 0.0 CMD: cd ${pwd} && exec varnishd -d -n /tmp/vtc.1914.6e3b3a08/v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p sigsegv_handler=on -p thread_pool_min=10 -p debug=+vtc_mode -a '127.0.0.1:0' -M '127.0.0.1 35145' -P /tmp/vtc.1914.6e3b3a08/v1/varnishd.pid
*** v1 0.0 CMD: cd /tmp/varnish-modules-0.15.0/src && exec varnishd -d -n /tmp/vtc.1914.6e3b3a08/v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p sigsegv_handler=on -p thread_pool_min=10 -p debug=+vtc_mode -a '127.0.0.1:0' -M '127.0.0.1 35145' -P /tmp/vtc.1914.6e3b3a08/v1/varnishd.pid
*** v1 0.0 PID: 1922
**** v1 0.0 macro def v1_pid=1922
**** v1 0.0 macro def v1_name=/tmp/vtc.1914.6e3b3a08/v1
*** v1 0.8 debug|Debug: Version: varnish-6.0.5 revision 3065ccaacc4bb537fb976a524bd808db42c5fe40
*** v1 0.8 debug|Debug: Platform: Linux,4.9.184-linuxkit,x86_64,-junix,-sdefault,-sdefault,-hcritbit
*** v1 0.8 debug|
*** v1 0.8 debug|200 317
*** v1 0.8 debug|-----------------------------
*** v1 0.8 debug|Varnish Cache CLI 1.0
*** v1 0.8 debug|-----------------------------
*** v1 0.8 debug|Linux,4.9.184-linuxkit,x86_64,-junix,-sdefault,-sdefault,-hcritbit
*** v1 0.8 debug|varnish-6.0.5 revision 3065ccaacc4bb537fb976a524bd808db42c5fe40
*** v1 0.8 debug|
*** v1 0.8 debug|Type 'help' for command list.
*** v1 0.8 debug|Type 'quit' to close CLI session.
*** v1 0.8 debug|Type 'start' to launch worker process.
*** v1 0.8 debug|
**** v1 0.9 CLIPOLL 1 0x1 0x0
*** v1 0.9 CLI connection fd = 7
*** v1 0.9 CLI RX 107
**** v1 0.9 CLI RX|dwfnnzvzwqylczsbnxnfbnebpgcqypce
**** v1 0.9 CLI RX|
**** v1 0.9 CLI RX|Authentication required.
**** v1 0.9 CLI TX|auth 175c3385ded143e2f124253b6f852e5f4c99572a672bea7879375d116b14d1bc
*** v1 0.9 CLI RX 200
**** v1 0.9 CLI RX|-----------------------------
**** v1 0.9 CLI RX|Varnish Cache CLI 1.0
**** v1 0.9 CLI RX|-----------------------------
**** v1 0.9 CLI RX|Linux,4.9.184-linuxkit,x86_64,-junix,-sdefault,-sdefault,-hcritbit
**** v1 0.9 CLI RX|varnish-6.0.5 revision 3065ccaacc4bb537fb976a524bd808db42c5fe40
**** v1 0.9 CLI RX|
**** v1 0.9 CLI RX|Type 'help' for command list.
**** v1 0.9 CLI RX|Type 'quit' to close CLI session.
**** v1 0.9 CLI RX|Type 'start' to launch worker process.
**** v1 0.9 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P
**** v1 0.9 CLI TX|vcl 4.1;
**** v1 0.9 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "43527"; }
**** v1 0.9 CLI TX|
**** v1 0.9 CLI TX|
**** v1 0.9 CLI TX|\timport tcp from "/tmp/varnish-modules-0.15.0/src/.libs/libvmod_tcp.so";
**** v1 0.9 CLI TX|
**** v1 0.9 CLI TX|\tsub vcl_deliver {
**** v1 0.9 CLI TX|\t\tset resp.http.a = tcp.congestion_algorithm("reno");
**** v1 0.9 CLI TX|\t\tset resp.http.b = tcp.congestion_algorithm("slartibartfast");
**** v1 0.9 CLI TX|\t\tset resp.http.c = tcp.congestion_algorithm("cubic");
**** v1 0.9 CLI TX|\t}
**** v1 0.9 CLI TX|
**** v1 0.9 CLI TX|%XJEIFLH|)Xspa8P
*** v1 1.0 vsl|No VSL chunk found (child not started ?)
*** v1 1.1 vsl|No VSL chunk found (child not started ?)
*** v1 1.2 vsl|No VSL chunk found (child not started ?)
*** v1 1.3 vsl|No VSL chunk found (child not started ?)
*** v1 1.4 vsl|No VSL chunk found (child not started ?)
*** v1 1.5 vsl|No VSL chunk found (child not started ?)
*** v1 1.6 vsl|No VSL chunk found (child not started ?)
*** v1 1.7 vsl|No VSL chunk found (child not started ?)
*** v1 1.8 vsl|No VSL chunk found (child not started ?)
*** v1 1.9 vsl|No VSL chunk found (child not started ?)
*** v1 2.0 vsl|No VSL chunk found (child not started ?)
*** v1 2.1 vsl|No VSL chunk found (child not started ?)
*** v1 2.2 CLI RX 200
**** v1 2.2 CLI RX|VCL compiled.
**** v1 2.2 CLI TX|vcl.use vcl1
*** v1 2.2 CLI RX 200
** v1 2.2 Start
**** v1 2.2 CLI TX|start
*** v1 2.2 vsl|No VSL chunk found (child not started ?)
*** v1 2.2 debug|Debug: Child (1934) Started
*** v1 2.3 debug|Info: Child (1934) said Child starts
*** v1 2.3 CLI RX 200
*** v1 2.3 wait-running
**** v1 2.3 CLI TX|status
**** v1 2.3 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1571803978.723166/vgc.so 1auto
**** v1 2.3 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1571803978.723166/vgc.so" as "vcl1"
**** v1 2.3 vsl| 0 CLI - Rd vcl.use "vcl1"
**** v1 2.3 vsl| 0 CLI - Wr 200 0
**** v1 2.3 vsl| 0 CLI - Rd start
**** v1 2.3 vsl| 0 CLI - Wr 200 0
*** v1 2.3 CLI RX 200
**** v1 2.3 CLI RX|Child in state running
**** v1 2.3 CLI TX|debug.listen_address
*** v1 2.4 CLI RX 200
**** v1 2.4 CLI RX|127.0.0.1 38385
**** v1 2.4 CLI TX|debug.xid 999
**** v1 2.4 vsl| 0 CLI - Rd debug.listen_address
**** v1 2.4 vsl| 0 CLI - Wr 200 16 127.0.0.1 38385
*** v1 2.4 CLI RX 200
**** v1 2.4 CLI RX|XID is 999
**** v1 2.4 CLI TX|debug.listen_address
*** v1 2.5 CLI RX 200
**** v1 2.5 CLI RX|127.0.0.1 38385
** v1 2.5 Listen on 127.0.0.1 38385
**** v1 2.5 macro def v1_addr=127.0.0.1
**** v1 2.5 macro def v1_port=38385
**** v1 2.5 macro def v1_sock=127.0.0.1 38385
** top 2.5 === client c1 {
** top 2.5 === client c1 -run
** c1 2.5 Starting client
** c1 2.5 Waiting for client
*** c1 2.5 Connect to 127.0.0.1 38385
*** c1 2.5 connected fd 17 from 127.0.0.1 39970 to 127.0.0.1 38385
** c1 2.5 === txreq -url "/"
**** c1 2.5 txreq|GET / HTTP/1.1\r
**** c1 2.5 txreq|Host: 127.0.0.1\r
**** c1 2.5 txreq|\r
** c1 2.5 === rxresp
*** s1 2.5 accepted fd 5 127.0.0.1 50156
** s1 2.5 === rxreq
**** s1 2.5 rxhdr|GET / HTTP/1.1\r
**** s1 2.5 rxhdr|Host: 127.0.0.1\r
**** s1 2.5 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 2.5 rxhdr|Accept-Encoding: gzip\r
**** s1 2.5 rxhdr|X-Varnish: 1002\r
**** s1 2.5 rxhdr|\r
**** s1 2.5 rxhdrlen = 103
**** s1 2.5 http[ 0] |GET
**** s1 2.5 http[ 1] |/
**** s1 2.5 http[ 2] |HTTP/1.1
**** s1 2.5 http[ 3] |Host: 127.0.0.1
**** s1 2.5 http[ 4] |X-Forwarded-For: 127.0.0.1
**** s1 2.5 http[ 5] |Accept-Encoding: gzip
**** s1 2.5 http[ 6] |X-Varnish: 1002
**** s1 2.5 bodylen = 0
** s1 2.5 === txresp
**** s1 2.5 txresp|HTTP/1.1 200 OK\r
**** s1 2.5 txresp|Content-Length: 0\r
**** s1 2.5 txresp|\r
*** s1 2.5 shutting fd 5
** s1 2.5 Ending
**** c1 2.5 rxhdr|HTTP/1.1 200 OK\r
**** c1 2.5 rxhdr|Content-Length: 0\r
**** c1 2.5 rxhdr|Date: Wed, 23 Oct 2019 04:13:00 GMT\r
**** c1 2.5 rxhdr|X-Varnish: 1001\r
**** c1 2.5 rxhdr|Age: 0\r
**** c1 2.5 rxhdr|Via: 1.1 varnish (Varnish/6.0)\r
**** c1 2.5 rxhdr|a: -1\r
**** c1 2.5 rxhdr|b: -1\r
**** c1 2.5 rxhdr|c: -1\r
**** c1 2.5 rxhdr|Accept-Ranges: bytes\r
**** c1 2.5 rxhdr|Connection: keep-alive\r
**** c1 2.5 rxhdr|\r
**** c1 2.5 rxhdrlen = 199
**** c1 2.5 http[ 0] |HTTP/1.1
**** c1 2.5 http[ 1] |200
**** c1 2.5 http[ 2] |OK
**** c1 2.5 http[ 3] |Content-Length: 0
**** c1 2.5 http[ 4] |Date: Wed, 23 Oct 2019 04:13:00 GMT
**** c1 2.5 http[ 5] |X-Varnish: 1001
**** c1 2.5 http[ 6] |Age: 0
**** c1 2.5 http[ 7] |Via: 1.1 varnish (Varnish/6.0)
**** c1 2.5 http[ 8] |a: -1
**** c1 2.5 http[ 9] |b: -1
**** c1 2.5 http[10] |c: -1
**** c1 2.5 http[11] |Accept-Ranges: bytes
**** c1 2.5 http[12] |Connection: keep-alive
**** c1 2.5 bodylen = 0
** c1 2.5 === expect resp.http.a == "0"
---- c1 2.5 EXPECT resp.http.a (-1) == "0" failed
* top 2.5 RESETTING after ./tests/tcp/02-congestion.vtc
** s1 2.5 Waiting for server (4/-1)
** v1 2.5 Wait
**** v1 2.5 CLI TX|panic.clear
**** v1 2.5 vsl| 0 CLI - Rd debug.xid 999
**** v1 2.5 vsl| 0 CLI - Wr 200 10 XID is 999
**** v1 2.5 vsl| 0 CLI - Rd debug.listen_address
**** v1 2.5 vsl| 0 CLI - Wr 200 16 127.0.0.1 38385
**** v1 2.5 vsl| 1000 Begin c sess 0 HTTP/1
**** v1 2.5 vsl| 1000 SessOpen c 127.0.0.1 39970 a0 127.0.0.1 38385 1571803980.304330 22
**** v1 2.5 vsl| 1000 Link c req 1001 rxreq
**** v1 2.5 vsl| 0 ExpKill - EXP_Inbox flg=1e p=0x556d43aa73c0 e=0.000000 f=0x0
**** v1 2.5 vsl| 0 ExpKill - EXP_When p=0x556d43aa73c0 e=1571804110.308686 f=0x1e
**** v1 2.5 vsl| 0 ExpKill - EXP_expire p=0x556d43aa73c0 e=129.999741 f=0x0
**** v1 2.5 vsl| 1002 Begin b bereq 1001 fetch
**** v1 2.5 vsl| 1002 VCL_use b vcl1
**** v1 2.5 vsl| 1002 Timestamp b Start: 1571803980.304728 0.000000 0.000000
**** v1 2.5 vsl| 1002 BereqMethod b GET
**** v1 2.5 vsl| 1002 BereqURL b /
**** v1 2.5 vsl| 1002 BereqProtocol b HTTP/1.1
**** v1 2.5 vsl| 1002 BereqHeader b Host: 127.0.0.1
**** v1 2.5 vsl| 1002 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 2.5 vsl| 1002 BereqHeader b Accept-Encoding: gzip
**** v1 2.5 vsl| 1002 BereqHeader b X-Varnish: 1002
**** v1 2.5 vsl| 1002 VCL_call b BACKEND_FETCH
**** v1 2.5 vsl| 1002 VCL_return b fetch
**** v1 2.5 vsl| 1002 BackendOpen b 25 vcl1.s1 127.0.0.1 43527 127.0.0.1 50156
**** v1 2.5 vsl| 1002 BackendStart b 127.0.0.1 43527
**** v1 2.5 vsl| 1002 Timestamp b Bereq: 1571803980.305212 0.000484 0.000484
**** v1 2.5 vsl| 1002 Timestamp b Beresp: 1571803980.308686 0.003958 0.003473
**** v1 2.5 vsl| 1002 BerespProtocol b HTTP/1.1
**** v1 2.5 vsl| 1002 BerespStatus b 200
**** v1 2.5 vsl| 1002 BerespReason b OK
**** v1 2.5 vsl| 1002 BerespHeader b Content-Length: 0
**** v1 2.5 vsl| 1002 BerespHeader b Date: Wed, 23 Oct 2019 04:13:00 GMT
**** v1 2.5 vsl| 1002 TTL b RFC 120 10 0 1571803980 1571803980 1571803980 0 0 cacheable
**** v1 2.5 vsl| 1002 VCL_call b BACKEND_RESPONSE
**** v1 2.5 vsl| 1002 VCL_return b deliver
**** v1 2.5 vsl| 1002 Storage b malloc s0
**** v1 2.5 vsl| 1002 Fetch_Body b 0 none -
**** v1 2.5 vsl| 1002 BackendReuse b 25 vcl1.s1
**** v1 2.5 vsl| 1002 Timestamp b BerespBody: 1571803980.320915 0.016188 0.012230
**** v1 2.5 vsl| 1002 Length b 0
**** v1 2.5 vsl| 1002 BereqAcct b 103 0 103 38 0 38
**** v1 2.5 vsl| 1002 End b
**** v1 2.5 vsl| 1001 Begin c req 1000 rxreq
**** v1 2.5 vsl| 1001 Timestamp c Start: 1571803980.304627 0.000000 0.000000
**** v1 2.5 vsl| 1001 Timestamp c Req: 1571803980.304627 0.000000 0.000000
**** v1 2.5 vsl| 1001 ReqStart c 127.0.0.1 39970 a0
**** v1 2.5 vsl| 1001 ReqMethod c GET
**** v1 2.5 vsl| 1001 ReqURL c /
**** v1 2.5 vsl| 1001 ReqProtocol c HTTP/1.1
**** v1 2.5 vsl| 1001 ReqHeader c Host: 127.0.0.1
**** v1 2.5 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 2.5 vsl| 1001 VCL_call c RECV
**** v1 2.5 vsl| 1001 VCL_return c hash
**** v1 2.5 vsl| 1001 VCL_call c HASH
**** v1 2.5 vsl| 1001 VCL_return c lookup
**** v1 2.5 vsl| 1001 VCL_call c MISS
**** v1 2.5 vsl| 1001 VCL_return c fetch
**** v1 2.5 vsl| 1001 Link c bereq 1002 fetch
**** v1 2.5 vsl| 1001 Timestamp c Fetch: 1571803980.321101 0.016475 0.016475
**** v1 2.5 vsl| 1001 RespProtocol c HTTP/1.1
**** v1 2.5 vsl| 1001 RespStatus c 200
**** v1 2.5 vsl| 1001 RespReason c OK
**** v1 2.5 vsl| 1001 RespHeader c Content-Length: 0
**** v1 2.5 vsl| 1001 RespHeader c Date: Wed, 23 Oct 2019 04:13:00 GMT
**** v1 2.5 vsl| 1001 RespHeader c X-Varnish: 1001
**** v1 2.5 vsl| 1001 RespHeader c Age: 0
**** v1 2.5 vsl| 1001 RespHeader c Via: 1.1 varnish (Varnish/6.0)
**** v1 2.5 vsl| 1001 VCL_call c DELIVER
**** v1 2.5 vsl| 1001 RespHeader c a: -1
**** v1 2.5 vsl| 1001 RespHeader c b: -1
**** v1 2.5 vsl| 1001 RespHeader c c: -1
**** v1 2.5 vsl| 1001 VCL_return c deliver
**** v1 2.5 vsl| 1001 Timestamp c Process: 1571803980.321161 0.016534 0.000059
**** v1 2.5 vsl| 1001 RespHeader c Accept-Ranges: bytes
**** v1 2.5 vsl| 1001 RespHeader c Connection: keep-alive
**** v1 2.5 vsl| 1001 Timestamp c Resp: 1571803980.321377 0.016750 0.000216
**** v1 2.5 vsl| 1001 ReqAcct c 35 0 35 199 0 199
**** v1 2.5 vsl| 1001 End c
*** v1 2.5 CLI RX 300
**** v1 2.5 CLI RX|No panic to clear
*** v1 2.5 debug|Info: manager stopping child
*** v1 2.5 debug|Debug: Stopping Child
**** v1 2.6 vsl| 0 CLI - EOF on CLI connection, worker stops
*** v1 3.5 debug|Info: Child (1934) ended
*** v1 3.5 debug|Info: Child (1934) said Child dies
*** v1 3.5 debug|Debug: Child cleanup complete
*** v1 3.5 debug|Info: manager dies
**** v1 3.5 STDOUT poll 0x11
** v1 3.6 WAIT4 pid=1922 status=0x0000 (user 1.220000 sys 0.840000)
* top 3.6 TEST ./tests/tcp/02-congestion.vtc FAILED
* diag 0.0 Linux
# top TEST ./tests/tcp/02-congestion.vtc FAILED (4.025) exit=2
FAIL tests/tcp/02-congestion.vtc (exit status: 2)
Also, I think there's a mistake in README that says you don't need to run bootstrap if using releases archives. You still do.
can you try the 6.0
branch please? master
tracks the varnish-cache master
branch, and API have changed
Thank you, it works on 6.0
branch. I see there are also 6.2
, 6.2
and 6.0-lts
branches. Should I by using LTS?
You can, they're really the same. The idea is to have one branch for each supported package cloud version, but it would have been weird to have a 6.0-lts without a 6.0, so there's both.
On Tue, Oct 22, 2019, 22:32 Chingis notifications@github.com wrote:
Closed #144 https://github.com/varnish/varnish-modules/issues/144.
— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/varnish/varnish-modules/issues/144?email_source=notifications&email_token=AA42AKP6EAWP7QPIQDQPPJDQP7OX7A5CNFSM4JDMHYDKYY3PNVWWK3TUL52HS4DFWZEXG43VMVCXMZLOORHG65DJMZUWGYLUNFXW5KTDN5WW2ZLOORPWSZGOUMHQAKY#event-2735669291, or unsubscribe https://github.com/notifications/unsubscribe-auth/AA42AKJABXAZUN7VKHVND3DQP7OX7ANCNFSM4JDMHYDA .
I've recently started to get the following error when compiling on Alpine Linux (3.9 and 3.10).
Full log: