hmmm if i try to vue the same page cnn.com no more error wen i clean my cache and try again it happen it look like only on clean cache can triger it debug_options ALL,3 2016/08/12 21:05:45.904 kid1| 36,3| ufs/UFSSwapDir.cc(1334) DirClean: Cleaning directory /mnt/cache/02/7C 2016/08/12 21:06:00.905 kid1| 36,3| ufs/UFSSwapDir.cc(1334) DirClean: Cleaning directory /mnt/cache/03/7C 2016/08/12 21:06:15.906 kid1| 36,3| ufs/UFSSwapDir.cc(1334) DirClean: Cleaning directory /mnt/cache/04/7C 2016/08/12 21:06:18.660 kid1| 5,2| TcpAcceptor.cc(226) doAccept: New connection on FD 20 2016/08/12 21:06:18.660 kid1| 5,2| TcpAcceptor.cc(315) acceptNext: connection on local=0.0.0.0:3128 remote=[::] FD 20 flags=41 2016/08/12 21:06:18.660 kid1| 51,3| fd.cc(199) fd_open: fd_open() FD 11 HTTP Request 2016/08/12 21:06:18.660 kid1| 28,3| Eui48.cc(516) lookup: id=0x181b404 10.4.4.60 NOT found 2016/08/12 21:06:18.660 kid1| 78,3| dns_internal.cc(1823) idnsPTRLookup: idnsPTRLookup: buf is 40 bytes for 10.4.4.60, id = 0x28ae 2016/08/12 21:06:18.660 kid1| 50,3| comm.cc(960) comm_udp_sendto: comm_udp_sendto: Attempt to send UDP packet to 4.2.2.3:53 using FD 6 using Port 10982 2016/08/12 21:06:18.660 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=54.192.217.48:80 remote=10.4.4.60:3318 FD 11 flags=33 timeout 300 2016/08/12 21:06:18.778 kid1| 78,3| dns_internal.cc(1330) idnsRead: idnsRead: starting with FD 6 2016/08/12 21:06:18.778 kid1| 78,3| dns_internal.cc(1376) idnsRead: idnsRead: FD 6: received 99 bytes from 4.2.2.3:53 2016/08/12 21:06:18.778 kid1| 78,3| dns_internal.cc(1183) idnsGrokReply: idnsGrokReply: QID 0x28ae, -3 answers 2016/08/12 21:06:18.778 kid1| 78,3| dns_internal.cc(1248) idnsGrokReply: idnsGrokReply: error Name Error: The domain name does not exist. (3) 2016/08/12 21:06:18.778 kid1| 35,3| fqdncache.cc(327) fqdncacheParse: fqdncacheParse: Lookup of '10.4.4.60' failed (Name Error: The domain name does not exist.) 2016/08/12 21:06:20.969 kid1| 5,2| TcpAcceptor.cc(226) doAccept: New connection on FD 20 2016/08/12 21:06:20.969 kid1| 5,2| TcpAcceptor.cc(315) acceptNext: connection on local=0.0.0.0:3128 remote=[::] FD 20 flags=41 2016/08/12 21:06:20.969 kid1| 51,3| fd.cc(199) fd_open: fd_open() FD 13 HTTP Request 2016/08/12 21:06:20.969 kid1| 28,3| Eui48.cc(516) lookup: id=0x1409634 10.4.4.61 NOT found 2016/08/12 21:06:20.969 kid1| 78,3| dns_internal.cc(1823) idnsPTRLookup: idnsPTRLookup: buf is 40 bytes for 10.4.4.61, id = 0x75b7 2016/08/12 21:06:20.969 kid1| 50,3| comm.cc(960) comm_udp_sendto: comm_udp_sendto: Attempt to send UDP packet to 4.2.2.3:53 using FD 6 using Port 10982 2016/08/12 21:06:20.969 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33 timeout 300 2016/08/12 21:06:20.969 kid1| 5,3| IoCallback.cc(116) finish: called for local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33 (0, 0) 2016/08/12 21:06:20.969 kid1| 5,3| Read.cc(92) ReadNow: local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33, size 4096, retval 363, errno 0 2016/08/12 21:06:20.969 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33 timeout 120 2016/08/12 21:06:20.970 kid1| 5,3| IoCallback.cc(116) finish: called for local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33 (0, 0) 2016/08/12 21:06:20.970 kid1| 5,3| Read.cc(92) ReadNow: local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33, size 3733, retval 0, errno 0 2016/08/12 21:06:20.970 kid1| 33,3| client_side.cc(1429) connFinishedWithConn: local=173.236.187.17:80 remote=10.4.4.61:12441 FD 13 flags=33 aborted (half_closed_clients disabled) 2016/08/12 21:06:20.970 kid1| 5,3| comm.cc(871) _comm_close: comm_close: start closing FD 13 2016/08/12 21:06:20.970 kid1| 5,3| comm.cc(546) commUnsetFdTimeout: Remove timeout for FD 13 2016/08/12 21:06:20.970 kid1| 33,2| client_side.cc(586) swanSong: local=173.236.187.17:80 remote=10.4.4.61:12441 flags=33 2016/08/12 21:06:20.970 kid1| 33,3| client_side_request.cc(270) ~ClientHttpRequest: httpRequestFree: error:transaction-end-before-headers 2016/08/12 21:06:20.970 kid1| 28,3| Checklist.cc(70) preCheck: 0x7ffc80a911a0 checking fast ACLs 2016/08/12 21:06:20.970 kid1| 28,3| Acl.cc(290) matches: checked: (access_log daemon:/var/log/squid/access.log line) = 1 2016/08/12 21:06:20.970 kid1| 28,3| Acl.cc(290) matches: checked: access_log daemon:/var/log/squid/access.log = 1 2016/08/12 21:06:20.970 kid1| 28,3| Checklist.cc(63) markFinished: 0x7ffc80a911a0 answer ALLOWED for match 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 1 bytes 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 0 of 32768 bytes before append 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 100 bytes 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 1 of 32768 bytes before append 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 7 bytes 2016/08/12 21:06:20.970 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 101 of 32768 bytes before append 2016/08/12 21:06:20.970 kid1| 33,3| client_side.cc(4004) unpinConnection: 2016/08/12 21:06:20.970 kid1| 33,3| client_side.cc(616) ~ConnStateData: local=173.236.187.17:80 remote=10.4.4.61:12441 flags=33 2016/08/12 21:06:20.970 kid1| 51,3| fd.cc(94) fd_close: fd_close FD 13 Reading next request 2016/08/12 21:06:21.057 kid1| 78,3| dns_internal.cc(1330) idnsRead: idnsRead: starting with FD 6 2016/08/12 21:06:21.057 kid1| 78,3| dns_internal.cc(1376) idnsRead: idnsRead: FD 6: received 99 bytes from 4.2.2.3:53 2016/08/12 21:06:21.057 kid1| 78,3| dns_internal.cc(1183) idnsGrokReply: idnsGrokReply: QID 0x75b7, -3 answers 2016/08/12 21:06:21.057 kid1| 78,3| dns_internal.cc(1248) idnsGrokReply: idnsGrokReply: error Name Error: The domain name does not exist. (3) 2016/08/12 21:06:21.057 kid1| 35,3| fqdncache.cc(327) fqdncacheParse: fqdncacheParse: Lookup of '10.4.4.61' failed (Name Error: The domain name does not exist.) 2016/08/12 21:06:21.081 kid1| 5,2| TcpAcceptor.cc(226) doAccept: New connection on FD 20 2016/08/12 21:06:21.081 kid1| 5,2| TcpAcceptor.cc(315) acceptNext: connection on local=0.0.0.0:3128 remote=[::] FD 20 flags=41 2016/08/12 21:06:21.081 kid1| 51,3| fd.cc(199) fd_open: fd_open() FD 13 HTTP Request 2016/08/12 21:06:21.081 kid1| 28,3| Eui48.cc(516) lookup: id=0x1409634 10.4.4.61 NOT found 2016/08/12 21:06:21.082 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 timeout 300 2016/08/12 21:06:21.082 kid1| 5,3| IoCallback.cc(116) finish: called for local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 (0, 0) 2016/08/12 21:06:21.082 kid1| 5,3| Read.cc(92) ReadNow: local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33, size 4096, retval 373, errno 0 2016/08/12 21:06:21.082 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 timeout 120 2016/08/12 21:06:21.082 kid1| 87,3| clientStream.cc(140) clientStreamInsertHead: clientStreamInsertHead: Inserted node 0x140afc8 with data 0x140ce78 after head 2016/08/12 21:06:21.082 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 timeout 86400 2016/08/12 21:06:21.082 kid1| 33,3| Pipeline.cc(24) add: Pipeline 0x14096e0 add request 1 0x140be10*3 2016/08/12 21:06:21.082 kid1| 33,2| Http1Server.cc(101) buildHttpRequest: Invalid Request 2016/08/12 21:06:21.082 kid1| 20,3| store.cc(777) storeCreatePureEntry: storeCreateEntry: 'error:invalid-request' 2016/08/12 21:06:21.082 kid1| 20,3| MemObject.cc(110) MemObject: new MemObject 0x1824f10 2016/08/12 21:06:21.082 kid1| 20,3| store.cc(472) setReleaseFlag: StoreEntry::setReleaseFlag: '[null_store_key]' 2016/08/12 21:06:21.082 kid1| 20,3| store.cc(421) hashInsert: StoreEntry::hashInsert: Inserting Entry e:=XI/0x140e330*0 key '34000000000000009A53000001000000' 2016/08/12 21:06:21.082 kid1| 20,3| store.cc(457) lock: storeCreateEntry locked key 34000000000000009A53000001000000 e:=XIV/0x140e330*1 2016/08/12 21:06:21.082 kid1| 4,2| errorpage.cc(1260) BuildContent: No existing error page language negotiated for ERR_PROTOCOL_UNKNOWN. Using default error file. 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%l --> '/* * Copyright (C) 1996-2015 The Squid Software Foundation and contributors * * Squid software is distributed under GPLv2+ license and includes * contributions from numerous individuals and organizations. * Please see the COPYING and CONTRIBUTORS files for details. */ /* Stylesheet for Squid Error pages Adapted from design by Free CSS Templates http://www.freecsstemplates.org Released for free under a Creative Commons Attribution 2.5 License */ /* Page basics */ * { font-family: verdana, sans-serif; } html body { margin: 0; padding: 0; background: #efefef; font-size: 12px; color: #1e1e1e; } /* Page displayed title area */ #titles { margin-left: 15px; padding: 10px; padding-left: 100px; background: url('http://www.squid-cache.org/Artwork/SN.png') no-repeat left; } /* initial title */ #titles h1 { color: #000000; } #titles h2 { color: #000000; } /* special event: FTP success page titles */ #titles ftpsuccess { background-color:#00ff00; width:100%; } /* Page displayed body content area */ #content { padding: 10px; background: #ffffff; } /* General text */ p { } /* error brief description */ #error p { } /* some data which may have caused the problem */ #data { } /* the error message received from the system or other software */ #sysmsg { } pre { font-family:sans-serif; } /* special event: FTP / Gopher directory listing */ #dirmsg { font-family: courier; color: black; font-size: 10pt; } #dirlisting { margin-left: 2%; margin-right: 2%; } #dirlisting tr.entry td.icon,td.filename,td.size,td.date { border-bottom: groove; } #dirlisting td.size { width: 50px; text-align: right; padding-right: 5px; } /* horizontal lines */ hr { margin: 0; } /* page displayed footer area */ #footer { font-size: 9px; padding-left: 10px; } ' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%; --> '%;' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%c --> 'ERR_PROTOCOL_UNKNOWN' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%U --> 'error:invalid-request' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%U --> 'error:invalid-request' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%w --> 'webmaster' 2016/08/12 21:06:21.082 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%W --> '?subject=CacheErrorInfo%20-%20ERR_PROTOCOL_UNKNOWN&body=CacheHost%3A%20proxy.netgatesss.com%0D%0AErrPage%3A%20ERR_PROTOCOL_UNKNOWN%0D%0AErr%3A%20%5Bnone%5D%0D%0ATimeStamp%3A%20Fri,%2012%20Aug%202016%2018%3A06%3A21%20GMT%0D%0A%0D%0AClientIP%3A%2010.4.4.61%0D%0A%0D%0AHTTP%20Request%3A%0D%0A%0D%0A%0D%0A' 2016/08/12 21:06:21.083 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%w --> 'webmaster' 2016/08/12 21:06:21.083 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%T --> 'Fri, 12 Aug 2016 18:06:21 GMT' 2016/08/12 21:06:21.083 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%h --> 'proxy.netgatesss.com' 2016/08/12 21:06:21.083 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%s --> 'squid' 2016/08/12 21:06:21.083 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%c --> 'ERR_PROTOCOL_UNKNOWN' 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(457) lock: StoreEntry::storeErrorResponse locked key 34000000000000009A53000001000000 e:=XIV/0x140e330*2 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(1848) replaceHttpReply: StoreEntry::replaceHttpReply: error:invalid-request 2016/08/12 21:06:21.083 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.083 kid1| 20,3| store_swapout.cc(382) mayStartSwapOut: not cachable 2016/08/12 21:06:21.083 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(729) invokeHandlers: InvokeHandlers: 34000000000000009A53000001000000 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(735) invokeHandlers: StoreEntry::InvokeHandlers: checking client #0 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(1089) complete: storeComplete: '34000000000000009A53000001000000' 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(1342) validLength: storeEntryValidLength: Checking '34000000000000009A53000001000000' 2016/08/12 21:06:21.083 kid1| 20,3| store_swapout.cc(357) mayStartSwapOut: already rejected 2016/08/12 21:06:21.083 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(729) invokeHandlers: InvokeHandlers: 34000000000000009A53000001000000 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(735) invokeHandlers: StoreEntry::InvokeHandlers: checking client #0 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(494) unlock: StoreEntry::storeErrorResponse unlocking key 34000000000000009A53000001000000 e:=sXINV/0x140e330*2 2016/08/12 21:06:21.083 kid1| 87,3| clientStream.cc(180) clientStreamRead: clientStreamRead: Calling 1 with cbdata 0x140e298 from node 0x140afc8 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(198) copy: store_client::copy: 34000000000000009A53000001000000, from 0, for length 4096, cb 1, cbdata 0x140d1e8 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(457) lock: store_client::copy locked key 34000000000000009A53000001000000 e:=sXINV/0x140e330*2 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(295) storeClientCopy2: storeClientCopy2: 34000000000000009A53000001000000 2016/08/12 21:06:21.083 kid1| 90,3| store_client.cc(429) scheduleMemRead: store_client::doCopy: Copying normal from memory 2016/08/12 21:06:21.083 kid1| 33,2| QosConfig.cc(163) doTosLocalMiss: QOS: Preserving TOS on miss, TOS=0 2016/08/12 21:06:21.083 kid1| 50,3| ../../src/ip/Qos.cci(22) setSockTos: for FD 13 to 0 2016/08/12 21:06:21.083 kid1| 88,2| client_side_reply.cc(2054) processReplyAccessResult: The reply for NONE error:invalid-request is ALLOWED, because it matched (access_log daemon:/var/log/squid/access.log line) 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(457) lock: ClientHttpRequest::loggingEntry locked key 34000000000000009A53000001000000 e:=sXINV/0x140e330*3 2016/08/12 21:06:21.083 kid1| 88,3| client_side_reply.cc(2092) processReplyAccessResult: clientReplyContext::sendMoreData: Appending 3367 bytes after 199 bytes of headers 2016/08/12 21:06:21.083 kid1| 87,3| clientStream.cc(158) clientStreamCallback: clientStreamCallback: Calling 1 with cbdata 0x140ce78 from node 0x1409a68 2016/08/12 21:06:21.083 kid1| 33,3| Pipeline.cc(35) front: Pipeline 0x14096e0 front 0x140be10*3 2016/08/12 21:06:21.083 kid1| 33,3| Pipeline.cc(35) front: Pipeline 0x14096e0 front 0x140be10*3 2016/08/12 21:06:21.083 kid1| 11,2| Stream.cc(266) sendStartOfMessage: HTTP Client local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 2016/08/12 21:06:21.083 kid1| 11,2| Stream.cc(267) sendStartOfMessage: HTTP Client REPLY: --------- HTTP/1.1 400 Bad Request Server: squid Mime-Version: 1.0 Date: Fri, 12 Aug 2016 18:06:21 GMT Content-Type: text/html;charset=utf-8 Content-Length: 3367 X-Squid-Error: ERR_PROTOCOL_UNKNOWN 0 X-Cache: MISS from proxy.netgatesss.com Connection: close ---------- 2016/08/12 21:06:21.083 kid1| 20,3| store.cc(494) unlock: store_client::copy unlocking key 34000000000000009A53000001000000 e:=sXINV/0x140e330*3 2016/08/12 21:06:21.084 kid1| 5,3| IoCallback.cc(116) finish: called for local=173.236.187.17:80 remote=10.4.4.61:12442 FD 13 flags=33 (0, 0) 2016/08/12 21:06:21.084 kid1| 33,3| Pipeline.cc(35) front: Pipeline 0x14096e0 front 0x140be10*2 2016/08/12 21:06:21.084 kid1| 88,3| client_side_reply.cc(1150) storeOKTransferDone: storeOKTransferDone out.offset=3367 objectLen()=3566 headers_sz=199 2016/08/12 21:06:21.084 kid1| 5,3| comm.cc(871) _comm_close: comm_close: start closing FD 13 2016/08/12 21:06:21.084 kid1| 5,3| comm.cc(546) commUnsetFdTimeout: Remove timeout for FD 13 2016/08/12 21:06:21.084 kid1| 87,3| clientStream.cc(198) clientStreamDetach: clientStreamDetach: Detaching node 0x140afc8 2016/08/12 21:06:21.084 kid1| 87,3| clientStream.cc(97) ~clientStreamNode: Freeing clientStreamNode 0x140afc8 2016/08/12 21:06:21.084 kid1| 87,3| clientStream.cc(219) clientStreamDetach: clientStreamDetach: Calling 1 with cbdata 0x140e298 2016/08/12 21:06:21.084 kid1| 87,3| clientStream.cc(198) clientStreamDetach: clientStreamDetach: Detaching node 0x1409a68 2016/08/12 21:06:21.084 kid1| 87,3| clientStream.cc(97) ~clientStreamNode: Freeing clientStreamNode 0x1409a68 2016/08/12 21:06:21.084 kid1| 90,3| store_client.cc(661) storeUnregister: storeUnregister: called for '34000000000000009A53000001000000' 2016/08/12 21:06:21.084 kid1| 20,3| store_swapout.cc(357) mayStartSwapOut: already rejected 2016/08/12 21:06:21.084 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(457) lock: storeUnregister locked key 34000000000000009A53000001000000 e:=sXINV/0x140e330*3 2016/08/12 21:06:21.084 kid1| 90,3| store_client.cc(755) storePendingNClients: storePendingNClients: returning 0 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(494) unlock: storeUnregister unlocking key 34000000000000009A53000001000000 e:=sXINV/0x140e330*3 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(494) unlock: clientReplyContext::removeStoreReference unlocking key 34000000000000009A53000001000000 e:=sXINV/0x140e330*2 2016/08/12 21:06:21.084 kid1| 33,3| Pipeline.cc(69) popMe: Pipeline 0x14096e0 drop 0x140be10*3 2016/08/12 21:06:21.084 kid1| 33,2| client_side.cc(893) kick: local=173.236.187.17:80 remote=10.4.4.61:12442 flags=33 Connection was closed 2016/08/12 21:06:21.084 kid1| 33,3| client_side_request.cc(270) ~ClientHttpRequest: httpRequestFree: error:invalid-request 2016/08/12 21:06:21.084 kid1| 28,3| Checklist.cc(70) preCheck: 0x7ffc80a91290 checking fast ACLs 2016/08/12 21:06:21.084 kid1| 28,3| Acl.cc(290) matches: checked: (access_log daemon:/var/log/squid/access.log line) = 1 2016/08/12 21:06:21.084 kid1| 28,3| Acl.cc(290) matches: checked: access_log daemon:/var/log/squid/access.log = 1 2016/08/12 21:06:21.084 kid1| 28,3| Checklist.cc(63) markFinished: 0x7ffc80a91290 answer ALLOWED for match 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 1 bytes 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 108 of 32768 bytes before append 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 96 bytes 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 109 of 32768 bytes before append 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 220 bytes 2016/08/12 21:06:21.084 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 205 of 32768 bytes before append 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(494) unlock: ClientHttpRequest::loggingEntry unlocking key 34000000000000009A53000001000000 e:=sXINV/0x140e330*1 2016/08/12 21:06:21.084 kid1| 90,3| store_client.cc(755) storePendingNClients: storePendingNClients: returning 0 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(1252) release: releasing e:=sXINV/0x140e330*0 34000000000000009A53000001000000 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(378) destroyMemObject: destroyMemObject 0x1824f10 2016/08/12 21:06:21.084 kid1| 20,3| MemObject.cc(119) ~MemObject: del MemObject 0x1824f10 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(396) destroyStoreEntry: destroyStoreEntry: destroying 0x140e338 2016/08/12 21:06:21.084 kid1| 20,3| store.cc(378) destroyMemObject: destroyMemObject 0 2016/08/12 21:06:21.085 kid1| 33,2| client_side.cc(586) swanSong: local=173.236.187.17:80 remote=10.4.4.61:12442 flags=33 2016/08/12 21:06:21.085 kid1| 33,3| client_side_request.cc(270) ~ClientHttpRequest: httpRequestFree: error:transaction-end-before-headers 2016/08/12 21:06:21.085 kid1| 28,3| Checklist.cc(70) preCheck: 0x7ffc80a911a0 checking fast ACLs 2016/08/12 21:06:21.085 kid1| 28,3| Acl.cc(290) matches: checked: (access_log daemon:/var/log/squid/access.log line) = 1 2016/08/12 21:06:21.085 kid1| 28,3| Acl.cc(290) matches: checked: access_log daemon:/var/log/squid/access.log = 1 2016/08/12 21:06:21.085 kid1| 28,3| Checklist.cc(63) markFinished: 0x7ffc80a911a0 answer ALLOWED for match 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 1 bytes 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 425 of 32768 bytes before append 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 100 bytes 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 426 of 32768 bytes before append 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(174) logfile_mod_daemon_append: logfile_mod_daemon_append: daemon:/var/log/squid/access.log: appending 7 bytes 2016/08/12 21:06:21.085 kid1| 50,3| ModDaemon.cc(178) logfile_mod_daemon_append: logfile_mod_daemon_append: current buffer has 526 of 32768 bytes before append 2016/08/12 21:06:21.085 kid1| 33,3| client_side.cc(4004) unpinConnection: 2016/08/12 21:06:21.085 kid1| 33,3| client_side.cc(616) ~ConnStateData: local=173.236.187.17:80 remote=10.4.4.61:12442 flags=33 2016/08/12 21:06:21.085 kid1| 51,3| fd.cc(94) fd_close: fd_close FD 13 Reading next request 2016/08/12 21:06:21.168 kid1| 5,2| TcpAcceptor.cc(226) doAccept: New connection on FD 20 2016/08/12 21:06:21.168 kid1| 5,2| TcpAcceptor.cc(315) acceptNext: connection on local=0.0.0.0:3128 remote=[::] FD 20 flags=41 2016/08/12 21:06:21.168 kid1| 51,3| fd.cc(199) fd_open: fd_open() FD 13 HTTP Request 2016/08/12 21:06:21.168 kid1| 28,3| Eui48.cc(516) lookup: id=0x1409634 10.4.4.61 NOT found 2016/08/12 21:06:21.168 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33 timeout 300 2016/08/12 21:06:21.169 kid1| 5,3| IoCallback.cc(116) finish: called for local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33 (0, 0) 2016/08/12 21:06:21.169 kid1| 5,3| Read.cc(92) ReadNow: local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33, size 4096, retval 216, errno 0 2016/08/12 21:06:21.169 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33 timeout 120 2016/08/12 21:06:21.169 kid1| 87,3| clientStream.cc(140) clientStreamInsertHead: clientStreamInsertHead: Inserted node 0x140afc8 with data 0x140ce78 after head 2016/08/12 21:06:21.169 kid1| 5,3| comm.cc(559) commSetConnTimeout: local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33 timeout 86400 2016/08/12 21:06:21.169 kid1| 33,3| Pipeline.cc(24) add: Pipeline 0x14096e0 add request 1 0x140be10*3 2016/08/12 21:06:21.169 kid1| 33,2| Http1Server.cc(101) buildHttpRequest: Invalid Request 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(777) storeCreatePureEntry: storeCreateEntry: 'error:invalid-request' 2016/08/12 21:06:21.169 kid1| 20,3| MemObject.cc(110) MemObject: new MemObject 0x1824f10 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(472) setReleaseFlag: StoreEntry::setReleaseFlag: '[null_store_key]' 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(421) hashInsert: StoreEntry::hashInsert: Inserting Entry e:=XI/0x140e330*0 key '35000000000000009A53000001000000' 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(457) lock: storeCreateEntry locked key 35000000000000009A53000001000000 e:=XIV/0x140e330*1 2016/08/12 21:06:21.169 kid1| 4,2| errorpage.cc(1260) BuildContent: No existing error page language negotiated for ERR_PROTOCOL_UNKNOWN. Using default error file. 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%l --> '/* * Copyright (C) 1996-2015 The Squid Software Foundation and contributors * * Squid software is distributed under GPLv2+ license and includes * contributions from numerous individuals and organizations. * Please see the COPYING and CONTRIBUTORS files for details. */ /* Stylesheet for Squid Error pages Adapted from design by Free CSS Templates http://www.freecsstemplates.org Released for free under a Creative Commons Attribution 2.5 License */ /* Page basics */ * { font-family: verdana, sans-serif; } html body { margin: 0; padding: 0; background: #efefef; font-size: 12px; color: #1e1e1e; } /* Page displayed title area */ #titles { margin-left: 15px; padding: 10px; padding-left: 100px; background: url('http://www.squid-cache.org/Artwork/SN.png') no-repeat left; } /* initial title */ #titles h1 { color: #000000; } #titles h2 { color: #000000; } /* special event: FTP success page titles */ #titles ftpsuccess { background-color:#00ff00; width:100%; } /* Page displayed body content area */ #content { padding: 10px; background: #ffffff; } /* General text */ p { } /* error brief description */ #error p { } /* some data which may have caused the problem */ #data { } /* the error message received from the system or other software */ #sysmsg { } pre { font-family:sans-serif; } /* special event: FTP / Gopher directory listing */ #dirmsg { font-family: courier; color: black; font-size: 10pt; } #dirlisting { margin-left: 2%; margin-right: 2%; } #dirlisting tr.entry td.icon,td.filename,td.size,td.date { border-bottom: groove; } #dirlisting td.size { width: 50px; text-align: right; padding-right: 5px; } /* horizontal lines */ hr { margin: 0; } /* page displayed footer area */ #footer { font-size: 9px; padding-left: 10px; } ' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%; --> '%;' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%c --> 'ERR_PROTOCOL_UNKNOWN' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%U --> 'error:invalid-request' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%U --> 'error:invalid-request' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%w --> 'webmaster' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%W --> '?subject=CacheErrorInfo%20-%20ERR_PROTOCOL_UNKNOWN&body=CacheHost%3A%20proxy.netgatesss.com%0D%0AErrPage%3A%20ERR_PROTOCOL_UNKNOWN%0D%0AErr%3A%20%5Bnone%5D%0D%0ATimeStamp%3A%20Fri,%2012%20Aug%202016%2018%3A06%3A21%20GMT%0D%0A%0D%0AClientIP%3A%2010.4.4.61%0D%0A%0D%0AHTTP%20Request%3A%0D%0A%0D%0A%0D%0A' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%w --> 'webmaster' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%T --> 'Fri, 12 Aug 2016 18:06:21 GMT' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%h --> 'proxy.netgatesss.com' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%s --> 'squid' 2016/08/12 21:06:21.169 kid1| 4,3| errorpage.cc(1099) Convert: errorConvert: %%c --> 'ERR_PROTOCOL_UNKNOWN' 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(457) lock: StoreEntry::storeErrorResponse locked key 35000000000000009A53000001000000 e:=XIV/0x140e330*2 2016/08/12 21:06:21.169 kid1| 20,3| store.cc(1848) replaceHttpReply: StoreEntry::replaceHttpReply: error:invalid-request 2016/08/12 21:06:21.170 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.170 kid1| 20,3| store_swapout.cc(382) mayStartSwapOut: not cachable 2016/08/12 21:06:21.170 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(729) invokeHandlers: InvokeHandlers: 35000000000000009A53000001000000 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(735) invokeHandlers: StoreEntry::InvokeHandlers: checking client #0 2016/08/12 21:06:21.170 kid1| 20,3| store.cc(1089) complete: storeComplete: '35000000000000009A53000001000000' 2016/08/12 21:06:21.170 kid1| 20,3| store.cc(1342) validLength: storeEntryValidLength: Checking '35000000000000009A53000001000000' 2016/08/12 21:06:21.170 kid1| 20,3| store_swapout.cc(357) mayStartSwapOut: already rejected 2016/08/12 21:06:21.170 kid1| 20,2| store.cc(990) checkCachable: StoreEntry::checkCachable: NO: not cachable 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(729) invokeHandlers: InvokeHandlers: 35000000000000009A53000001000000 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(735) invokeHandlers: StoreEntry::InvokeHandlers: checking client #0 2016/08/12 21:06:21.170 kid1| 20,3| store.cc(494) unlock: StoreEntry::storeErrorResponse unlocking key 35000000000000009A53000001000000 e:=sXINV/0x140e330*2 2016/08/12 21:06:21.170 kid1| 87,3| clientStream.cc(180) clientStreamRead: clientStreamRead: Calling 1 with cbdata 0x140e298 from node 0x140afc8 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(198) copy: store_client::copy: 35000000000000009A53000001000000, from 0, for length 4096, cb 1, cbdata 0x140d1e8 2016/08/12 21:06:21.170 kid1| 20,3| store.cc(457) lock: store_client::copy locked key 35000000000000009A53000001000000 e:=sXINV/0x140e330*2 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(295) storeClientCopy2: storeClientCopy2: 35000000000000009A53000001000000 2016/08/12 21:06:21.170 kid1| 90,3| store_client.cc(429) scheduleMemRead: store_client::doCopy: Copying normal from memory 2016/08/12 21:06:21.170 kid1| 33,2| QosConfig.cc(163) doTosLocalMiss: QOS: Preserving TOS on miss, TOS=0 2016/08/12 21:06:21.170 kid1| 50,3| ../../src/ip/Qos.cci(22) setSockTos: for FD 13 to 0 2016/08/12 21:06:21.170 kid1| 88,2| client_side_reply.cc(2054) processReplyAccessResult: The reply for NONE error:invalid-request is ALLOWED, because it matched (access_log daemon:/var/log/squid/access.log line) 2016/08/12 21:06:21.170 kid1| 20,3| store.cc(457) lock: ClientHttpRequest::loggingEntry locked key 35000000000000009A53000001000000 e:=sXINV/0x140e330*3 2016/08/12 21:06:21.170 kid1| 88,3| client_side_reply.cc(2092) processReplyAccessResult: clientReplyContext::sendMoreData: Appending 3367 bytes after 199 bytes of headers 2016/08/12 21:06:21.170 kid1| 87,3| clientStream.cc(158) clientStreamCallback: clientStreamCallback: Calling 1 with cbdata 0x140ce78 from node 0x1409a68 2016/08/12 21:06:21.170 kid1| 33,3| Pipeline.cc(35) front: Pipeline 0x14096e0 front 0x140be10*3 2016/08/12 21:06:21.170 kid1| 33,3| Pipeline.cc(35) front: Pipeline 0x14096e0 front 0x140be10*3 2016/08/12 21:06:21.170 kid1| 11,2| Stream.cc(266) sendStartOfMessage: HTTP Client local=173.236.187.17:80 remote=10.4.4.61:12443 FD 13 flags=33 2016/08/12 21:06:21.170 kid1| 11,2| Stream.cc(267) sendStartOfMessage: HTTP Client REPLY: --------- HTTP/1.1 400 Bad Request Server: squid Mime-Version: 1.0 Date: Fri, 12 Aug 2016 18:06:21 GMT Content-Type: text/html;charset=utf-8 Content-Length: 3367 X-Squid-Error: ERR_PROTOCOL_UNKNOWN 0 X-Cache: MISS from proxy.netgatesss.com Connection: close ---------- -- View this message in context: http://squid-web-proxy-cache.1019090.n4.nabble.com/X-Squid-Error-tp4678848p4678889.html Sent from the Squid - Users mailing list archive at Nabble.com. _______________________________________________ squid-users mailing list squid-users@xxxxxxxxxxxxxxxxxxxxx http://lists.squid-cache.org/listinfo/squid-users
