Page MenuHomePhabricator
Paste P13041

635302-upload-vtc-err.log
ActivePublic

Authored by ema on Oct 21 2020, 8:31 AM.
# top TEST upload/01-basic-caching.vtc passed (2.630)
# top TEST upload/02-unset-xrange.vtc passed (2.541)
# top TEST upload/05-range-requests.vtc passed (2.944)
# top TEST upload/06-range-requests-convert-into-pass.vtc passed (2.664)
# top TEST upload/08-frontend-cors.vtc passed (2.486)
# top TEST upload/09-frontend-homepage-commons-redirect.vtc passed (2.470)
# top TEST upload/10-frontend-deliver.vtc passed (2.460)
# top TEST upload/11-frontend-no-external-resources.vtc passed (2.416)
# top TEST upload/12-no-cookies.vtc passed (2.399)
# top TEST upload/15-x-cache-status.vtc passed (2.758)
**** top 0.0 extmacro def pwd=/vagrant
**** top 0.0 extmacro def cc_command=exec gcc -std=gnu99 -g -O2 -fstack-protector-strong -Wformat -Werror=format-security -Wall -pthread -fpic -shared -Wl,-x -o %o %s -lmaxminddb
**** top 0.0 extmacro def basepath=/vagrant
**** top 0.0 extmacro def vcl_path=/vagrant/usr/share/varnish/tests:/vagrant/etc/varnish
**** top 0.0 extmacro def localhost=127.0.0.1
**** top 0.0 extmacro def bad_backend=127.0.0.1 38217
**** top 0.0 extmacro def bad_ip=192.0.2.255
**** top 0.0 macro def testdir=/vagrant/upload
**** top 0.0 macro def tmpdir=/tmp/vtc.5265.05cb9514
* top 0.0 TEST upload/16-x-connection-properties.vtc starting
** top 0.0 === varnishtest "X-Connection-Properties"
* top 0.0 TEST X-Connection-Properties
** 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=37055
**** s1 0.0 macro def s1_sock=127.0.0.1 37055
* s1 0.0 Listen on 127.0.0.1 37055
** top 0.0 === varnish v1 -arg "-p vcl_path=${vcl_path} -p vcc_err_unref=fa...
** s1 0.0 Started on 127.0.0.1 37055 (1 iterations)
** v1 0.0 Launch
*** v1 0.0 CMD: cd ${pwd} && exec varnishd -d -n /tmp/vtc.5265.05cb9514/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 43217' -P /tmp/vtc.5265.05cb9514/v1/varnishd.pid -p vcl_path=/vagrant/usr/share/varnish/tests:/vagrant/etc/varnish -p vcc_err_unref=false -p vcc_allow_inline_c=true -p cc_command='exec gcc -std=gnu99 -g -O2 -fstack-protector-strong -Wformat -Werror=format-security -Wall -pthread -fpic -shared -Wl,-x -o %o %s -lmaxminddb'
*** v1 0.0 CMD: cd /vagrant && exec varnishd -d -n /tmp/vtc.5265.05cb9514/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 43217' -P /tmp/vtc.5265.05cb9514/v1/varnishd.pid -p vcl_path=/vagrant/usr/share/varnish/tests:/vagrant/etc/varnish -p vcc_err_unref=false -p vcc_allow_inline_c=true -p cc_command='exec gcc -std=gnu99 -g -O2 -fstack-protector-strong -Wformat -Werror=format-security -Wall -pthread -fpic -shared -Wl,-x -o %o %s -lmaxminddb'
*** v1 0.0 PID: 5878
**** v1 0.0 macro def v1_pid=5878
**** v1 0.0 macro def v1_name=/tmp/vtc.5265.05cb9514/v1
*** v1 0.0 debug|Debug: Version: varnish-6.0.6 revision 29a1a8243dbef3d973aec28dc90403188c1dc8e7
*** v1 0.0 debug|Debug: Platform: Linux,4.19.0-9-amd64,x86_64,-junix,-sdefault,-sdefault,-hcritbit
*** v1 0.0 debug|200 315
*** v1 0.0 debug|-----------------------------
*** v1 0.0 debug|Varnish Cache CLI 1.0
*** v1 0.0 debug|-----------------------------
*** v1 0.0 debug|Linux,4.19.0-9-amd64,x86_64,-junix,-sdefault,-sdefault,-hcritbit
*** v1 0.0 debug|varnish-6.0.6 revision 29a1a8243dbef3d973aec28dc90403188c1dc8e7
*** v1 0.0 debug|
*** v1 0.0 debug|Type 'help' for command list.
*** v1 0.0 debug|Type 'quit' to close CLI session.
*** v1 0.0 debug|Type 'start' to launch worker process.
*** v1 0.0 debug|
**** v1 0.1 CLIPOLL 1 0x1 0x0
*** v1 0.1 CLI connection fd = 7
*** v1 0.1 CLI RX 107
**** v1 0.1 CLI RX|sdejpqvjnhwrsgrjfuqrzqbehuoozpyb
**** v1 0.1 CLI RX|
**** v1 0.1 CLI RX|Authentication required.
**** v1 0.1 CLI TX|auth c4b1f09e8aac9578bbc9a2c08128053683e42707eb3a2efc0dff8f7c201fc6b9
*** v1 0.1 CLI RX 200
**** v1 0.1 CLI RX|-----------------------------
**** v1 0.1 CLI RX|Varnish Cache CLI 1.0
**** v1 0.1 CLI RX|-----------------------------
**** v1 0.1 CLI RX|Linux,4.19.0-9-amd64,x86_64,-junix,-sdefault,-sdefault,-hcritbit
**** v1 0.1 CLI RX|varnish-6.0.6 revision 29a1a8243dbef3d973aec28dc90403188c1dc8e7
**** v1 0.1 CLI RX|
**** v1 0.1 CLI RX|Type 'help' for command list.
**** v1 0.1 CLI RX|Type 'quit' to close CLI session.
**** v1 0.1 CLI RX|Type 'start' to launch worker process.
**** v1 0.1 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P
**** v1 0.1 CLI TX|vcl 4.1;
**** v1 0.1 CLI TX|backend s1 { .host = "127.0.0.1"; .port = "37055"; }
**** v1 0.1 CLI TX|
**** v1 0.1 CLI TX|
**** v1 0.1 CLI TX| backend vtc_backend {
**** v1 0.1 CLI TX| .host = "127.0.0.1"; .port = "37055";
**** v1 0.1 CLI TX| }
**** v1 0.1 CLI TX|
**** v1 0.1 CLI TX| include "/vagrant/usr/share/varnish/tests/wikimedia_upload-frontend.vcl";
**** v1 0.1 CLI TX|
**** v1 0.1 CLI TX|%XJEIFLH|)Xspa8P
*** v1 0.2 vsl|No VSL chunk found (child not started ?)
*** v1 0.3 vsl|No VSL chunk found (child not started ?)
*** v1 0.4 vsl|No VSL chunk found (child not started ?)
*** v1 0.5 vsl|No VSL chunk found (child not started ?)
*** v1 0.6 vsl|No VSL chunk found (child not started ?)
*** v1 0.8 vsl|No VSL chunk found (child not started ?)
*** v1 0.9 vsl|No VSL chunk found (child not started ?)
*** v1 1.0 vsl|No VSL chunk found (child not started ?)
*** v1 1.0 CLI RX 200
**** v1 1.0 CLI RX|Message from VCC-compiler:
**** v1 1.0 CLI RX|Unused acl public_cloud_nets, defined:
**** v1 1.0 CLI RX|('/vagrant/etc/varnish/blocked-nets.inc.vcl' Line 11 Pos 5)
**** v1 1.0 CLI RX|acl public_cloud_nets {
**** v1 1.0 CLI RX|----#################--
**** v1 1.0 CLI RX|
**** v1 1.0 CLI RX|(That was just a warning)
**** v1 1.0 CLI RX|Unused probe varnish, defined:
**** v1 1.0 CLI RX|('/vagrant/usr/share/varnish/tests/wikimedia_upload-frontend.vcl' Line 81 Pos 7)
**** v1 1.0 CLI RX|probe varnish {
**** v1 1.0 CLI RX|------#######--
**** v1 1.0 CLI RX|
**** v1 1.0 CLI RX|(That was just a warning)
**** v1 1.0 CLI RX|Message from C-compiler:
**** v1 1.0 CLI RX|vgc.c:5135:21: warning: \342\200\230generic_decoder_ring\342\200\231 defined but not used [-Wunused-const-variable=]
**** v1 1.0 CLI RX| static const size_t generic_decoder_ring[256] = {
**** v1 1.0 CLI RX| ^~~~~~~~~~~~~~~~~~~~
**** v1 1.0 CLI RX|vgc.c:4813:39: warning: \342\200\230vgc_probe_varnish\342\200\231 defined but not used [-Wunused-const-variable=]
**** v1 1.0 CLI RX| static const struct vrt_backend_probe vgc_probe_varnish[] = {{
**** v1 1.0 CLI RX| ^~~~~~~~~~~~~~~~~
**** v1 1.0 CLI RX|VCL compiled.
**** v1 1.0 CLI TX|vcl.use vcl1
*** v1 1.0 CLI RX 200
** v1 1.0 Start
**** v1 1.0 CLI TX|start
*** v1 1.0 debug|Debug: Child (5892) Started
*** v1 1.1 CLI RX 200
*** v1 1.1 wait-running
**** v1 1.1 CLI TX|status
*** v1 1.1 debug|Info: Child (5892) said Child starts
*** v1 1.1 CLI RX 200
**** v1 1.1 CLI RX|Child in state running
**** v1 1.1 CLI TX|debug.listen_address
*** v1 1.1 CLI RX 200
**** v1 1.1 CLI RX|127.0.0.1 42117
**** v1 1.1 CLI TX|debug.xid 999
**** v1 1.2 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1603268839.268520/vgc.so 1auto
**** v1 1.2 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1603268839.268520/vgc.so" as "vcl1"
**** v1 1.2 vsl| 0 CLI - Rd vcl.use "vcl1"
**** v1 1.2 vsl| 0 CLI - Wr 200 0
**** v1 1.2 vsl| 0 CLI - Rd start
**** v1 1.2 vsl| 0 CLI - Wr 200 0
**** v1 1.2 vsl| 0 CLI - Rd debug.listen_address
**** v1 1.2 vsl| 0 CLI - Wr 200 16 127.0.0.1 42117
*** v1 1.2 CLI RX 200
**** v1 1.2 CLI RX|XID is 999
**** v1 1.2 CLI TX|debug.listen_address
*** v1 1.2 CLI RX 200
**** v1 1.2 CLI RX|127.0.0.1 42117
** v1 1.2 Listen on 127.0.0.1 42117
**** v1 1.2 macro def v1_addr=127.0.0.1
**** v1 1.2 macro def v1_port=42117
**** v1 1.2 macro def v1_sock=127.0.0.1 42117
** top 1.2 === client c1 {
** c1 1.2 Starting client
** c1 1.2 Waiting for client
*** c1 1.2 Connect to 127.0.0.1 42117
*** c1 1.2 connected fd 17 from 127.0.0.1 42342 to 127.0.0.1 42117
** c1 1.2 === txreq -url "/1" -hdr "X-Forwarded-Proto: https" -hdr "Host: ...
**** c1 1.2 txreq|GET /1 HTTP/1.1\r
**** c1 1.2 txreq|X-Forwarded-Proto: https\r
**** c1 1.2 txreq|Host: upload.wikimedia.org\r
**** c1 1.2 txreq|X-Connection-Properties: H2=0; SSR=0; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=prime256v1;\r
**** c1 1.2 txreq|\r
** c1 1.2 === rxresp
*** s1 1.2 accepted fd 5 127.0.0.1 56266
** s1 1.2 === rxreq
**** s1 1.2 rxhdr|GET /1 HTTP/1.1\r
**** s1 1.2 rxhdr|X-Forwarded-Proto: https\r
**** s1 1.2 rxhdr|X-Connection-Properties: H2=0; SSR=0; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=prime256v1;\r
**** s1 1.2 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 1.2 rxhdr|X-Client-IP: 127.0.0.1\r
**** s1 1.2 rxhdr|x-tls-prot: h1\r
**** s1 1.2 rxhdr|x-tls-sess: new\r
**** s1 1.2 rxhdr|x-tls-vers: TLSv1.2\r
**** s1 1.2 rxhdr|x-tls-keyx: prime256v1\r
**** s1 1.2 rxhdr|x-tls-auth: ECDSA\r
**** s1 1.2 rxhdr|x-tls-ciph: AES256-GCM-SHA384\r
**** s1 1.2 rxhdr|Host: upload.wikimedia.org\r
**** s1 1.2 rxhdr|X-WMF-NOCOOKIES: 1\r
**** s1 1.2 rxhdr|X-CDIS: miss\r
**** s1 1.2 rxhdr|Accept-Encoding: gzip\r
**** s1 1.2 rxhdr|X-Varnish: 1002\r
**** s1 1.2 rxhdr|\r
**** s1 1.2 rxhdrlen = 427
**** s1 1.2 http[ 0] |GET
**** s1 1.2 http[ 1] |/1
**** s1 1.2 http[ 2] |HTTP/1.1
**** s1 1.2 http[ 3] |X-Forwarded-Proto: https
**** s1 1.2 http[ 4] |X-Connection-Properties: H2=0; SSR=0; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=prime256v1;
**** s1 1.2 http[ 5] |X-Forwarded-For: 127.0.0.1
**** s1 1.2 http[ 6] |X-Client-IP: 127.0.0.1
**** s1 1.2 http[ 7] |x-tls-prot: h1
**** s1 1.2 http[ 8] |x-tls-sess: new
**** s1 1.2 http[ 9] |x-tls-vers: TLSv1.2
**** s1 1.2 http[10] |x-tls-keyx: prime256v1
**** s1 1.2 http[11] |x-tls-auth: ECDSA
**** s1 1.2 http[12] |x-tls-ciph: AES256-GCM-SHA384
**** s1 1.2 http[13] |Host: upload.wikimedia.org
**** s1 1.2 http[14] |X-WMF-NOCOOKIES: 1
**** s1 1.2 http[15] |X-CDIS: miss
**** s1 1.2 http[16] |Accept-Encoding: gzip
**** s1 1.2 http[17] |X-Varnish: 1002
**** s1 1.2 bodylen = 0
** s1 1.2 === expect req.url == "/1"
**** s1 1.2 EXPECT req.url (/1) == "/1" match
** s1 1.2 === expect req.http.x-tls-prot == "h1"
**** s1 1.2 EXPECT req.http.x-tls-prot (h1) == "h1" match
** s1 1.2 === expect req.http.x-tls-vers == "TLSv1.2"
**** s1 1.2 EXPECT req.http.x-tls-vers (TLSv1.2) == "TLSv1.2" match
** s1 1.2 === expect req.http.x-tls-sess == "new"
**** s1 1.2 EXPECT req.http.x-tls-sess (new) == "new" match
** s1 1.2 === expect req.http.x-tls-keyx == "prime256v1"
**** s1 1.2 EXPECT req.http.x-tls-keyx (prime256v1) == "prime256v1" match
** s1 1.2 === expect req.http.x-tls-auth == "ECDSA"
**** s1 1.2 EXPECT req.http.x-tls-auth (ECDSA) == "ECDSA" match
** s1 1.2 === expect req.http.x-tls-ciph == "AES256-GCM-SHA384"
**** s1 1.2 EXPECT req.http.x-tls-ciph (AES256-GCM-SHA384) == "AES256-GCM-SHA384" match
** s1 1.2 === txresp
**** s1 1.2 txresp|HTTP/1.1 200 OK\r
**** s1 1.2 txresp|Content-Length: 0\r
**** s1 1.2 txresp|\r
** s1 1.2 === rxreq
**** c1 1.2 rxhdr|HTTP/1.1 200 OK\r
**** c1 1.2 rxhdr|Content-Length: 0\r
**** c1 1.2 rxhdr|Date: Wed, 21 Oct 2020 08:27:20 GMT\r
**** c1 1.2 rxhdr|X-Varnish: 1001\r
**** c1 1.2 rxhdr|Age: 0\r
**** c1 1.2 rxhdr|X-Cache: cp3061 miss\r
**** c1 1.2 rxhdr|X-Cache-Status: miss\r
**** c1 1.2 rxhdr|Server-Timing: cache;desc="miss"\r
**** c1 1.2 rxhdr|Strict-Transport-Security: max-age=106384710; includeSubDomains; preload\r
**** c1 1.2 rxhdr|Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }\r
**** c1 1.2 rxhdr|NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}\r
**** c1 1.2 rxhdr|X-Analytics: https=1;nocookies=1\r
**** c1 1.2 rxhdr|X-Client-IP: 127.0.0.1\r
**** c1 1.2 rxhdr|Access-Control-Allow-Origin: *\r
**** c1 1.2 rxhdr|Access-Control-Expose-Headers: Age, Date, Content-Length, Content-Range, X-Content-Duration, X-Cache\r
**** c1 1.2 rxhdr|Timing-Allow-Origin: *\r
**** c1 1.2 rxhdr|Accept-Ranges: bytes\r
**** c1 1.2 rxhdr|Connection: keep-alive\r
**** c1 1.2 rxhdr|\r
**** c1 1.2 rxhdrlen = 829
**** c1 1.2 http[ 0] |HTTP/1.1
**** c1 1.2 http[ 1] |200
**** c1 1.2 http[ 2] |OK
**** c1 1.2 http[ 3] |Content-Length: 0
**** c1 1.2 http[ 4] |Date: Wed, 21 Oct 2020 08:27:20 GMT
**** c1 1.2 http[ 5] |X-Varnish: 1001
**** c1 1.2 http[ 6] |Age: 0
**** c1 1.2 http[ 7] |X-Cache: cp3061 miss
**** c1 1.2 http[ 8] |X-Cache-Status: miss
**** c1 1.2 http[ 9] |Server-Timing: cache;desc="miss"
**** c1 1.2 http[10] |Strict-Transport-Security: max-age=106384710; includeSubDomains; preload
**** c1 1.2 http[11] |Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }
**** c1 1.2 http[12] |NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}
**** c1 1.2 http[13] |X-Analytics: https=1;nocookies=1
**** c1 1.2 http[14] |X-Client-IP: 127.0.0.1
**** c1 1.2 http[15] |Access-Control-Allow-Origin: *
**** c1 1.2 http[16] |Access-Control-Expose-Headers: Age, Date, Content-Length, Content-Range, X-Content-Duration, X-Cache
**** c1 1.2 http[17] |Timing-Allow-Origin: *
**** c1 1.2 http[18] |Accept-Ranges: bytes
**** c1 1.2 http[19] |Connection: keep-alive
**** c1 1.2 bodylen = 0
** c1 1.2 === txreq -url "/2" -hdr "X-Forwarded-Proto: https" -hdr "Host: ...
**** c1 1.2 txreq|GET /2 HTTP/1.1\r
**** c1 1.2 txreq|X-Forwarded-Proto: https\r
**** c1 1.2 txreq|Host: upload.wikimedia.org\r
**** c1 1.2 txreq|X-Connection-Properties: H2=0; SSR=1; SSL=TLSv1.2; C=ECDHE-ECDSA-AES128-SHA; EC=prime256v1;\r
**** c1 1.2 txreq|\r
** c1 1.2 === rxresp
**** c1 1.2 rxhdr|HTTP/1.1 302 Browser Connection Security Redirect\r
**** c1 1.2 rxhdr|Date: Wed, 21 Oct 2020 08:27:20 GMT\r
**** c1 1.2 rxhdr|Server: Varnish\r
**** c1 1.2 rxhdr|X-Varnish: 1003\r
**** c1 1.2 rxhdr|X-Cache: cp3061 int\r
**** c1 1.2 rxhdr|X-Cache-Status: int-front\r
**** c1 1.2 rxhdr|Server-Timing: cache;desc="int-front"\r
**** c1 1.2 rxhdr|Strict-Transport-Security: max-age=106384710; includeSubDomains; preload\r
**** c1 1.2 rxhdr|Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }\r
**** c1 1.2 rxhdr|NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}\r
**** c1 1.2 rxhdr|Set-Cookie: WMF-Last-Access=21-Oct-2020;Path=/;HttpOnly;secure;Expires=Sun, 22 Nov 2020 00:00:00 GMT\r
**** c1 1.2 rxhdr|X-Analytics: https=1;nocookies=1\r
**** c1 1.2 rxhdr|X-Client-IP: 127.0.0.1\r
**** c1 1.2 rxhdr|Location: https://upload.wikimedia.org/sec-warning\r
**** c1 1.2 rxhdr|Content-Length: 0\r
**** c1 1.2 rxhdr|Connection: keep-alive\r
**** c1 1.2 rxhdr|\r
**** c1 1.2 rxhdrlen = 855
**** c1 1.2 http[ 0] |HTTP/1.1
**** c1 1.2 http[ 1] |302
**** c1 1.2 http[ 2] |Browser Connection Security Redirect
**** c1 1.2 http[ 3] |Date: Wed, 21 Oct 2020 08:27:20 GMT
**** c1 1.2 http[ 4] |Server: Varnish
**** c1 1.2 http[ 5] |X-Varnish: 1003
**** c1 1.2 http[ 6] |X-Cache: cp3061 int
**** c1 1.2 http[ 7] |X-Cache-Status: int-front
**** c1 1.2 http[ 8] |Server-Timing: cache;desc="int-front"
**** c1 1.2 http[ 9] |Strict-Transport-Security: max-age=106384710; includeSubDomains; preload
**** c1 1.2 http[10] |Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }
**** c1 1.2 http[11] |NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}
**** c1 1.2 http[12] |Set-Cookie: WMF-Last-Access=21-Oct-2020;Path=/;HttpOnly;secure;Expires=Sun, 22 Nov 2020 00:00:00 GMT
**** c1 1.2 http[13] |X-Analytics: https=1;nocookies=1
**** c1 1.2 http[14] |X-Client-IP: 127.0.0.1
**** c1 1.2 http[15] |Location: https://upload.wikimedia.org/sec-warning
**** c1 1.2 http[16] |Content-Length: 0
**** c1 1.2 http[17] |Connection: keep-alive
**** c1 1.2 bodylen = 0
** c1 1.2 === txreq -url "/3" -hdr "X-Forwarded-Proto: https" -hdr "Host: ...
**** c1 1.2 txreq|GET /3 HTTP/1.1\r
**** c1 1.2 txreq|X-Forwarded-Proto: https\r
**** c1 1.2 txreq|Host: upload.wikimedia.org\r
**** c1 1.2 txreq|X-Connection-Properties: H2=1; SSR=1; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=X25519;\r
**** c1 1.2 txreq|\r
** c1 1.2 === rxresp
**** s1 1.2 rxhdr|GET /3 HTTP/1.1\r
**** s1 1.2 rxhdr|X-Forwarded-Proto: https\r
**** s1 1.2 rxhdr|X-Connection-Properties: H2=1; SSR=1; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=X25519;\r
**** s1 1.2 rxhdr|X-Forwarded-For: 127.0.0.1\r
**** s1 1.2 rxhdr|X-Client-IP: 127.0.0.1\r
**** s1 1.2 rxhdr|x-tls-prot: h2\r
**** s1 1.2 rxhdr|x-tls-sess: reused\r
**** s1 1.2 rxhdr|x-tls-vers: TLSv1.2\r
**** s1 1.2 rxhdr|x-tls-keyx: X25519\r
**** s1 1.2 rxhdr|x-tls-auth: ECDSA\r
**** s1 1.2 rxhdr|x-tls-ciph: AES256-GCM-SHA384\r
**** s1 1.2 rxhdr|Host: upload.wikimedia.org\r
**** s1 1.2 rxhdr|X-WMF-NOCOOKIES: 1\r
**** s1 1.2 rxhdr|X-CDIS: miss\r
**** s1 1.2 rxhdr|Accept-Encoding: gzip\r
**** s1 1.2 rxhdr|X-Varnish: 1005\r
**** s1 1.2 rxhdr|\r
**** s1 1.2 rxhdrlen = 422
**** s1 1.2 http[ 0] |GET
**** s1 1.2 http[ 1] |/3
**** s1 1.2 http[ 2] |HTTP/1.1
**** s1 1.2 http[ 3] |X-Forwarded-Proto: https
**** s1 1.2 http[ 4] |X-Connection-Properties: H2=1; SSR=1; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=X25519;
**** s1 1.2 http[ 5] |X-Forwarded-For: 127.0.0.1
**** s1 1.2 http[ 6] |X-Client-IP: 127.0.0.1
**** s1 1.2 http[ 7] |x-tls-prot: h2
**** s1 1.2 http[ 8] |x-tls-sess: reused
**** s1 1.2 http[ 9] |x-tls-vers: TLSv1.2
**** s1 1.2 http[10] |x-tls-keyx: X25519
**** s1 1.2 http[11] |x-tls-auth: ECDSA
**** s1 1.2 http[12] |x-tls-ciph: AES256-GCM-SHA384
**** s1 1.2 http[13] |Host: upload.wikimedia.org
**** s1 1.2 http[14] |X-WMF-NOCOOKIES: 1
**** s1 1.2 http[15] |X-CDIS: miss
**** s1 1.2 http[16] |Accept-Encoding: gzip
**** s1 1.2 http[17] |X-Varnish: 1005
**** s1 1.2 bodylen = 0
** s1 1.2 === expect req.url == "/2"
---- s1 1.2 EXPECT req.url (/3) == "/2" failed
**** v1 1.3 vsl| 0 CLI - Rd debug.xid 999
**** v1 1.3 vsl| 0 CLI - Wr 200 10 XID is 999
**** v1 1.3 vsl| 0 CLI - Rd debug.listen_address
**** v1 1.3 vsl| 0 CLI - Wr 200 16 127.0.0.1 42117
**** v1 1.3 vsl| 1000 Begin c sess 0 HTTP/1
**** v1 1.3 vsl| 1000 SessOpen c 127.0.0.1 42342 a0 127.0.0.1 42117 1603268840.346320 23
**** v1 1.3 vsl| 1000 Link c req 1001 rxreq
**** v1 1.3 vsl| 0 ExpKill - EXP_Inbox flg=1e p=0x7ff006810000 e=0.000000 f=0x4
**** v1 1.3 vsl| 0 ExpKill - EXP_When p=0x7ff006810000 e=1603269440.350898 f=0x1e
**** v1 1.3 vsl| 0 ExpKill - EXP_expire p=0x7ff006810000 e=599.999375 f=0x4
**** v1 1.3 vsl| 1002 Begin b bereq 1001 fetch
**** v1 1.3 vsl| 1002 VCL_use b vcl1
**** v1 1.3 vsl| 1002 Timestamp b Start: 1603268840.346894 0.000000 0.000000
**** v1 1.3 vsl| 1002 BereqMethod b GET
**** v1 1.3 vsl| 1002 BereqURL b /1
**** v1 1.3 vsl| 1002 BereqProtocol b HTTP/1.1
**** v1 1.3 vsl| 1002 BereqHeader b X-Forwarded-Proto: https
**** v1 1.3 vsl| 1002 BereqHeader b X-Connection-Properties: H2=0; SSR=0; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=prime256v1;
**** v1 1.3 vsl| 1002 BereqHeader b X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1002 BereqHeader b X-Client-IP: 127.0.0.1
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-prot: h1
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-sess: new
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-vers: TLSv1.2
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-keyx: prime256v1
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-auth: ECDSA
**** v1 1.3 vsl| 1002 BereqHeader b x-tls-ciph: AES256-GCM-SHA384
**** v1 1.3 vsl| 1002 BereqHeader b Host: upload.wikimedia.org
**** v1 1.3 vsl| 1002 BereqHeader b X-WMF-NOCOOKIES: 1
**** v1 1.3 vsl| 1002 BereqHeader b X-CDIS: miss
**** v1 1.3 vsl| 1002 BereqHeader b Accept-Encoding: gzip
**** v1 1.3 vsl| 1002 BereqHeader b X-Varnish: 1002
**** v1 1.3 vsl| 1002 VCL_call b BACKEND_FETCH
**** v1 1.3 vsl| 1002 VCL_return b fetch
**** v1 1.3 vsl| 1002 BackendOpen b 26 vcl1.vtc_backend 127.0.0.1 37055 127.0.0.1 56266
**** v1 1.3 vsl| 1002 BackendStart b 127.0.0.1 37055
**** v1 1.3 vsl| 1002 Timestamp b Bereq: 1603268840.347254 0.000360 0.000360
**** v1 1.3 vsl| 1002 Timestamp b Beresp: 1603268840.350898 0.004004 0.003644
**** v1 1.3 vsl| 1002 BerespProtocol b HTTP/1.1
**** v1 1.3 vsl| 1002 BerespStatus b 200
**** v1 1.3 vsl| 1002 BerespReason b OK
**** v1 1.3 vsl| 1002 BerespHeader b Content-Length: 0
**** v1 1.3 vsl| 1002 BerespHeader b Date: Wed, 21 Oct 2020 08:27:20 GMT
**** v1 1.3 vsl| 1002 TTL b RFC 120 10 0 1603268840 1603268840 1603268840 0 0 cacheable
**** v1 1.3 vsl| 1002 VCL_call b BACKEND_RESPONSE
**** v1 1.3 vsl| 1002 TTL b VCL 120 1200 0 1603268840 cacheable
**** v1 1.3 vsl| 1002 TTL b VCL 116 1200 0 1603268840 cacheable
**** v1 1.3 vsl| 1002 TTL b VCL 600 1200 0 1603268840 cacheable
**** v1 1.3 vsl| 1002 TTL b VCL 600 0 0 1603268840 cacheable
**** v1 1.3 vsl| 1002 TTL b VCL 600 0 0 1603268840 cacheable
**** v1 1.3 vsl| 1002 TTL b VCL 600 0 0 1603268840 uncacheable
**** v1 1.3 vsl| 1002 VCL_return b deliver
**** v1 1.3 vsl| 1002 Storage b malloc Transient
**** v1 1.3 vsl| 1002 Fetch_Body b 0 none -
**** v1 1.3 vsl| 1002 BackendReuse b 26 vcl1.vtc_backend
**** v1 1.3 vsl| 1002 Timestamp b BerespBody: 1603268840.361881 0.014987 0.010983
**** v1 1.3 vsl| 1002 Length b 0
**** v1 1.3 vsl| 1002 BereqAcct b 427 0 427 38 0 38
**** v1 1.3 vsl| 1002 End b
**** v1 1.3 vsl| 1001 Begin c req 1000 rxreq
**** v1 1.3 vsl| 1001 Timestamp c Start: 1603268840.346485 0.000000 0.000000
**** v1 1.3 vsl| 1001 Timestamp c Req: 1603268840.346485 0.000000 0.000000
**** v1 1.3 vsl| 1001 ReqStart c 127.0.0.1 42342 a0
**** v1 1.3 vsl| 1001 ReqMethod c GET
**** v1 1.3 vsl| 1001 ReqURL c /1
**** v1 1.3 vsl| 1001 ReqProtocol c HTTP/1.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Forwarded-Proto: https
**** v1 1.3 vsl| 1001 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1001 ReqHeader c X-Connection-Properties: H2=0; SSR=0; SSL=TLSv1.2; C=ECDHE-ECDSA-AES256-GCM-SHA384; EC=prime256v1;
**** v1 1.3 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 VCL_call c RECV
**** v1 1.3 vsl| 1001 VCL_acl c MATCH wikimedia_trust "127.0.0.0"/8
**** v1 1.3 vsl| 1001 VCL_acl c MATCH local_host "127.0.0.1"
**** v1 1.3 vsl| 1001 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Client-IP: 127.0.0.1
**** v1 1.3 vsl| 1001 ReqHeader c X-Trusted-Proxy:
**** v1 1.3 vsl| 1001 ReqUnset c X-Trusted-Proxy:
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-prot: 0
**** v1 1.3 vsl| 1001 ReqUnset c x-tls-prot: 0
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-prot: h1
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-sess: 0
**** v1 1.3 vsl| 1001 ReqUnset c x-tls-sess: 0
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-sess: new
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-vers: TLSv1.2
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-keyx: prime256v1
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-auth: ECDHE-ECDSA-AES256-GCM-SHA384
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-ciph: AES256-GCM-SHA384
**** v1 1.3 vsl| 1001 ReqUnset c x-tls-auth: ECDHE-ECDSA-AES256-GCM-SHA384
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-auth: ECDSA
**** v1 1.3 vsl| 1001 ReqUnset c x-tls-ciph: AES256-GCM-SHA384
**** v1 1.3 vsl| 1001 ReqHeader c x-tls-ciph: AES256-GCM-SHA384
**** v1 1.3 vsl| 1001 VCL_Log c tls: vers=TLSv1.2;keyx=prime256v1;auth=ECDSA;ciph=AES256-GCM-SHA384;prot=h1;sess=new
**** v1 1.3 vsl| 1001 VCL_acl c NO_MATCH blocked_nets
**** v1 1.3 vsl| 1001 VCL_acl c NO_MATCH bot_blocked_nets
**** v1 1.3 vsl| 1001 ReqUnset c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1001 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1001 ReqUnset c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1001 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1001 ReqHeader c X-WMF-NOCOOKIES: 1
**** v1 1.3 vsl| 1001 ReqURL c /1
**** v1 1.3 vsl| 1001 ReqURL c /1
**** v1 1.3 vsl| 1001 VCL_return c hash
**** v1 1.3 vsl| 1001 VCL_call c HASH
**** v1 1.3 vsl| 1001 VCL_return c lookup
**** v1 1.3 vsl| 1001 VCL_call c MISS
**** v1 1.3 vsl| 1001 ReqHeader c X-CDIS: miss
**** v1 1.3 vsl| 1001 VCL_acl c MATCH wikimedia_nets "127.0.0.0"/8
**** v1 1.3 vsl| 1001 VCL_return c fetch
**** v1 1.3 vsl| 1001 Link c bereq 1002 fetch
**** v1 1.3 vsl| 1001 Timestamp c Fetch: 1603268840.362041 0.015555 0.015555
**** v1 1.3 vsl| 1001 RespProtocol c HTTP/1.1
**** v1 1.3 vsl| 1001 RespStatus c 200
**** v1 1.3 vsl| 1001 RespReason c OK
**** v1 1.3 vsl| 1001 RespHeader c Content-Length: 0
**** v1 1.3 vsl| 1001 RespHeader c Date: Wed, 21 Oct 2020 08:27:20 GMT
**** v1 1.3 vsl| 1001 RespHeader c X-Varnish: 1001
**** v1 1.3 vsl| 1001 RespHeader c Age: 0
**** v1 1.3 vsl| 1001 RespHeader c Via: 1.1 varnish (Varnish/6.0)
**** v1 1.3 vsl| 1001 VCL_call c DELIVER
**** v1 1.3 vsl| 1001 RespHeader c X-Cache-Int: cp3061 miss
**** v1 1.3 vsl| 1001 RespHeader c X-Cache: cp3061 miss
**** v1 1.3 vsl| 1001 RespHeader c X-Cache-Status: miss
**** v1 1.3 vsl| 1001 RespUnset c X-Cache-Int: cp3061 miss
**** v1 1.3 vsl| 1001 RespUnset c Via: 1.1 varnish (Varnish/6.0)
**** v1 1.3 vsl| 1001 RespUnset c X-Cache-Status: miss
**** v1 1.3 vsl| 1001 RespHeader c X-Cache-Status: miss
**** v1 1.3 vsl| 1001 RespHeader c Server-Timing: cache;desc="miss"
**** v1 1.3 vsl| 1001 RespHeader c Strict-Transport-Security: max-age=106384710; includeSubDomains; preload
**** v1 1.3 vsl| 1001 RespHeader c Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }
**** v1 1.3 vsl| 1001 RespHeader c NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}
**** v1 1.3 vsl| 1001 RespHeader c X-Analytics:
**** v1 1.3 vsl| 1001 ReqHeader c X-NowDay: 21-Oct-2020
**** v1 1.3 vsl| 1001 RespHeader c Set-Cookie: WMF-Last-Access=21-Oct-2020;Path=/;HttpOnly;secure;Expires=Sun, 22 Nov 2020 00:00:00 GMT
**** v1 1.3 vsl| 1001 RespUnset c X-Analytics:
**** v1 1.3 vsl| 1001 RespHeader c X-Analytics: ;https=1
**** v1 1.3 vsl| 1001 RespUnset c X-Analytics: ;https=1
**** v1 1.3 vsl| 1001 RespHeader c X-Analytics: ;https=1;nocookies=1
**** v1 1.3 vsl| 1001 RespUnset c X-Analytics: ;https=1;nocookies=1
**** v1 1.3 vsl| 1001 RespHeader c X-Analytics: https=1;nocookies=1
**** v1 1.3 vsl| 1001 RespHeader c X-Client-IP: 127.0.0.1
**** v1 1.3 vsl| 1001 RespUnset c Set-Cookie: WMF-Last-Access=21-Oct-2020;Path=/;HttpOnly;secure;Expires=Sun, 22 Nov 2020 00:00:00 GMT
**** v1 1.3 vsl| 1001 RespHeader c Access-Control-Allow-Origin: *
**** v1 1.3 vsl| 1001 RespHeader c Access-Control-Expose-Headers: Age, Date, Content-Length, Content-Range, X-Content-Duration, X-Cache
**** v1 1.3 vsl| 1001 RespHeader c Timing-Allow-Origin: *
**** v1 1.3 vsl| 1001 VCL_acl c NO_MATCH fb_nets
**** v1 1.3 vsl| 1001 VCL_return c deliver
**** v1 1.3 vsl| 1001 Timestamp c Process: 1603268840.362220 0.015734 0.000179
**** v1 1.3 vsl| 1001 RespHeader c Accept-Ranges: bytes
**** v1 1.3 vsl| 1001 RespHeader c Connection: keep-alive
**** v1 1.3 vsl| 1001 Timestamp c Resp: 1603268840.362392 0.015907 0.000172
**** v1 1.3 vsl| 1001 ReqAcct c 173 0 173 829 0 829
**** v1 1.3 vsl| 1001 End c
**** v1 1.3 vsl| 1000 Link c req 1003 rxreq
**** v1 1.3 vsl| 1003 Begin c req 1000 rxreq
**** v1 1.3 vsl| 1003 Timestamp c Start: 1603268840.367745 0.000000 0.000000
**** v1 1.3 vsl| 1003 Timestamp c Req: 1603268840.367745 0.000000 0.000000
**** v1 1.3 vsl| 1003 ReqStart c 127.0.0.1 42342 a0
**** v1 1.3 vsl| 1003 ReqMethod c GET
**** v1 1.3 vsl| 1003 ReqURL c /2
**** v1 1.3 vsl| 1003 ReqProtocol c HTTP/1.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Forwarded-Proto: https
**** v1 1.3 vsl| 1003 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1003 ReqHeader c X-Connection-Properties: H2=0; SSR=1; SSL=TLSv1.2; C=ECDHE-ECDSA-AES128-SHA; EC=prime256v1;
**** v1 1.3 vsl| 1003 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 VCL_call c RECV
**** v1 1.3 vsl| 1003 VCL_acl c MATCH wikimedia_trust "127.0.0.0"/8
**** v1 1.3 vsl| 1003 VCL_acl c MATCH local_host "127.0.0.1"
**** v1 1.3 vsl| 1003 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqUnset c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Forwarded-For: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Client-IP: 127.0.0.1
**** v1 1.3 vsl| 1003 ReqHeader c X-Trusted-Proxy:
**** v1 1.3 vsl| 1003 ReqUnset c X-Trusted-Proxy:
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-prot: 0
**** v1 1.3 vsl| 1003 ReqUnset c x-tls-prot: 0
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-prot: h1
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-sess: 1
**** v1 1.3 vsl| 1003 ReqUnset c x-tls-sess: 1
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-sess: reused
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-vers: TLSv1.2
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-keyx: prime256v1
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-auth: ECDHE-ECDSA-AES128-SHA
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-ciph: AES128-SHA
**** v1 1.3 vsl| 1003 ReqUnset c x-tls-auth: ECDHE-ECDSA-AES128-SHA
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-auth: ECDSA
**** v1 1.3 vsl| 1003 ReqUnset c x-tls-ciph: AES128-SHA
**** v1 1.3 vsl| 1003 ReqHeader c x-tls-ciph: AES128-SHA
**** v1 1.3 vsl| 1003 VCL_Log c tls: vers=TLSv1.2;keyx=prime256v1;auth=ECDSA;ciph=AES128-SHA;prot=h1;sess=reused
**** v1 1.3 vsl| 1003 VCL_acl c NO_MATCH blocked_nets
**** v1 1.3 vsl| 1003 VCL_acl c NO_MATCH bot_blocked_nets
**** v1 1.3 vsl| 1003 ReqUnset c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1003 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1003 ReqUnset c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1003 ReqHeader c Host: upload.wikimedia.org
**** v1 1.3 vsl| 1003 ReqHeader c X-WMF-NOCOOKIES: 1
**** v1 1.3 vsl| 1003 ReqHeader c Location: https://upload.wikimedia.org/sec-warning
**** v1 1.3 vsl| 1003 VCL_return c synth
**** v1 1.3 vsl| 1003 VCL_call c HASH
**** v1 1.3 vsl| 1003 VCL_return c lookup
**** v1 1.3 vsl| 1003 Timestamp c Process: 1603268840.367820 0.000075 0.000075
**** v1 1.3 vsl| 1003 RespHeader c Date: Wed, 21 Oct 2020 08:27:20 GMT
**** v1 1.3 vsl| 1003 RespHeader c Server: Varnish
**** v1 1.3 vsl| 1003 RespHeader c X-Varnish: 1003
**** v1 1.3 vsl| 1003 RespProtocol c HTTP/1.1
**** v1 1.3 vsl| 1003 RespStatus c 302
**** v1 1.3 vsl| 1003 RespReason c Found
**** v1 1.3 vsl| 1003 RespReason c Browser Connection Security Redirect
**** v1 1.3 vsl| 1003 VCL_call c SYNTH
**** v1 1.3 vsl| 1003 RespHeader c X-CDIS: int
**** v1 1.3 vsl| 1003 ReqHeader c X-CDIS: int
**** v1 1.3 vsl| 1003 RespUnset c X-CDIS: int
**** v1 1.3 vsl| 1003 RespHeader c X-Cache-Int: cp3061 int
**** v1 1.3 vsl| 1003 RespHeader c X-Cache: cp3061 int
**** v1 1.3 vsl| 1003 RespHeader c X-Cache-Status: int
**** v1 1.3 vsl| 1003 RespUnset c X-Cache-Int: cp3061 int
**** v1 1.3 vsl| 1003 RespUnset c X-Cache-Status: int
**** v1 1.3 vsl| 1003 RespHeader c X-Cache-Status: int-front
**** v1 1.3 vsl| 1003 RespHeader c Server-Timing: cache;desc="int-front"
**** v1 1.3 vsl| 1003 RespHeader c Strict-Transport-Security: max-age=106384710; includeSubDomains; preload
**** v1 1.3 vsl| 1003 RespHeader c Report-To: { "group": "wm_nel", "max_age": 86400, "endpoints": [{ "url": "https://intake-logging.wikimedia.org/v1/events?stream=w3c.reportingapi.network_error&schema_uri=/w3c/reportingapi/network_error/1.0.0" }] }
**** v1 1.3 vsl| 1003 RespHeader c NEL: { "report_to": "wm_nel", "max_age": 86400, "failure_fraction": 0.05, "success_fraction": 0.0}
**** v1 1.3 vsl| 1003 RespHeader c X-Analytics:
**** v1 1.3 vsl| 1003 ReqHeader c X-NowDay: 21-Oct-2020
**** v1 1.3 vsl| 1003 RespHeader c Set-Cookie: WMF-Last-Access=21-Oct-2020;Path=/;HttpOnly;secure;Expires=Sun, 22 Nov 2020 00:00:00 GMT
**** v1 1.3 vsl| 1003 RespUnset c X-Analytics:
**** v1 1.3 vsl| 1003 RespHeader c X-Analytics: ;https=1
**** v1 1.3 vsl| 1003 RespUnset c X-Analytics: ;https=1
**** v1 1.3 vsl| 1003 RespHeader c X-Analytics: ;https=1;nocookies=1
**** v1 1.3 vsl| 1003 RespUnset c X-Analytics: ;https=1;nocookies=1
**** v1 1.3 vsl| 1003 RespHeader c X-Analytics: https=1;nocookies=1
**** v1 1.3 vsl| 1003 RespHeader c X-Client-IP: 127.0.0.1
**** v1 1.3 vsl| 1003 RespHeader c Location: https://upload.wikimedia.org/sec-warning
**** v1 1.3 vsl| 1003 RespHeader c Content-Length: 0
**** v1 1.3 vsl| 1003 VCL_return c deliver
**** v1 1.3 vsl| 1003 RespUnset c Content-Length: 0
**** v1 1.3 vsl| 1003 RespHeader c Content-Length: 0
**** v1 1.3 vsl| 1003 Storage c malloc Transient
**** v1 1.3 vsl| 1003 RespHeader c Connection: keep-alive
**** v1 1.3 vsl| 1003 Timestamp c Resp: 1603268840.367912 0.000166 0.000092
**** v1 1.3 vsl| 1003 ReqAcct c 166 0 166 855 0 855
**** v1 1.3 vsl| 1003 End c
**** v1 1.3 vsl| 1000 Link c req 1004 rxreq
**** v1 4.2 vsl| 0 CLI - Rd ping
**** v1 4.2 vsl| 0 CLI - Wr 200 19 PONG 1603268843 1.0
**** v1 7.2 vsl| 0 CLI - Rd ping
**** v1 7.2 vsl| 0 CLI - Wr 200 19 PONG 1603268846 1.0
**** v1 10.2 vsl| 0 CLI - Rd ping
**** v1 10.2 vsl| 0 CLI - Wr 200 19 PONG 1603268849 1.0
**** v1 13.1 vsl| 0 CLI - Rd ping
**** v1 13.1 vsl| 0 CLI - Wr 200 19 PONG 1603268852 1.0
**** v1 16.1 vsl| 0 CLI - Rd ping
**** v1 16.1 vsl| 0 CLI - Wr 200 19 PONG 1603268855 1.0
**** v1 19.2 vsl| 0 CLI - Rd ping
**** v1 19.2 vsl| 0 CLI - Wr 200 19 PONG 1603268858 1.0
**** v1 22.1 vsl| 0 CLI - Rd ping
**** v1 22.1 vsl| 0 CLI - Wr 200 19 PONG 1603268861 1.0
**** v1 25.2 vsl| 0 CLI - Rd ping
**** v1 25.2 vsl| 0 CLI - Wr 200 19 PONG 1603268864 1.0
**** v1 28.2 vsl| 0 CLI - Rd ping
**** v1 28.2 vsl| 0 CLI - Wr 200 19 PONG 1603268867 1.0
**** v1 31.2 vsl| 0 CLI - Rd ping
**** v1 31.2 vsl| 0 CLI - Wr 200 19 PONG 1603268870 1.0
---- c1 31.3 HTTP rx timeout (fd:17 30000 ms)
* top 31.3 RESETTING after upload/16-x-connection-properties.vtc
** s1 31.3 Waiting for server (4/-1)
** v1 31.3 Wait
**** v1 31.3 CLI TX|panic.clear
*** v1 31.3 CLI RX 300
**** v1 31.3 CLI RX|No panic to clear
*** v1 31.3 debug|Info: manager stopping child
*** v1 31.3 debug|Debug: Stopping Child
**** v1 31.4 vsl| 0 CLI - EOF on CLI connection, worker stops
*** v1 32.3 debug|Info: Child (5892) ended
*** v1 32.3 debug|Info: Child (5892) said Child dies
*** v1 32.3 debug|Debug: Child cleanup complete
*** v1 32.3 debug|Info: manager dies
**** v1 32.3 STDOUT poll 0x11
** v1 32.4 WAIT4 pid=5878 status=0x0000 (user 0.820554 sys 0.079703)
* top 32.4 TEST upload/16-x-connection-properties.vtc FAILED
# top TEST upload/16-x-connection-properties.vtc FAILED (32.375) exit=2
# top TEST upload/17-strip-unnecessary-headers.vtc passed (2.426)
# top TEST upload/18-thumb-bad-extension.vtc passed (2.752)
# top TEST upload/19-normalize-thumbnail-url.vtc passed (2.859)
# top TEST upload/20-content-type-fixup.vtc passed (2.503)
# top TEST upload/21-maps.vtc passed (2.785)

Event Timeline

ema created this paste.Oct 21 2020, 8:31 AM