Re: [squid-users] I have stumbled into a very curios problem\issue with icap request passed from squid. from Eliezer Croitoru on 2012-07-16 (squid-users)

From: Eliezer Croitoru <eliezer_at_ngtech.co.il>
Date: Mon, 16 Jul 2012 21:40:08 +0300

On 7/16/2012 3:36 AM, Eliezer Croitoru wrote:
so i sat on it a bit more:
on the 3.1.10 proxy in the logs i am getting this while using curl and
proxy:
1342399298.935 680 127.0.0.1 TCP_MISS/200 9590 http://127.0.0.1:3128
http://www.xxx.com/ - DIRECT/67.23.112.226 text/html
and this using wget:
1342463622.152 1585 127.0.0.1 TCP_MISS/200 165744 GET
http://www.xxx.com/ - DIRECT/67.23.112.226 text/html

why would it be a method of "http://127.0.0.1:3128" on the proxy?
how can it be?

Thanks,
Eliezer

some logs from squid 3.1.20 that intercepts the request:
icap log level 9:
2012/07/16 21:24:01.982| AsyncJob constructed, this=0x998cf10
type=ConnStateData [job240089]
2012/07/16 21:24:02.120| AsyncJob constructed, this=0xab4638
type=ClientHttpRequest [job240090]
2012/07/16 21:24:02.121| HttpRequest.cc(55) HttpRequest: constructed,
this=0x3376130 id=5
2012/07/16 21:24:02.121| AsyncJob constructed, this=0x54fb728
type=AccessCheck [job240091]
2012/07/16 21:24:02.121| AccessCheck.cc(50) AccessCheck: AccessCheck
constructed for REQMOD PRECACHE
2012/07/16 21:24:02.121| The AsyncCall AsyncJob::start constructed,
this=0xc35dd0 [call8112457]
2012/07/16 21:24:02.121| AsyncJob.cc(19) will call AsyncJob::start()
[call8112457]
2012/07/16 21:24:02.121| entering AsyncJob::start()
2012/07/16 21:24:02.121| AsyncCall.cc(32) make: make call
AsyncJob::start [call8112457]
2012/07/16 21:24:02.121| AccessCheck status in: [ job240091]
2012/07/16 21:24:02.121| AccessCheck.cc(75) check: start checking
2012/07/16 21:24:02.122| AccessCheck.cc(197) isCandidate: checking
candidacy of 6, group service_filter
2012/07/16 21:24:02.122| ServiceGroups.cc(134) findService:
service_filter checks service at 0
2012/07/16 21:24:02.122| ServiceGroups.cc(171) findService:
service_filter has no matching services
2012/07/16 21:24:02.122| AccessCheck.cc(207) isCandidate: service_filter
ignores
2012/07/16 21:24:02.122| AccessCheck.cc(97) checkCandidates: has 0 rules
2012/07/16 21:24:02.122| AccessCheck.cc(112) checkCandidates: NO
candidates left
2012/07/16 21:24:02.122| AccessCheck.cc(164) callBack: NULL
2012/07/16 21:24:02.122| client_side_request.cc(669)
adaptationAclCheckDone: 0x50b24d8 adaptationAclCheckDone called
2012/07/16 21:24:02.123| AccessCheck will stop, reason: done
2012/07/16 21:24:02.123| AsyncJob::start() ends job [Stopped,
reason:done job240091]
2012/07/16 21:24:02.123| AsyncJob destructed, this=0x54fb728
type=AccessCheck [job240091]
2012/07/16 21:24:02.123| AsyncJob.cc(139) callEnd: AsyncJob::start()
ended 0x54fb728
2012/07/16 21:24:02.123| leaving AsyncJob::start()
2012/07/16 21:24:02.284| AsyncJob constructed, this=0x165dbeb8
type=HttpStateData [job240092]
2012/07/16 21:24:02.470| AsyncJob constructed, this=0x54fb728
type=AccessCheck [job240093]
2012/07/16 21:24:02.470| AccessCheck.cc(50) AccessCheck: AccessCheck
constructed for RESPMOD PRECACHE
2012/07/16 21:24:02.470| The AsyncCall AsyncJob::start constructed,
this=0xc67500 [call8112468]
2012/07/16 21:24:02.470| AsyncJob.cc(19) will call AsyncJob::start()
[call8112468]
2012/07/16 21:24:02.470| entering AsyncJob::start()
2012/07/16 21:24:02.470| AsyncCall.cc(32) make: make call
AsyncJob::start [call8112468]
2012/07/16 21:24:02.470| AccessCheck status in: [ job240093]
2012/07/16 21:24:02.470| AccessCheck.cc(75) check: start checking
2012/07/16 21:24:02.470| AccessCheck.cc(197) isCandidate: checking
candidacy of 6, group service_filter
2012/07/16 21:24:02.470| ServiceGroups.cc(126) findService:
service_filter serves another location
2012/07/16 21:24:02.470| AccessCheck.cc(207) isCandidate: service_filter
ignores
2012/07/16 21:24:02.470| AccessCheck.cc(97) checkCandidates: has 0 rules
2012/07/16 21:24:02.470| AccessCheck.cc(112) checkCandidates: NO
candidates left
2012/07/16 21:24:02.470| AccessCheck.cc(164) callBack: NULL
2012/07/16 21:24:02.471| AccessCheck will stop, reason: done
2012/07/16 21:24:02.471| AsyncJob::start() ends job [Stopped,
reason:done job240093]
2012/07/16 21:24:02.471| AsyncJob destructed, this=0x54fb728
type=AccessCheck [job240093]
2012/07/16 21:24:02.471| AsyncJob.cc(139) callEnd: AsyncJob::start()
ended 0x54fb728
2012/07/16 21:24:02.471| leaving AsyncJob::start()
2012/07/16 21:24:02.792| ConnStateData will NOT delete in-call job,
reason: ConnStateData::connStateClosed
2012/07/16 21:24:02.792| ConnStateData::connStateClosed(FD 37,
data=0x998cd58) ends job [Stopped, reason:ConnStateData::connStateClosed
job240089]
2012/07/16 21:24:02.792| The AsyncCall Initiate::noteInitiatorAborted
constructed, this=0xc67500 [call8112496]
2012/07/16 21:24:02.792| Initiator.cc(28) will call
Initiate::noteInitiatorAborted() [call8112496]
2012/07/16 21:24:02.792| AsyncJob destructed, this=0xab4638
type=ClientHttpRequest [job240090]
2012/07/16 21:24:02.792| AsyncJob destructed, this=0x998cf10
type=ConnStateData [job240089]
2012/07/16 21:24:02.792| AsyncJob.cc(139) callEnd:
ConnStateData::connStateClosed(FD 37, data=0x998cd58) ended 0x998cf10
2012/07/16 21:24:02.793| entering Initiate::noteInitiatorAborted()
2012/07/16 21:24:02.793| AsyncCall.cc(32) make: make call
Initiate::noteInitiatorAborted [call8112496]
2012/07/16 21:24:02.793| AsyncCall.cc(42) make: will not call
Initiate::noteInitiatorAborted [call8112496] because of job gone
2012/07/16 21:24:02.793| leaving Initiate::noteInitiatorAborted()
2012/07/16 21:24:02.793| HttpStateData will NOT delete in-call job,
reason: HttpStateData::httpStateConnClosed
2012/07/16 21:24:02.793| HttpStateData::httpStateConnClosed(FD 38,
data=0x165dbdc8) ends job [Stopped,
reason:HttpStateData::httpStateConnClosed job240092]
2012/07/16 21:24:02.793| The AsyncCall Initiate::noteInitiatorAborted
constructed, this=0x5762de0 [call8112500]
2012/07/16 21:24:02.793| Initiator.cc(28) will call
Initiate::noteInitiatorAborted() [call8112500]
2012/07/16 21:24:02.793| ctx: enter level 0: 'http://www.xxx.com/'
2012/07/16 21:24:02.793| HttpRequest.cc(63) ~HttpRequest: destructed,
this=0x3376130
2012/07/16 21:24:02.794| ctx: exit level 0
2012/07/16 21:24:02.794| AsyncJob destructed, this=0x165dbeb8
type=HttpStateData [job240092]
2012/07/16 21:24:02.794| AsyncJob.cc(139) callEnd:
HttpStateData::httpStateConnClosed(FD 38, data=0x165dbdc8) ended 0x165dbeb8
2012/07/16 21:24:02.794| entering Initiate::noteInitiatorAborted()
2012/07/16 21:24:02.794| AsyncCall.cc(32) make: make call
Initiate::noteInitiatorAborted [call8112500]
2012/07/16 21:24:02.794| AsyncCall.cc(42) make: will not call
Initiate::noteInitiatorAborted [call8112500] because of job gone
2012/07/16 21:24:02.794| leaving Initiate::noteInitiatorAborted()
><SNIPPED long doubled lines)
2012/07/16 21:26:50.118| ctx: enter level 0: 'http://www.xxx.com/'
2012/07/16 21:26:50.118| 0x2a80950: joined for id 54: chunked
2012/07/16 21:26:50.118| 0x2a80950: joined for id 8: 0x7fffab1a2050
2012/07/16 21:26:50.119| 0x2a80950: joined for id 9: close
2012/07/16 21:26:50.119| 0x2a80950: joined for id 54: chunked
2012/07/16 21:26:50.119| ctx: exit level 0
2012/07/16 21:26:50.119| 0xd748d10: joined for id 8: 0x7fffab1a1cf0
2012/07/16 21:26:50.119| 0xd748d10: joined for id 9: close
2012/07/16 21:26:50.119| 0xd748d10: joined for id 9: 0x7fffab1a1ab0

