[squid-users] Squid 5.7 + bump ERR_READ_ERROR|WITH_SERVER
David Touzeau
david at articatech.com
Wed Oct 12 21:58:21 UTC 2022
Thanks Alex
We have put it in debug mode :
you can see :
"2022/10/12 22:29:49.476 kid3| 4,3| Error.cc(22) update: recent:
ERR_READ_ERROR/WITH_SERVER"
As without ssl-bump, there is no issue.
the full log can be downloaded here
http://articatech.net/tmpf/cache.log.txt*
*
}
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905084 from SBuf15905303
2022/10/12 22:29:49.475 kid3| 11,2| client_side.cc(1357)
parseHttpRequest: HTTP Client conn214046 local=192.168.1.190:3128
remote=192.168.1.13:62858 FD 21 flags=1
2022/10/12 22:29:49.475 kid3| 11,2| client_side.cc(1361)
parseHttpRequest: HTTP Client REQUEST:
---------
GET /fw.ping.php?_=1665576594826 HTTP/1.1
Host: categories.articatech.net
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:105.0)
Gecko/20100101 Firefox/105.0
Accept: */*
Accept-Language: fr,fr-FR;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip, deflate, br
Referer: https://categories.articatech.net/index
X-Requested-With: XMLHttpRequest
Connection: keep-alive
Cookie: _ga=GA1.2.1172828951.1642984448;
PHPSESSID=28871210b5b031a7b034981e9704a4ac
Sec-Fetch-Dest: empty
Sec-Fetch-Mode: cors
Sec-Fetch-Site: same-origin
----------
2022/10/12 22:29:49.475 kid3| 33,3| client_side.cc(1393)
parseHttpRequest: complete request received. prefix_sz = 542,
request-line-size=43, mime-header-size=499, mime header block:
Host: categories.articatech.net
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:105.0)
Gecko/20100101 Firefox/105.0
Accept: */*
Accept-Language: fr,fr-FR;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip, deflate, br
Referer: https://categories.articatech.net/index
X-Requested-With: XMLHttpRequest
Connection: keep-alive
Cookie: _ga=GA1.2.1172828951.1642984448;
PHPSESSID=28871210b5b031a7b034981e9704a4ac
Sec-Fetch-Dest: empty
Sec-Fetch-Mode: cors
Sec-Fetch-Site: same-origin
----------
2022/10/12 22:29:49.475 kid3| 93,5| AsyncJob.cc(34) AsyncJob: AsyncJob
constructed, this=0x56260e3814b8 type=ClientHttpRequest [job199106]
2022/10/12 22:29:49.475 kid3| 1,5| CodeContext.cc(60) Entering: ALE w/o
master
2022/10/12 22:29:49.475 kid3| 87,3| clientStream.cc(140)
clientStreamInsertHead: clientStreamInsertHead: Inserted node
0x56260e6d26f8 with data 0x56260e0fa280 after head
2022/10/12 22:29:49.475 kid3| 33,5| client_side.cc(1413)
parseHttpRequest: Prepare absolute URL from
2022/10/12 22:29:49.475 kid3| 25,5| Parser.cc(228) getHostHeaderField:
looking for Host
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(763) findFirstNotOf: first
not of characterset non-LF in id SBuf15905340
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
32 bytes
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
1 bytes
2022/10/12 22:29:49.475 kid3| 25,5| Parser.cc(249) getHostHeaderField:
checking Host: categories.articatech.net
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(763) findFirstNotOf: first
not of characterset WSP in id SBuf15905345
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
1 bytes
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905339 from SBuf15905345
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(763) findFirstNotOf: first
not of characterset host in id SBuf15905339
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(771) findFirstNotOf: not found
2022/10/12 22:29:49.475 kid3| 25,5| Parser.cc(267) getHostHeaderField:
returning categories.articatech.net
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905347 from SBuf183
2022/10/12 22:29:49.475 kid3| 33,5| client_side.cc(1294)
prepareTlsSwitchingURL: TLS switching host rewrite:
https://categories.articatech.net/fw.ping.php?_=1665576594826
2022/10/12 22:29:49.475 kid3| 33,5| client_side.cc(1981)
clientParseRequests: conn214046 local=192.168.1.190:3128
remote=192.168.1.13:62858 FD 21 flags=1: done parsing a request
2022/10/12 22:29:49.475 kid3| 5,4| AsyncCall.cc(30) AsyncCall: The
AsyncCall ConnStateData::lifetimeTimeout constructed,
this=0x56260e5afd50 [call1972958]
2022/10/12 22:29:49.475 kid3| 5,3| comm.cc(571) commSetConnTimeout:
conn214046 local=192.168.1.190:3128 remote=192.168.1.13:62858 FD 21
flags=1 timeout 86400
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(194) clean: cleaning
hdr: 0x56260e392c18 owner: 3
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(194) clean: cleaning
hdr: 0x56260e392c18 owner: 3
2022/10/12 22:29:49.475 kid3| 33,3| client_side.cc(1806) add:
0x56260e0f9210*3 to 0/1
2022/10/12 22:29:49.475 kid3| 33,3| Pipeline.cc(24) add: Pipeline
0x56260e6cd470 add request 2 0x56260e0f9210*4
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905349
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 61
for SBuf15905349
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905349
new store capacity: 128
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(155) HttpHeader:
init-ing hdr: 0x56260e4038f8 owner: 2
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(763) findFirstNotOf: first
not of characterset special in id SBuf15905363
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
5 bytes
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
1 bytes
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905367 from SBuf183
2022/10/12 22:29:49.475 kid3| 24,5| Tokenizer.cc(27) consume: consuming
2 bytes
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 1
for SBuf15905371
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905371
not growing
2022/10/12 22:29:49.475 kid3| 23,3| Uri.cc(441) parse: Split URL
'https://categories.articatech.net/fw.ping.php?_=1665576594826' into
proto='https', host='categories.articatech.net', port='443',
path='/fw.ping.php?_=1665576594826'
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905351 from SBuf15905361
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905353
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905353
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 28
for SBuf15905353
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905353
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 14,3| Address.cc(389) lookupHostIP: Given
Non-IP 'categories.articatech.net': Name or service not known
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905373
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 0
for SBuf15905373
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905373
not growing
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905352 from SBuf15905373
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905350 from SBuf15905305
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 1
for SBuf15905374
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905374
not growing
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(390) parse: parsing
hdr: (0x56260e4038f8)
Host: categories.articatech.net
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:105.0)
Gecko/20100101 Firefox/105.0
Accept: */*
Accept-Language: fr,fr-FR;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip, deflate, br
Referer: https://categories.articatech.net/index
X-Requested-With: XMLHttpRequest
Connection: keep-alive
Cookie: _ga=GA1.2.1172828951.1642984448;
PHPSESSID=28871210b5b031a7b034981e9704a4ac
Sec-Fetch-Dest: empty
Sec-Fetch-Mode: cors
Sec-Fetch-Site: same-origin
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905375
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905375
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 4
for SBuf15905375
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905375
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905376
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905376
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 4
for SBuf15905376
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905376
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Host[30] at 0
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905377
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905377
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 10
for SBuf15905377
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905377
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905378
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905378
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 10
for SBuf15905378
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905378
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: User-Agent[67] at 1
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905379
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905379
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905379
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905379
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905380
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905380
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905380
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905380
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Accept[0] at 2
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905381
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905381
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 15
for SBuf15905381
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905381
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905382
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905382
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 15
for SBuf15905382
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905382
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Accept-Language[3] at 3
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905383
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905383
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 15
for SBuf15905383
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905383
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905384
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905384
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 15
for SBuf15905384
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905384
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Accept-Encoding[2] at 4
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905385
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905385
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 7
for SBuf15905385
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905385
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905386
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905386
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 7
for SBuf15905386
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905386
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Referer[54] at 5
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905387
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 16
for SBuf15905387
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905387
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905388 from SBuf15905387
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Other:[87] at 6
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905389
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905389
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 10
for SBuf15905389
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905389
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905390
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905390
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 10
for SBuf15905390
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905390
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Connection[12] at 7
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905391
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905391
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905391
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905391
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905392
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905392
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905392
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905392
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Cookie[22] at 8
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905393
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 14
for SBuf15905393
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905393
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905394 from SBuf15905393
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Other:[87] at 9
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905395
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 14
for SBuf15905395
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905395
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905396 from SBuf15905395
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Other:[87] at 10
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905397
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 14
for SBuf15905397
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905397
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905398 from SBuf15905397
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Other:[87] at 11
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905355
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 25
for SBuf15905355
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905355
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905354 from SBuf15905355
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905355
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905355
not growing
2022/10/12 22:29:49.475 kid3| 33,5| Http1Server.cc(193)
buildHttpRequest: normalize 1 Host header using categories.articatech.net
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 1
for SBuf15905399
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905399
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 24,6| SBuf.cc(99) assign: SBuf15905401
from c-string, n=4294967295)
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905401
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 4
for SBuf15905401
2022/10/12 22:29:49.475 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905401
new store capacity: 40
2022/10/12 22:29:49.475 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e4038f8 adding entry: Host[30] at 12
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905356
new store capacity: 16384
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 5
for SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905356
not growing
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 1
for SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905356
not growing
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 2
for SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905356
not growing
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 25
for SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905356
not growing
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 28
for SBuf15905356
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905356
not growing
2022/10/12 22:29:49.476 kid3| 33,3| client_side.cc(699)
clientSetKeepaliveFlag: http_ver = HTTP/1.1
2022/10/12 22:29:49.476 kid3| 33,3| client_side.cc(700)
clientSetKeepaliveFlag: method = GET
2022/10/12 22:29:49.476 kid3| 55,6| HttpHeader.cc(850) getList:
0x56260e4038f8: joined for id Connection[12]: 0x7ffc7248c400
2022/10/12 22:29:49.476 kid3| 33,4| client_side.cc(1510) quitAfterError:
Will close after error: conn214046 local=192.168.1.190:3128
remote=192.168.1.13:62858 FD 21 flags=1
2022/10/12 22:29:49.476 kid3| 33,5| client_side.cc(1531)
serveDelayedError: Responding with delated error for
https://categories.articatech.net/fw.ping.php?_=1665576594826
2022/10/12 22:29:49.476 kid3| 20,3| store.cc(443) lock:
clientReplyContext::setReplyToStoreEntry locked key
AFC90000000000002632000003000000 e:=sp2XIV/0x56260e1b8290*2
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248c000 checking fast rules
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(343) fastCheck:
aclCheckFast: list: 0x56260c88d7a8
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'ALLOWED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#1
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking Group2
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(110) match:
aclMatchDomainList: checking 'categories.articatech.net'
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(115) match:
aclMatchDomainList: 'categories.articatech.net' NOT found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: Group2 = 0
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#1 = 0
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'DENIED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#2
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking all
2022/10/12 22:29:49.476 kid3| 28,3| Ip.cc(538) match: aclIpMatchIp:
'192.168.1.13:62858' found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: all = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#2 = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access = 1
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248c000 answer DENIED for match
2022/10/12 22:29:49.476 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248c000
2022/10/12 22:29:49.476 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248c000
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248c000 checking fast rules
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(343) fastCheck:
aclCheckFast: list: 0x56260c8c46a8
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'ALLOWED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#1
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking Group2
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(110) match:
aclMatchDomainList: checking 'categories.articatech.net'
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(115) match:
aclMatchDomainList: 'categories.articatech.net' NOT found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: Group2 = 0
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#1 = 0
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'DENIED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#2
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking all
2022/10/12 22:29:49.476 kid3| 28,3| Ip.cc(538) match: aclIpMatchIp:
'192.168.1.13:62858' found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: all = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#2 = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access = 1
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248c000 answer DENIED for match
2022/10/12 22:29:49.476 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248c000
2022/10/12 22:29:49.476 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248c000
*2022/10/12 22:29:49.476 kid3| 4,3| Error.cc(22) update: recent:
ERR_READ_ERROR/WITH_SERVER*
2022/10/12 22:29:49.476 kid3| 33,5| Stream.cc(117) pullData: 0 written 0
into conn214046 local=192.168.1.190:3128 remote=192.168.1.13:62858 FD 21
flags=1
2022/10/12 22:29:49.476 kid3| 33,5| Stream.cc(141) getNextRangeOffset:
range: 0; http offset 0; reply 0
2022/10/12 22:29:49.476 kid3| 87,3| clientStream.cc(180)
clientStreamRead: clientStreamRead: Calling 1 with cbdata 0x56260e0d2ba8
from node 0x56260e6d26f8
2022/10/12 22:29:49.476 kid3| 90,3| store_client.cc(246) copy:
store_client::copy: AFC90000000000002632000003000000, from 0, for length
4096, cb 1, cbdata 0x56260e0d1ad8
2022/10/12 22:29:49.476 kid3| 20,3| store.cc(443) lock:
store_client::copy locked key AFC90000000000002632000003000000
e:=sp2XIV/0x56260e1b8290*3
2022/10/12 22:29:49.476 kid3| 90,3| store_client.cc(338)
storeClientCopy2: storeClientCopy2: AFC90000000000002632000003000000
2022/10/12 22:29:49.476 kid3| 33,5| store_client.cc(368) doCopy:
store_client::doCopy: co: 0, hi: 506665
2022/10/12 22:29:49.476 kid3| 90,3| store_client.cc(472)
scheduleMemRead: store_client::doCopy: Copying normal from memory
2022/10/12 22:29:49.476 kid3| 19,6| stmem.cc(230) copy: memCopy:
0x56260db339f8 [0,4096)
2022/10/12 22:29:49.476 kid3| 88,5| client_side_reply.cc(2213)
sendMoreData: conn214046 local=192.168.1.190:3128
remote=192.168.1.13:62858 FD 21 flags=1 'categories.articatech.net:443'
out.offset=0
2022/10/12 22:29:49.476 kid3| 88,5| client_side_reply.cc(2241)
sendMoreData: clientReplyContext::sendMoreData:
https://categories.articatech.net/fw.ping.php?_=1665576594826, 4096
bytes (4096 new bytes)
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(155) HttpHeader:
init-ing hdr: 0x56260e392c18 owner: 3
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(243) append: appending
hdr: 0x56260e392c18 += 0x56260db7a728
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905409
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905409
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 6
for SBuf15905409
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905409
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Server[57] at 0
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905410
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905410
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 12
for SBuf15905410
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905410
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Mime-Version[43] at 1
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905411
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905411
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 4
for SBuf15905411
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905411
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Date[24] at 2
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905412
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905412
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 12
for SBuf15905412
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905412
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Content-Type[21] at 3
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905413
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905413
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 14
for SBuf15905413
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905413
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Content-Length[17] at 4
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905414
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905414
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 13
for SBuf15905414
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905414
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: X-Squid-Error[76] at 5
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(156)
httpHeaderParseOffset: offset 506470 parsed as 506470
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(156)
httpHeaderParseOffset: offset 506470 parsed as 506470
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905416
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905416
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 7
for SBuf15905416
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905416
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: X-Cache[72] at 6
2022/10/12 22:29:49.476 kid3| 33,2| client_side_reply.cc(1585)
buildReplyHeader: clientBuildReplyHeader: Connection Keep-Alive not
requested by admin or client
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 16
for SBuf15905417
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905417
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 96
for SBuf15905417
2022/10/12 22:29:49.476 kid3| 24,7| MemBlob.cc(130) syncSize: 0 was: 0
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905417
new store capacity: 128
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(85) assign: assigning
SBuf15905418 from SBuf15905417
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 1
for SBuf15905418
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(167) rawSpace: SBuf15905418
not growing
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905420
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905420
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 3
for SBuf15905420
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905420
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Via[69] at 7
2022/10/12 22:29:49.476 kid3| 24,6| SBuf.cc(99) assign: SBuf15905422
from c-string, n=4294967295)
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(209) append: from c-string
to id SBuf15905422
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(160) rawSpace: reserving 10
for SBuf15905422
2022/10/12 22:29:49.476 kid3| 24,7| SBuf.cc(866) reAlloc: SBuf15905422
new store capacity: 40
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(786) addEntry:
0x56260e392c18 adding entry: Connection[12] at 8
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248bb70 checking fast rules
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(343) fastCheck:
aclCheckFast: list: 0x56260c8adf68
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
http_header_access Server
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'DENIED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
http_header_access Server#1
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking all
2022/10/12 22:29:49.476 kid3| 28,3| Ip.cc(538) match: aclIpMatchIp:
'192.168.1.13:62858' found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: all = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
http_header_access Server#1 = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
http_header_access Server = 1
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248bb70 answer DENIED for match
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(308)
httpHdrMangle: checklist denied, we have no replacement. Pass
2022/10/12 22:29:49.476 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248bb70
2022/10/12 22:29:49.476 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248bb70
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 66,7| HttpHeaderTools.cc(286)
httpHdrMangle: couldn't find mangler or access list. Allowing
2022/10/12 22:29:49.476 kid3| 55,7| HttpHeader.cc(769) refreshMask:
refreshing the mask in hdr 0x56260e392c18
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248bcb0 checking fast rules
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(343) fastCheck:
aclCheckFast: list: 0x56260c88d7a8
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'ALLOWED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#1
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking Group2
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(110) match:
aclMatchDomainList: checking 'categories.articatech.net'
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(115) match:
aclMatchDomainList: 'categories.articatech.net' NOT found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: Group2 = 0
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#1 = 0
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'DENIED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#2
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking all
2022/10/12 22:29:49.476 kid3| 28,3| Ip.cc(538) match: aclIpMatchIp:
'192.168.1.13:62858' found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: all = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#2 = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access = 1
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248bcb0 answer DENIED for match
2022/10/12 22:29:49.476 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248bcb0
2022/10/12 22:29:49.476 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248bcb0
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248bcb0 checking fast rules
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(343) fastCheck:
aclCheckFast: list: 0x56260c8c46a8
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'ALLOWED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#1
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking Group2
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(110) match:
aclMatchDomainList: checking 'categories.articatech.net'
2022/10/12 22:29:49.476 kid3| 28,3| DomainData.cc(115) match:
aclMatchDomainList: 'categories.articatech.net' NOT found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: Group2 = 0
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#1 = 0
2022/10/12 22:29:49.476 kid3| 28,5| Checklist.cc(398) bannedAction:
Action 'DENIED/0' is not banned
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking
delay_access#2
2022/10/12 22:29:49.476 kid3| 28,5| Acl.cc(124) matches: checking all
2022/10/12 22:29:49.476 kid3| 28,3| Ip.cc(538) match: aclIpMatchIp:
'192.168.1.13:62858' found
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked: all = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access#2 = 1
2022/10/12 22:29:49.476 kid3| 28,3| Acl.cc(151) matches: checked:
delay_access = 1
2022/10/12 22:29:49.476 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248bcb0 answer DENIED for match
2022/10/12 22:29:49.476 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248bcb0
2022/10/12 22:29:49.477 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248bcb0
2022/10/12 22:29:49.477 kid3| 28,3| Checklist.cc(70) preCheck:
0x7ffc7248bc10 checking fast ACLs
2022/10/12 22:29:49.477 kid3| 28,5| Acl.cc(124) matches: checking
reply_body_max_size -1
2022/10/12 22:29:49.477 kid3| 28,5| Acl.cc(124) matches: checking
(reply_body_max_size -1 line)
2022/10/12 22:29:49.477 kid3| 28,3| Acl.cc(151) matches: checked:
(reply_body_max_size -1 line) = 1
2022/10/12 22:29:49.477 kid3| 28,3| Acl.cc(151) matches: checked:
reply_body_max_size -1 = 1
2022/10/12 22:29:49.477 kid3| 28,3| Checklist.cc(63) markFinished:
0x7ffc7248bc10 answer ALLOWED for match
2022/10/12 22:29:49.477 kid3| 58,4| HttpReply.cc(564) calcMaxBodySize:
bodySizeMax=-1
2022/10/12 22:29:49.477 kid3| 28,4| FilledChecklist.cc(67)
~ACLFilledChecklist: ACLFilledChecklist destroyed 0x7ffc7248bc10
2022/10/12 22:29:49.477 kid3| 28,4| Checklist.cc(197) ~ACLChecklist:
ACLChecklist::~ACLChecklist: destroyed 0x7ffc7248bc10
2022/10/12 22:29:49.477 kid3| 58,7| HttpReply.cc(528)
expectedBodyTooLarge: bodySizeMax=-1
2022/10/12 22:29:49.477 kid3| 88,2| client_side_reply.cc(2090)
processReplyAccessResult: The reply for GET
https://categories.articatech.net/fw.ping.php?_=1665576594826 is
ALLOWED, because it matched (reply_body_max_size -1 line)
2022/10/12 22:29:49.477 kid3| 20,3| store.cc(443) lock:
ClientHttpRequest::loggingEntry locked key
AFC90000000000002632000003000000 e:=sp2XIV/0x56260e1b8290*4
2022/10/12 22:29:49.477 kid3| 88,3| client_side_reply.cc(2128)
processReplyAccessResult: clientReplyContext::sendMoreData: Appending
3901 bytes after 195 bytes of headers
2022/10/12 22:29:49.477 kid3| 87,3| clientStream.cc(158)
clientStreamCallback: clientStreamCallback: Calling 1 with cbdata
0x56260e0fa280 from node 0x56260e5c0ab8
2022/10/12 22:29:49.477 kid3| 33,3| Pipeline.cc(35) front: Pipeline
0x56260e6cd470 front 0x56260e0f9210*4
2022/10/12 22:29:49.477 kid3| 33,3| Pipeline.cc(35) front: Pipeline
0x56260e6cd470 front 0x56260e0f9210*4
2022/10/12 22:29:49.477 kid3| 55,7| HttpHeader.cc(589) packInto:
0x56260e392c18 into 0x56260e26ebe8
2022/10/12 22:29:49.477 kid3| 11,2| Stream.cc(279) sendStartOfMessage:
HTTP Client conn214046 local=192.168.1.190:3128
remote=192.168.1.13:62858 FD 21 flags=1
2022/10/12 22:29:49.477 kid3| 11,2| Stream.cc(280) sendStartOfMessage:
HTTP Client REPLY:
---------
HTTP/1.1 502 Bad Gateway
Mime-Version: 1.0
Date: Wed, 12 Oct 2022 20:29:49 GMT
Content-Type: text/html;charset=utf-8
Content-Length: 506470
X-Squid-Error: ERR_READ_ERROR 0
X-Cache: MISS from proxy-190.articatech.int
Via: 1.1 789aaa51-a1eb-eb48-639b-000070877aed (squid)
Connection: close
Le 12/10/2022 à 20:00, Alex Rousskov a écrit :
> On 10/12/22 12:45, David Touzeau wrote:
>> Hi
>>
>> We using squid 5.7 after adding ssl-bump we have sometimes several
>> 502 error with extended error ERR_READ_ERROR|WITH_SERVER
>>
>> 1665589818.831 11 192.168.1.13 NONE_NONE/502 192616 OPTIONS
>> https://www2.deepl.com/jsonrpc?method=LMT_split_text - HIER_NONE/-:-
>> text/html mac="68:54:5a:94:e7:56" - exterr="ERR_READ_ERROR|WITH_SERVER"
>> 1665589839.288 11 192.168.1.13 NONE_NONE/502 506759 POST
>> https://pollserver.lastpass.com/poll_server.php - HIER_NONE/-:-
>> text/html mac="68:54:5a:94:e7:56" - exterr="ERR_READ_ERROR|WITH_SERVER"
>> 1665589719.879 44 192.168.1.13 NONE_NONE/502 506954 GET
>> https://contile.services.mozilla.com/v1/tiles - HIER_NONE/-:-
>> text/html mac="68:54:5a:94:e7:56" - exterr="ERR_READ_ERROR|WITH_SERVER"
>
>> What does it means.
>
> 502 with ERR_READ_ERROR|WITH_SERVER may mean several things
> (unfortunately). Given HIER_NONE, I would suspect that Squid could not
> find a valid destination for the request. There is a similar recent
> squid-users thread at
> http://lists.squid-cache.org/pipermail/squid-users/2022-October/025289.html
>
>
>> how can we fix it ?
>
> The first step is to identify what causes these errors.
>
> Can you reproduce this problem at will? Perhaps by trying going to
> https://dnslabeldoesnotexist.com mentioned at the above thread? If you
> can, consider sharing (a pointer to) a compressed debugging cache.log
> from a test box that does not expose any internal secrets, as detailed
> at
> https://wiki.squid-cache.org/SquidFaq/BugReporting#Debugging_a_single_transaction
>
>
> HTH,
>
> Alex.
> _______________________________________________
> squid-users mailing list
> squid-users at lists.squid-cache.org
> http://lists.squid-cache.org/listinfo/squid-users
--
Technical Support
*David Touzeau*
Orgerus, Yvelines, France
*Artica Tech*
P: +33 6 58 44 69 46
www: wiki.articatech.com <https://wiki.articatech.com>
www: articatech.net <http://articatech.net>
More information about the squid-users
mailing list