Hi Christos,
Thanks for your reply. I am posting the squid-icap server conversation
and also the debug messages here.
Christos Tsantilas wrote:
Hi Selvi,
selvi wrote:
Hello All,
I am in the process of integrating squid-3.0.STABLE1 with Python based
ICAP Server. Here, i am not able to get the response modification.
Is it a custom ICAP server?
I am using the Python based ICAP Server.
ICAP related configurations given are:
icap_enable on
icap_send_client_ip on
icap_service content respmod_precache 0 icap://<IP Address>:1344/respmod
icap_class class_1 content
icap_access class_1 allow all
I am not seeing any error messages in the ICAP Server side. Squid also
behaves normally except the following message in cache.log
"essential ICAP service is invalidated by reconfigure: icap://<IP
Address>:1344/respmod [down,gone,!opt]". But when i perform some web
access through ICAP enabled squid proxy, empty page is displayed (the
browser displays nothing).
This message means that the squid tried to send an options request to
the ICAP server and the ICAP server answer was not correct (or just did
not like to the squid)
I am suggesting to enable debug for ICAP client in squid3:
debug_options 93,9 0,9
And search in debug messages to see what they say about. You can also
post the debug messages here.
Also grabbing the conversation between squid and ICAP server using
wireshark or similar tool will be helpful...
Regards,
Christos
A snapshot of the conversation between squid and ICAP server is given
below (using tcpdump).
11:04:02.978996 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: S 2637131307:2637131307(0) win 32767 <mss
16396,sackOK,timestamp 1238745316 0,nop,wscale 8>
E..<..@.@.0
...........@./n+........+.....@....
I...........
11:04:02.979009 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: S 2632376145:2632376145(0) ack 2637131308
win 32767 <mss 16396,sackOK,timestamp 1238745316 1238745316,nop,wscale 8>
E..<..@.@............@.....Q./n,..........@....
I...I.......
11:04:02.979020 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: . ack 1 win 128 <nop,nop,timestamp
1238745316 1238745316>
E..4..@.@.0............@./n,...R.....A.....
I...I...
11:04:02.981160 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: P 1:752(751) ack 1 win 128
<nop,nop,timestamp 1238745318 1238745316>
E..#..@.@.-............@./n,...R....^......
I...I...RESPMOD icap://172.16.1.225:1344/respmod ICAP/1.0
Host: 172.16.1.225:1344
Date: Fri, 04 Jan 2008 05:34:02 GMT
Encapsulated: req-hdr=0, res-hdr=277, res-body=546
Allow: 204
X-Client-IP: 172.16.1.34
GET http://172.16.1.225:8088/gui/test.html HTTP/1.0
Accept: */*
Accept-Language: en-us
Pragma: no-cache
User-Agent: Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)
Host: 172.16.1.225:8088
Proxy-Connection: Keep-Alive
Authorization: Basic dmljYWNoZTp2aWNhY2hl
HTTP/1.1 200 OK
Date: Fri, 04 Jan 2008 05:34:02 GMT
Server: Apache/2.0.52 (Red Hat)
Last-Modified: Fri, 04 Jan 2008 05:25:31 GMT
ETag: "64cce8-1d-442debd2f28c0"
Accept-Ranges: bytes
Content-Length: 29
Connection: close
Content-Type: text/html; charset=UTF-8
11:04:02.981170 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: . ack 752 win 128 <nop,nop,timestamp
1238745318 1238745318>
E..4..@.@..+.........@.....R./q......N.....
I...I...
11:04:02.982351 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: P 752:792(40) ack 1 win 128
<nop,nop,timestamp 1238745319 1238745318>
E..\..@.@./............@./q....R....\1.....
I...I...1d
<html>
Hello Selvi
</html>
0
11:04:02.982360 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: . ack 792 win 128 <nop,nop,timestamp
1238745319 1238745319>
E..4..@.@..).........@.....R./qC.....$.....
I...I...
11:04:02.987875 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: P 1:429(428) ack 792 win 128
<nop,nop,timestamp 1238745325 1238745319>
E.....@.@..{.........@.....R./qC....]......
I...I...ICAP/1.0 200 OK
Date: Fri, 04 Jan 2008 05:34:02 GMT
Encapsulated: res-hdr=0 res-body=269
Server: ICAP-Server-Software/1.0
HTTP/1.0 200 OK
Content-Length: 29
Accept-Ranges: bytes
Server: Apache/2.0.52 (Red Hat)
Last-Modified: Fri, 04 Jan 2008 05:25:31 GMT
Connection: close
ETag: "64cce8-1d-442debd2f28c0"
Date: Fri, 04 Jan 2008 05:34:02 GMT
Content-Type: text/html; charset=UTF-8
<html>
Hello Selvi
</html>
11:04:02.987889 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: . ack 429 win 128 <nop,nop,timestamp
1238745325 1238745325>
E..4..@.@.0
...........@./qC.........l.....
I...I...
11:04:02.988074 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: F 429:429(0) ack 792 win 128
<nop,nop,timestamp 1238745325 1238745325>
E..4..@.@..%.........@......./qC.....k.....
I...I...
11:04:02.993135 IP squid225.kovaiteam.com.60111 >
squid225.kovaiteam.com.1344: F 792:792(0) ack 430 win 128
<nop,nop,timestamp 1238745330 1238745325>
E..4..@.@.0............@./qC.........e.....
I...I...
11:04:02.993148 IP squid225.kovaiteam.com.1344 >
squid225.kovaiteam.com.60111: . ack 793 win 128 <nop,nop,timestamp
1238745330 1238745330>
E..4..@.@..#.........@......./qD.....`.....
I...I...
Debug Messages determined using ' debug_options 93,9 0,9' is given below
2008/01/05 15:19:41.342| ICAPAccessCheck constructed for RESPMOD PRECACHE
2008/01/05 15:19:41.342| ICAPAccessCheck::check
2008/01/05 15:19:41.342| ICAP/ICAPConfig.cc(277) looking for the first
matching service in class class_1
2008/01/05 15:19:41.342| ICAP/ICAPConfig.cc(315) found first matching
service in class class_1: vicontent
2008/01/05 15:19:41.342| ICAPAccessCheck::check: class 'class_1' has
candidate service 'vicontent'
2008/01/05 15:19:41.342| ICAPAccessCheckCallbackWrapper: answer=1
2008/01/05 15:19:41.342| ICAPAccessCheckCallbackWrapper matchedClass =
class_1
2008/01/05 15:19:41.342| ICAPAccessCheckCallbackEvent
2008/01/05 15:19:41.342| ICAPAccessCheck::do_callback
2008/01/05 15:19:41.343| ICAPAccessCheck::do_callback matchedClass = class_1
2008/01/05 15:19:41.343| ICAP/ICAPConfig.cc(277) looking for the first
matching up service in class class_1
2008/01/05 15:19:41.343| ICAP/ICAPConfig.cc(308) cannot skip an
essential down service
2008/01/05 15:19:41.343| ICAP/ICAPConfig.cc(315) found first matching
down-but-essential service in class class_1: vicontent
2008/01/05 15:19:41.343| ICAP/ICAPConfig.cc(262) do_callback: with
service icap://172.16.1.225:1344/respmod
2008/01/05 15:19:41.343| Server.cc(414) will send virgin reply body to
0x6000000000451288*2; size: 29
2008/01/05 15:19:41.343| ICAP/AsyncJob.cc(14) will call
AsyncJob::noteStart(0x6000000000455498)
2008/01/05 15:19:41.353| entering AsyncJob::noteStart(0x6000000000455498)
2008/01/05 15:19:41.353| ICAPModXactLauncher::noteStart called
2008/01/05 15:19:41.353| ICAP/ICAPLauncher.cc(35) launching xaction #1
2008/01/05 15:19:41.353| ICAPModXact constructed,
this=0x60000000004596b8 [icapx1]
2008/01/05 15:19:41.353| ICAPModXact initialized. [R/ icapx1]
2008/01/05 15:19:41.353| ICAP/AsyncJob.cc(14) will call
AsyncJob::noteStart(0x60000000004596b8)
2008/01/05 15:19:41.353| ICAPModXactLauncher::noteStart ended
2008/01/05 15:19:41.353| exiting AsyncJob::noteStart(0x6000000000455498)
2008/01/05 15:19:41.364| entering AsyncJob::noteStart(0x60000000004596b8)
2008/01/05 15:19:41.364| ICAPModXact::noteStart called [R/ icapx1]
2008/01/05 15:19:41.364| ICAPModXact expects virgin body from
0x6000000000451288*3; size: 29
2008/01/05 15:19:41.364| ICAPModXact will wait for the ICAP service [R/
icapx1]
2008/01/05 15:19:41.364| ICAP/ICAPServiceRep.cc(308) ICAPService is
asked to call 0x60000000004596b8 when ready [down,!opt]
2008/01/05 15:19:41.364| ICAPService will get new options [down,!opt]
2008/01/05 15:19:41.364| ICAP/AsyncJob.cc(14) will call
AsyncJob::noteStart(0x600000000045d8e8)
2008/01/05 15:19:41.364| ICAPModXact::noteStart ended [UR/ icapx1]
2008/01/05 15:19:41.364| ICAP/AsyncJob.cc(14) will call
AsyncJob::noteStart(0x600000000045d8e8)
2008/01/05 15:19:41.364| ICAPModXact::noteStart ended [UR/ icapx1]
2008/01/05 15:19:41.364| exiting AsyncJob::noteStart(0x60000000004596b8)
2008/01/05 15:19:41.375| ICAPModXact::noteMoreBodyDataAvailable called
[UR/ icapx1]
2008/01/05 15:19:41.375| ICAP/ICAPModXact.cc(182) checking whether to
write more [UR/ icapx1]
2008/01/05 15:19:41.375| ICAPModXact::noteMoreBodyDataAvailable ended
[UR/ icapx1]
2008/01/05 15:19:41.375| ICAPModXact::noteBodyProductionEnded called
[UR/ icapx1]
2008/01/05 15:19:41.375| ICAP/ICAPModXact.cc(182) checking whether to
write more [UR/ icapx1]
2008/01/05 15:19:41.375| ICAPModXact::noteBodyProductionEnded ended [UR/
icapx1]
2008/01/05 15:19:41.375| entering AsyncJob::noteStart(0x600000000045d8e8)
2008/01/05 15:19:41.375| ICAPOptXactLauncher::noteStart called
2008/01/05 15:19:41.375| ICAP/ICAPLauncher.cc(35) launching xaction #1
2008/01/05 15:19:41.375| ICAPOptXact constructed,
this=0x6000000000461b28 [icapx2]
2008/01/05 15:19:41.375| ICAP/AsyncJob.cc(14) will call
AsyncJob::noteStart(0x6000000000461b28)
2008/01/05 15:19:41.375| ICAPOptXactLauncher::noteStart ended
2008/01/05 15:19:41.375| exiting AsyncJob::noteStart(0x600000000045d8e8)
2008/01/05 15:19:41.385| entering AsyncJob::noteStart(0x6000000000461b28)
2008/01/05 15:19:41.385| ICAPOptXact::noteStart called [/ icapx2]
2008/01/05 15:19:41.385| ICAPOptXact becomes final [/ icapx2]
2008/01/05 15:19:41.385| ICAPOptXact opens connection to 172.16.1.225:1344
2008/01/05 15:19:41.385| ICAPOptXact::noteStart ended [FD 14;/ icapx2]
2008/01/05 15:19:41.385| exiting AsyncJob::noteStart(0x6000000000461b28)
2008/01/05 15:19:41.386| ICAPOptXact::noteCommConnected called [FD 14;/
icapx2]
2008/01/05 15:19:41.386| ICAPOptXact request [FD 14r;/ icapx2]:
OPTIONS icap://172.16.1.225:1344/respmod ICAP/1.0^M
Host: 172.16.1.225:1344^M
^M
2008/01/05 15:19:41.386| ICAPOptXact::noteCommConnected ended [FD 14wr;/
icapx2]
2008/01/05 15:19:41.386| ICAPOptXact::noteCommWrote called [FD 14wr;/
icapx2]
2008/01/05 15:19:41.386| ICAPOptXact finished writing 78-byte request
[FD 14r;/ icapx2]
2008/01/05 15:19:41.386| ICAPOptXact::noteCommWrote ended [FD 14r;/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPXaction.cc(59) 0x6000000000461b28 read
returned 341
2008/01/05 15:19:41.387| ICAPOptXact::noteCommRead called [FD 14r;/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPXaction.cc(339) read 341 bytes
2008/01/05 15:19:41.387| ICAPOptXact remains final [FD 14;/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPOptXact.cc(71) have 341 bytes to parse
[FD 14;/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPOptXact.cc(72)
ICAP/1.0 200 OK^M
Transfer-Preview: *^M
Preview: 200000^M
Methods: REQMOD, RESPMOD^M
Service: Python ICAP Server 1.2^M
Methods: REQMOD, RESPMOD^M
Service: Python ICAP Server 1.2^M
Service-ID: ???^M
X-Include: RESPMOD^M
Encapsulated: null-body=0^M
Options-TTL: 300^M
ISTAG: "001-000-000001"^M
X-Authenticated-User: ^M
Date: Sat, 05 Jan 2008 09:49:41 GMT^M
Max-Connections: 1000^M
Server: ICAP-Server-Software/1.0^M
^M
2008/01/05 15:19:41.387| ICAP/ICAPXaction.cc(377) have 341 head bytes to
parse
2008/01/05 15:19:41.387| ICAP/ICAPInitiate.cc(176) will call
0x600000000045d920->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.387| ICAPOptXact::noteCommRead ends job [FD 14;/
icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPXaction.cc(169) not reusing pconn due
to pending I/O [FD 14;/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPXaction.cc(179) closing pconn [FD 14;/
icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPInitiate.cc(82) swan sings [/ icapx2]
2008/01/05 15:19:41.387| ICAP/ICAPInitiate.cc(89) swan sang [/ icapx2]
2008/01/05 15:19:41.387| ICAPOptXact destructed, this=0x6000000000461b28
[icapx2]
2008/01/05 15:19:41.387| ICAP/AsyncJob.cc(106) ICAPOptXact::noteCommRead
ended 0x6000000000461b28
2008/01/05 15:19:41.398| entering
0x600000000045d920->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.398| ICAPOptXactLauncher::noteIcapAnswer called
2008/01/05 15:19:41.398| ICAP/ICAPInitiate.cc(176) will call
0x60000000001777a8->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.398| ICAPOptXactLauncher::noteIcapAnswer ends job
2008/01/05 15:19:41.398| ICAP/ICAPInitiate.cc(82) swan sings
2008/01/05 15:19:41.398| ICAP/ICAPInitiate.cc(89) swan sang
2008/01/05 15:19:41.398| ICAP/AsyncJob.cc(106)
ICAPOptXactLauncher::noteIcapAnswer ended 0x600000000045d8e8
2008/01/05 15:19:41.398| exiting
0x600000000045d920->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.409| entering
0x60000000001777a8->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.409| ICAPService is interpreting new options [down,!opt]
2008/01/05 15:19:41.409| ICAPOptions::cfgIntHeader Max-Connections: 1000
2008/01/05 15:19:41.409| ICAPOptions::cfgIntHeader Options-TTL: 300
2008/01/05 15:19:41.409| ICAPOptions::cfgIntHeader Preview: 200000
2008/01/05 15:19:41.409| ICAPOptions::cfgTransferList: set default
transfer to Transfer-Preview
2008/01/05 15:19:41.409| ICAPOptions::cfgTransferList: no
Transfer-Preview extensions
2008/01/05 15:19:41.409| ICAPOptions::cfgTransferList: no
Transfer-Ignore extensions
2008/01/05 15:19:41.409| ICAPOptions::cfgTransferList: no
Transfer-Complete extensions
2008/01/05 15:19:41.409| ICAPService changes options from 0 to
0x600000000045d7f0 [down,!opt]
2008/01/05 15:19:41.409| ICAPService got new options and is now [up]
2008/01/05 15:19:41.409| ICAPService changes options from 0 to
0x600000000045d7f0 [down,!opt]
2008/01/05 15:19:41.409| ICAPService got new options and is now [up]
2008/01/05 15:19:41.409| ICAPService options expire on 1199526881 >=
1199526581
2008/01/05 15:19:41.409| ICAP/ICAPServiceRep.cc(487) raw OPTIONS fetch
at 1199526861 or in 280 sec
2008/01/05 15:19:41.409| ICAP/ICAPServiceRep.cc(489) last fetched at
1199526581 or 0 sec ago
2008/01/05 15:19:41.409| ICAPService will fetch OPTIONS in 280 sec
2008/01/05 15:19:41.409| ICAPService will notify 1 clients
2008/01/05 15:19:41.409| exiting
0x60000000001777a8->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.419| ICAPService notifies 1 clients [up,notif]
2008/01/05 15:19:41.419| ICAPModXact::noteServiceReady called [UR/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(1192) preview disabled by
squid.conf
2008/01/05 15:19:41.420| ICAPModXact becomes final [Rw(1)/ icapx1]
2008/01/05 15:19:41.420| ICAPModXact opens connection to 172.16.1.225:1344
2008/01/05 15:19:41.420| ICAPModXact::noteServiceReady ended [FD
14;Rrw(1)/ icapx1]
2008/01/05 15:19:41.420| ICAPModXact::noteCommConnected called [FD
14;Rrw(1)/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(1135) will allow 204s
outside of preview
2008/01/05 15:19:41.420| ICAPModXact ICAP will write [FD 14r;Rrw(1)B/
icapx1]:
RESPMOD icap://172.16.1.225:1344/respmod ICAP/1.0^M
Host: 172.16.1.225:1344^M
Date: Sat, 05 Jan 2008 09:49:41 GMT^M
Encapsulated: req-hdr=0, res-hdr=277, res-body=546^M
Allow: 204^M
X-Client-IP: 172.16.1.34^M
^M
GET http://172.16.1.225:8088/gui/test.html HTTP/1.0^M
Accept: */*^M
Accept-Language: en-us^M
Pragma: no-cache^M
User-Agent: Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1)^M
Host: 172.16.1.225:8088^M
Proxy-Connection: Keep-Alive^M
Authorization: Basic dmljYWNoZTp2aWNhY2hl^M
^M
HTTP/1.1 200 OK^M
Date: Sat, 05 Jan 2008 09:49:41 GMT^M
Server: Apache/2.0.52 (Red Hat)^M
Last-Modified: Sat, 05 Jan 2008 07:22:49 GMT^M
ETag: "64cce7-1d-442f47e85e440"^M
Accept-Ranges: bytes^M
Content-Length: 29^M
Connection: close^M
Content-Type: text/html; charset=UTF-8^M
^M
M
2008/01/05 15:19:41.420| ICAPModXact::noteCommConnected ended [FD
14wr;Rrw(2)B/ icapx1]
2008/01/05 15:19:41.420| ICAPModXact::noteCommWrote called [FD
14wr;Rrw(2)B/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(154) Wrote 751 bytes
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(182) checking whether to
write more [FD 14r;Rrw(5)B/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(260) will write up to 29
bytes of prime virgin body
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(271) will write 29-byte
chunk of prime virgin body
2008/01/05 15:19:41.420| consumption guards: 00
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(383) max virgin consumption
offset=29 acts 11 consumed=0 from [0<=29<=29 29+2018
pipe0x6000000000451288 cons0x6000000000459768]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(291) will write last-chunk
of prime virgin body
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(296) will write 40 raw
bytes of prime virgin body
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(250) wrote entire body
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(418) will wait for the last
write [FD 14wr;Rrw(5)B/ icapx1]
2008/01/05 15:19:41.420| ICAPModXact::noteCommWrote ended [FD
14wr;Rrw(6)B/ icapx1]
2008/01/05 15:19:41.420| ICAPModXact::noteCommWrote called [FD
14wr;Rrw(6)B/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(154) Wrote 40 bytes
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(182) checking whether to
write more [FD 14r;Rrw(6)B/ icapx1]
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(434) will no longer write
[FD 14r;Rrw(6)B/ icapx1]
2008/01/05 15:19:41.420| consumption guards: 00
2008/01/05 15:19:41.420| ICAP/ICAPModXact.cc(383) max virgin consumption
offset=29 acts 01 consumed=0 from [0<=29<=29 29+2018
pipe0x6000000000451288 cons0x6000000000459768]
2008/01/05 15:19:41.420| ICAPModXact::noteCommWrote ended [FD 14r;RrB/w
icapx1]
2008/01/05 15:19:41.425| ICAP/ICAPXaction.cc(59) 0x60000000004596b8 read
returned 428
2008/01/05 15:19:41.425| ICAPModXact::noteCommRead called [FD 14r;RrB/w
icapx1]
2008/01/05 15:19:41.425| ICAP/ICAPXaction.cc(339) read 428 bytes
2008/01/05 15:19:41.425| ICAPModXact remains final [FD 14;RrB/w icapx1]
2008/01/05 15:19:41.425| ICAP/ICAPModXact.cc(574) have 428 bytes to
parse [FD 14;RrB/w icapx1]
2008/01/05 15:19:41.425| ICAP/ICAPModXact.cc(575)
ICAP/1.0 200 OK^M
Date: Sat, 05 Jan 2008 09:49:41 GMT^M
Encapsulated: res-hdr=0 res-body=269^M
Server: ICAP-Server-Software/1.0^M
^M
HTTP/1.0 200 OK^M
Content-Length: 29^M
Accept-Ranges: bytes^M
Server: Apache/2.0.52 (Red Hat)^M
Last-Modified: Sat, 05 Jan 2008 07:22:49 GMT^M
Connection: close^M
ETag: "64cce7-1d-442f47e85e440"^M
Connection: close^M
ETag: "64cce7-1d-442f47e85e440"^M
Date: Sat, 05 Jan 2008 09:49:41 GMT^M
Content-Type: text/html; charset=UTF-8^M
^M
<html>
Hello Selvi
</html>
^M
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(653) parse ICAP headers
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(882) have 428 head bytes to
parse; state: 0
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(894) parse success, consume
128 bytes, return true
2008/01/05 15:19:41.426| ICAPModXact will no longer backup [FD
14;RrBp(1)S(2)/w icapx1]
2008/01/05 15:19:41.426| consumption guards: 00
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(383) max virgin consumption
offset=29 acts 00 consumed=0 from [0<=29<=29 29+2018
pipe0x6000000000451288 cons0x6000000000459768]
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(395) consuming 29 out of 29
virgin body bytes
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(567) will stop consuming
[FD 14;Rrp(1)S(2)/w icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(658) parse HTTP headers
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(882) have 300 head bytes to
parse; state: 1
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(894) parse success, consume
269 bytes, return true
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(926) not expecting a body
2008/01/05 15:19:41.426| ICAPModXact will no longer parse [FD
14;rp(1)S(2)/Rw icapx1]
2008/01/05 15:19:41.426| ICAPModXact will no longer send [FD
14;S(2)/Rwrp icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPInitiate.cc(176) will call
0x60000000004554d0->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(474) returning from
readMore because reader or doneReading()
2008/01/05 15:19:41.426| ICAP/ICAPXaction.cc(285) ICAPModXact done with
I/O [FD 14;/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPXaction.cc(174) pushing pconn [FD
14;/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAPModXact remains final [FD 14;/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAPModXact::noteCommRead ends job [/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPModXact.cc(1062) swan sings [/RwrpS
icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPInitiate.cc(82) swan sings [/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAP/ICAPInitiate.cc(89) swan sang [/RwrpS icapx1]
2008/01/05 15:19:41.426| ICAPModXact destructed, this=0x60000000004596b8
[icapx1]
2008/01/05 15:19:41.426| ICAP/AsyncJob.cc(106) ICAPModXact::noteCommRead
ended 0x60000000004596b8
2008/01/05 15:19:41.426| entering
0x60000000004554d0->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.426| ICAPModXactLauncher::noteIcapAnswer called
2008/01/05 15:19:41.426| ICAP/ICAPInitiate.cc(176) will call
0x600000000044c618->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.426| ICAPModXactLauncher::noteIcapAnswer called
2008/01/05 15:19:41.426| ICAP/ICAPInitiate.cc(176) will call
0x600000000044c618->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.426| ICAPModXactLauncher::noteIcapAnswer ends job
2008/01/05 15:19:41.427| ICAP/ICAPInitiate.cc(82) swan sings
2008/01/05 15:19:41.427| ICAP/ICAPInitiate.cc(89) swan sang
2008/01/05 15:19:41.427| ICAP/AsyncJob.cc(106)
ICAPModXactLauncher::noteIcapAnswer ended 0x6000000000455498
2008/01/05 15:19:41.427| exiting
0x60000000004554d0->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.437| entering
0x600000000044c618->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
2008/01/05 15:19:41.437| exiting
0x600000000044c618->ICAPInitiator::noteIcapAnswer(0x60000000003e2cd0)
Thanks
Selvi
The same setup with squid-2.5.STABLE13 works properly (the page is
displayed).
What could be the problem?
Thanks for your assistance.
Thanks
Selvi