and level 55 on squid 3.1.20:

2012/07/16 21:27:51.309| init-ing hdr: 0x17edfdb0 owner: 2
2012/07/16 21:27:51.309| parsing hdr: (0x17edfdb0)
User-Agent: curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0
OpenSSL/0.9.8o zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6
Host: www.xxx.com
Accept: */*

2012/07/16 21:27:51.309| parsing HttpHeaderEntry: near 'User-Agent:
curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6'
2012/07/16 21:27:51.309| parsed HttpHeaderEntry: 'User-Agent:
curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6'
2012/07/16 21:27:51.309| created HttpHeaderEntry 0x23cd640: 'User-Agent
: curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6
2012/07/16 21:27:51.309| 0x17edfdb0 adding entry: 58 at 0
2012/07/16 21:27:51.309| parsing HttpHeaderEntry: near 'Host: www.xxx.com'
2012/07/16 21:27:51.310| parsed HttpHeaderEntry: 'Host: www.xxx.com'
2012/07/16 21:27:51.310| created HttpHeaderEntry 0x16156fe0: 'Host :
www.xxx.com
2012/07/16 21:27:51.310| 0x17edfdb0 adding entry: 26 at 1
2012/07/16 21:27:51.310| parsing HttpHeaderEntry: near 'Accept: */*'
2012/07/16 21:27:51.310| parsed HttpHeaderEntry: 'Accept: */*'
2012/07/16 21:27:51.310| created HttpHeaderEntry 0x15a232a0: 'Accept : */*
2012/07/16 21:27:51.310| 0x17edfdb0 adding entry: 0 at 2
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 54
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 54
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 24
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 41
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 9
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 66
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 37
2012/07/16 21:27:51.310| 0x17edfdb0 del-by-id 44
2012/07/16 21:27:51.310| 0x17edfdb0 del-by-id 45
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 7
2012/07/16 21:27:51.310| 0x17edfdb0 lookup for 7
2012/07/16 21:27:51.311| 0x17edfdb0 lookup for 40
2012/07/16 21:27:51.311| 0x17edfdb0 lookup for 60
2012/07/16 21:27:51.311| init-ing hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.311| 0x330ae40 lookup for 41
2012/07/16 21:27:51.311| 0x330ae40 lookup for 9
2012/07/16 21:27:51.311| 0x330ae40 lookup for 23
2012/07/16 21:27:51.324| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.326| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.367| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.369| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.370| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.372| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.374| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.427| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.429| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.463| init-ing hdr: 0x7fffab1a1fb0 owner: 2
2012/07/16 21:27:51.463| 0x17edfdb0joining for id 9
2012/07/16 21:27:51.463| created HttpHeaderEntry 0x2767d60: 'User-Agent
: curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6
2012/07/16 21:27:51.463| 0x7fffab1a1fb0 adding entry: 58 at 0
2012/07/16 21:27:51.463| created HttpHeaderEntry 0x9891990: 'Host :
www.xxx.com
2012/07/16 21:27:51.463| 0x7fffab1a1fb0 adding entry: 26 at 1
2012/07/16 21:27:51.463| created HttpHeaderEntry 0x601dd10: 'Accept : */*
2012/07/16 21:27:51.463| 0x7fffab1a1fb0 adding entry: 0 at 2
2012/07/16 21:27:51.463| 0x17edfdb0joining for id 60
2012/07/16 21:27:51.464| created HttpHeaderEntry 0x5a5e940: 'Via : 1.1
www1.ngtech.co.il (squid/3.1.20)
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 adding entry: 60 at 3
2012/07/16 21:27:51.464| 0x17edfdb0joining for id 66
2012/07/16 21:27:51.464| created HttpHeaderEntry 0x15bd5910:
'X-Forwarded-For : 192.168.10.244
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 adding entry: 66 at 4
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 lookup for 26
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 lookup for 7
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 del-by-id 8
2012/07/16 21:27:51.464| created HttpHeaderEntry 0x12cd3f70:
'Cache-Control : max-age=259200
2012/07/16 21:27:51.464| 0x7fffab1a1fb0 adding entry: 8 at 5
2012/07/16 21:27:51.465| created HttpHeaderEntry 0x4788ed0: 'Connection
: keep-alive
2012/07/16 21:27:51.465| 0x7fffab1a1fb0 adding entry: 9 at 6
2012/07/16 21:27:51.465| 0x7fffab1a1fb0 lookup for 7
2012/07/16 21:27:51.465| packing hdr: (0x7fffab1a1fb0)
2012/07/16 21:27:51.465| cleaning hdr: 0x7fffab1a1fb0 owner: 2
2012/07/16 21:27:51.465| destroying entry 0x2767d60: 'User-Agent:
curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6'
2012/07/16 21:27:51.465| destroying entry 0x9891990: 'Host: www.xxx.com'
2012/07/16 21:27:51.465| destroying entry 0x601dd10: 'Accept: */*'
2012/07/16 21:27:51.465| destroying entry 0x5a5e940: 'Via: 1.1
www1.ngtech.co.il (squid/3.1.20)'
2012/07/16 21:27:51.465| destroying entry 0x15bd5910: 'X-Forwarded-For:
192.168.10.244'
2012/07/16 21:27:51.465| destroying entry 0x12cd3f70: 'Cache-Control:
max-age=259200'
2012/07/16 21:27:51.465| destroying entry 0x4788ed0: 'Connection:
keep-alive'
2012/07/16 21:27:51.465| cleaning hdr: 0x7fffab1a1fb0 owner: 2
2012/07/16 21:27:51.468| 0x1153ac10 lookup for 54
<SNIPPPED DOUBLED LINES>
2012/07/16 21:27:51.653| ctx: enter level 0: 'http://www.xxx.com/'
2012/07/16 21:27:51.653| init-ing hdr: 0x24bc720 owner: 3
2012/07/16 21:27:51.653| 0x24bc720 lookup for 41
2012/07/16 21:27:51.653| 0x24bc720 lookup for 9
2012/07/16 21:27:51.653| 0x24bc720 lookup for 23
2012/07/16 21:27:51.653| parsing hdr: (0x24bc720)
Date: Mon, 16 Jul 2012 18:29:14 GMT
Server: Apache/2.2.3 (CentOS)
X-Powered-By: PHP/5.3.3
Set-Cookie: PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/
Expires: Thu, 19 Nov 1981 08:52:00 GMT
Cache-Control: no-store, no-cache, must-revalidate, post-check=0,
pre-check=0
Pragma: no-cache
Connection: close
Transfer-Encoding: chunked
Content-Type: text/html; charset=UTF-8

2012/07/16 21:27:51.653| parsing HttpHeaderEntry: near 'Date: Mon, 16
Jul 2012 18:29:14 GMT'
2012/07/16 21:27:51.654| parsed HttpHeaderEntry: 'Date: Mon, 16 Jul 2012
18:29:14 GMT'
2012/07/16 21:27:51.654| created HttpHeaderEntry 0x4788ed0: 'Date : Mon,
16 Jul 2012 18:29:14 GMT
2012/07/16 21:27:51.654| 0x24bc720 adding entry: 21 at 0
2012/07/16 21:27:51.654| parsing HttpHeaderEntry: near 'Server:
Apache/2.2.3 (CentOS)'
2012/07/16 21:27:51.654| parsed HttpHeaderEntry: 'Server: Apache/2.2.3
(CentOS)'
2012/07/16 21:27:51.654| created HttpHeaderEntry 0x12cd3f70: 'Server :
Apache/2.2.3 (CentOS)
2012/07/16 21:27:51.654| 0x24bc720 adding entry: 48 at 1
2012/07/16 21:27:51.654| parsing HttpHeaderEntry: near 'X-Powered-By:
PHP/5.3.3'
2012/07/16 21:27:51.654| parsed HttpHeaderEntry: 'X-Powered-By: PHP/5.3.3'
2012/07/16 21:27:51.654| created HttpHeaderEntry 0x15bd5910:
'X-Powered-By : PHP/5.3.3
2012/07/16 21:27:51.654| 0x24bc720 adding entry: 74 at 2
2012/07/16 21:27:51.654| parsing HttpHeaderEntry: near 'Set-Cookie:
PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/'
2012/07/16 21:27:51.654| parsed HttpHeaderEntry: 'Set-Cookie:
PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/'
2012/07/16 21:27:51.654| created HttpHeaderEntry 0x5a5e940: 'Set-Cookie
: PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/
2012/07/16 21:27:51.654| 0x24bc720 adding entry: 49 at 3
2012/07/16 21:27:51.654| parsing HttpHeaderEntry: near 'Expires: Thu, 19
Nov 1981 08:52:00 GMT'
2012/07/16 21:27:51.655| parsed HttpHeaderEntry: 'Expires: Thu, 19 Nov
1981 08:52:00 GMT'
2012/07/16 21:27:51.655| created HttpHeaderEntry 0x601dd10: 'Expires :
Thu, 19 Nov 1981 08:52:00 GMT
2012/07/16 21:27:51.655| 0x24bc720 adding entry: 23 at 4
2012/07/16 21:27:51.655| parsing HttpHeaderEntry: near 'Cache-Control:
no-store, no-cache, must-revalidate, post-check=0, pre-check=0'
2012/07/16 21:27:51.655| parsed HttpHeaderEntry: 'Cache-Control:
no-store, no-cache, must-revalidate, post-check=0, pre-check=0'
2012/07/16 21:27:51.655| created HttpHeaderEntry 0x9891990:
'Cache-Control : no-store, no-cache, must-revalidate, post-check=0,
pre-check=0
2012/07/16 21:27:51.655| 0x24bc720 adding entry: 8 at 5
2012/07/16 21:27:51.655| parsing HttpHeaderEntry: near 'Pragma: no-cache'
2012/07/16 21:27:51.655| parsed HttpHeaderEntry: 'Pragma: no-cache'
2012/07/16 21:27:51.655| created HttpHeaderEntry 0x2767d60: 'Pragma :
no-cache
2012/07/16 21:27:51.655| 0x24bc720 adding entry: 37 at 6
2012/07/16 21:27:51.655| parsing HttpHeaderEntry: near 'Connection: close'
2012/07/16 21:27:51.655| parsed HttpHeaderEntry: 'Connection: close'
2012/07/16 21:27:51.655| created HttpHeaderEntry 0x1331c010: 'Connection
: close
2012/07/16 21:27:51.655| 0x24bc720 adding entry: 9 at 7
2012/07/16 21:27:51.655| parsing HttpHeaderEntry: near
'Transfer-Encoding: chunked'
2012/07/16 21:27:51.655| parsed HttpHeaderEntry: 'Transfer-Encoding:
chunked'
2012/07/16 21:27:51.655| created HttpHeaderEntry 0x14a0d2f0:
'Transfer-Encoding : chunked
2012/07/16 21:27:51.656| 0x24bc720 adding entry: 54 at 8
2012/07/16 21:27:51.656| parsing HttpHeaderEntry: near 'Content-Type:
text/html; charset=UTF-8'
2012/07/16 21:27:51.656| parsed HttpHeaderEntry: 'Content-Type:
text/html; charset=UTF-8'
2012/07/16 21:27:51.656| created HttpHeaderEntry 0x1682d9c0:
'Content-Type : text/html; charset=UTF-8
2012/07/16 21:27:51.656| 0x24bc720 adding entry: 18 at 9
2012/07/16 21:27:51.656| 0x24bc720 lookup for 54
2012/07/16 21:27:51.656| 0x24bc720joining for id 54
2012/07/16 21:27:51.656| 0x24bc720: joined for id 54: chunked
2012/07/16 21:27:51.656| 0x24bc720 del-by-id 14
2012/07/16 21:27:51.656| 0x24bc720 joining for id 8
2012/07/16 21:27:51.656| 0x24bc720: joined for id 8: 0x7fffab1a2050
2012/07/16 21:27:51.656| 0x24bc720 lookup for 41
2012/07/16 21:27:51.656| 0x24bc720 lookup for 9
2012/07/16 21:27:51.656| 0x24bc720joining for id 9
2012/07/16 21:27:51.656| 0x24bc720: joined for id 9: close
2012/07/16 21:27:51.657| 0x24bc720 lookup for 23
2012/07/16 21:27:51.657| 0x24bc720 joining for id 61
2012/07/16 21:27:51.657| 0x24bc720 lookup for 54
2012/07/16 21:27:51.657| 0x24bc720joining for id 54
2012/07/16 21:27:51.657| 0x24bc720: joined for id 54: chunked
2012/07/16 21:27:51.657| ctx: exit level 0
2012/07/16 21:27:51.657| cleaning hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.657| cleaning hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.657| packing hdr: (0x24bc720)
2012/07/16 21:27:51.657| ctx: enter level 0: 'http://www.xxx.com/'
2012/07/16 21:27:51.657| 0x24bc720 lookup for 59
2012/07/16 21:27:51.657| ctx: exit level 0
2012/07/16 21:27:51.658| init-ing hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.658| 0x330ae40 lookup for 41
2012/07/16 21:27:51.658| 0x330ae40 lookup for 9
2012/07/16 21:27:51.658| 0x330ae40 lookup for 23
2012/07/16 21:27:51.658| appending hdr: 0x330ae40 += 0x24bc720
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x3d1d640: 'Date : Mon,
16 Jul 2012 18:29:14 GMT
2012/07/16 21:27:51.658| 0x330ae40 adding entry: 21 at 0
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x2aec660: 'Server :
Apache/2.2.3 (CentOS)
2012/07/16 21:27:51.658| 0x330ae40 adding entry: 48 at 1
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x17ee0b70:
'X-Powered-By : PHP/5.3.3
2012/07/16 21:27:51.658| 0x330ae40 adding entry: 74 at 2
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x99ed670: 'Set-Cookie
: PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/
2012/07/16 21:27:51.658| 0x330ae40 adding entry: 49 at 3
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x601dc20: 'Expires :
Thu, 19 Nov 1981 08:52:00 GMT
2012/07/16 21:27:51.658| 0x330ae40 adding entry: 23 at 4
2012/07/16 21:27:51.658| created HttpHeaderEntry 0x8f85a30:
'Cache-Control : no-store, no-cache, must-revalidate, post-check=0,
pre-check=0
2012/07/16 21:27:51.659| 0x330ae40 adding entry: 8 at 5
2012/07/16 21:27:51.659| created HttpHeaderEntry 0x1682a8b0: 'Pragma :
no-cache
2012/07/16 21:27:51.659| 0x330ae40 adding entry: 37 at 6
2012/07/16 21:27:51.659| created HttpHeaderEntry 0x149ff450: 'Connection
: close
2012/07/16 21:27:51.659| 0x330ae40 adding entry: 9 at 7
2012/07/16 21:27:51.659| created HttpHeaderEntry 0x147d98e0:
'Transfer-Encoding : chunked
2012/07/16 21:27:51.659| 0x330ae40 adding entry: 54 at 8
2012/07/16 21:27:51.659| created HttpHeaderEntry 0x9e42b50:
'Content-Type : text/html; charset=UTF-8
2012/07/16 21:27:51.659| 0x330ae40 adding entry: 18 at 9
2012/07/16 21:27:51.659| 0x330ae40 joining for id 8
2012/07/16 21:27:51.659| 0x330ae40: joined for id 8: 0x7fffab1a1cf0
2012/07/16 21:27:51.659| 0x330ae40 lookup for 41
2012/07/16 21:27:51.659| 0x330ae40 lookup for 9
2012/07/16 21:27:51.659| 0x330ae40joining for id 9
2012/07/16 21:27:51.659| 0x330ae40: joined for id 9: close
2012/07/16 21:27:51.659| 0x330ae40 lookup for 23
2012/07/16 21:27:51.660| 0x330ae40 del-by-id 38
2012/07/16 21:27:51.660| 0x330ae40 lookup for 9
2012/07/16 21:27:51.660| 0x330ae40 joining for id 9
2012/07/16 21:27:51.660| 0x330ae40: joined for id 9: 0x7fffab1a1ab0
2012/07/16 21:27:51.660| destroying entry 0x149ff450: 'Connection: close'
2012/07/16 21:27:51.660| destroying entry 0x147d98e0:
'Transfer-Encoding: chunked'
2012/07/16 21:27:51.660| 0x330ae40 lookup for 21
2012/07/16 21:27:51.660| 0x330ae40 lookup for 62
2012/07/16 21:27:51.660| created HttpHeaderEntry 0x147d98e0: 'X-Cache :
MISS from www1.ngtech.co.il
2012/07/16 21:27:51.660| 0x330ae40 adding entry: 64 at 10
2012/07/16 21:27:51.660| 0x330ae40 joining for id 60
2012/07/16 21:27:51.660| 0x330ae40 del-by-id 60
2012/07/16 21:27:51.660| created HttpHeaderEntry 0x149ff450: 'Via : 1.0
www1.ngtech.co.il (squid/3.1.20)
2012/07/16 21:27:51.660| 0x330ae40 adding entry: 60 at 11
2012/07/16 21:27:51.660| created HttpHeaderEntry 0x99ed5d0: 'Connection
: close
2012/07/16 21:27:51.660| 0x330ae40 adding entry: 9 at 12
2012/07/16 21:27:51.661| packing hdr: (0x330ae40)
2012/07/16 21:27:51.797| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.797| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.836| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.894| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.896| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.898| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.943| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.945| 0x1153ac10 lookup for 54
2012/07/16 21:27:51.973| cleaning hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.973| destroying entry 0x3d1d640: 'Date: Mon, 16 Jul
2012 18:29:14 GMT'
2012/07/16 21:27:51.973| destroying entry 0x2aec660: 'Server:
Apache/2.2.3 (CentOS)'
2012/07/16 21:27:51.973| destroying entry 0x17ee0b70: 'X-Powered-By:
PHP/5.3.3'
2012/07/16 21:27:51.974| destroying entry 0x99ed670: 'Set-Cookie:
PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/'
2012/07/16 21:27:51.974| destroying entry 0x601dc20: 'Expires: Thu, 19
Nov 1981 08:52:00 GMT'
2012/07/16 21:27:51.974| destroying entry 0x8f85a30: 'Cache-Control:
no-store, no-cache, must-revalidate, post-check=0, pre-check=0'
2012/07/16 21:27:51.974| destroying entry 0x1682a8b0: 'Pragma: no-cache'
2012/07/16 21:27:51.974| destroying entry 0x9e42b50: 'Content-Type:
text/html; charset=UTF-8'
2012/07/16 21:27:51.974| destroying entry 0x147d98e0: 'X-Cache: MISS
from www1.ngtech.co.il'
2012/07/16 21:27:51.974| destroying entry 0x149ff450: 'Via: 1.0
www1.ngtech.co.il (squid/3.1.20)'
2012/07/16 21:27:51.974| destroying entry 0x99ed5d0: 'Connection: close'
2012/07/16 21:27:51.974| cleaning hdr: 0x330ae40 owner: 3
2012/07/16 21:27:51.974| ctx: enter level 0: 'http://www.xxx.com/'
2012/07/16 21:27:51.974| cleaning hdr: 0x24bc720 owner: 3
2012/07/16 21:27:51.975| destroying entry 0x4788ed0: 'Date: Mon, 16 Jul
2012 18:29:14 GMT'
2012/07/16 21:27:51.975| destroying entry 0x12cd3f70: 'Server:
Apache/2.2.3 (CentOS)'
2012/07/16 21:27:51.975| destroying entry 0x15bd5910: 'X-Powered-By:
PHP/5.3.3'
2012/07/16 21:27:51.975| destroying entry 0x5a5e940: 'Set-Cookie:
PHPSESSID=9f72ocsgekm49omma4kil3o4t0; path=/'
2012/07/16 21:27:51.975| destroying entry 0x601dd10: 'Expires: Thu, 19
Nov 1981 08:52:00 GMT'
2012/07/16 21:27:51.975| destroying entry 0x9891990: 'Cache-Control:
no-store, no-cache, must-revalidate, post-check=0, pre-check=0'
2012/07/16 21:27:51.975| destroying entry 0x2767d60: 'Pragma: no-cache'
2012/07/16 21:27:51.975| destroying entry 0x1331c010: 'Connection: close'
2012/07/16 21:27:51.975| destroying entry 0x14a0d2f0:
'Transfer-Encoding: chunked'
2012/07/16 21:27:51.975| destroying entry 0x1682d9c0: 'Content-Type:
text/html; charset=UTF-8'
2012/07/16 21:27:51.975| cleaning hdr: 0x24bc720 owner: 3
2012/07/16 21:27:51.975| cleaning hdr: 0x17edfdb0 owner: 2
2012/07/16 21:27:51.975| destroying entry 0x23cd640: 'User-Agent:
curl/7.21.0 (i486-pc-linux-gnu) libcurl/7.21.0 OpenSSL/0.9.8o
zlib/1.2.3.4 libidn/1.15 libssh2/1.2.6'
2012/07/16 21:27:51.976| destroying entry 0x16156fe0: 'Host: www.xxx.com'
2012/07/16 21:27:51.976| destroying entry 0x15a232a0: 'Accept: */*'
2012/07/16 21:27:51.976| cleaning hdr: 0x17edfdb0 owner: 2
2012/07/16 21:27:51.994| ctx: exit level 0

-- 
Eliezer Croitoru
https://www1.ngtech.co.il
IT consulting for Nonprofit organizations
eliezer <at> ngtech.co.il

Received on Mon Jul 16 2012 - 18:40:12 MDT

This archive was generated by hypermail 2.2.0 : Tue Jul 17 2012 - 12:00:02 MDT