Skip to content

Instantly share code, notes, and snippets.

@erkie

erkie/cache.log Secret

Created January 6, 2013 11:51
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save erkie/742b7320b7055f18304c to your computer and use it in GitHub Desktop.
Save erkie/742b7320b7055f18304c to your computer and use it in GitHub Desktop.
Download ZIP
Squid cache log with debug_options ALL,9 trying to access https site.
Raw
cache.log
2013/01/06 06:43:10.522| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:10.522| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:10.522| fd_open() FD 247 HTTP Request
2013/01/06 06:43:10.522| AcceptFD::acceptOne accepted: FD 22 newfd: 247 from: 83.251.135.227:61083 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:10.522| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 247) [call2083]
2013/01/06 06:43:10.522| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 247)
2013/01/06 06:43:10.522| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2083]
2013/01/06 06:43:10.522| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:10.522| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:10.522| cbdataLock: 0xb78880f8=230
2013/01/06 06:43:10.522| cbdataLock: 0xb78880f8=231
2013/01/06 06:43:10.523| The AsyncCall SomeCommAcceptHandler constructed, this=0xb795ee88 [call2106]
2013/01/06 06:43:10.523| cbdataLock: 0xb78880f8=232
2013/01/06 06:43:10.523| cbdataUnlock: 0xb78880f8=231
2013/01/06 06:43:10.523| cbdataUnlock: 0xb78880f8=230
2013/01/06 06:43:10.523| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:10.523| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb795ee88*2
2013/01/06 06:43:10.523| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:10.523| httpAccept: FD 247: accepted
2013/01/06 06:43:10.523| AsyncJob constructed, this=0xb7bf22d4 type=ConnStateData [job321]
2013/01/06 06:43:10.523| cbdataLock: 0xb78880f8=231
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=1
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=2
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=3
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=4
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=3
2013/01/06 06:43:10.523| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf32f8 [call2107]
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=4
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=5
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=4
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=3
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=2
2013/01/06 06:43:10.523| comm_add_close_handler: FD 247, AsyncCall=0xb7bf32f8*1
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=3
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=4
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=5
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=6
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=5
2013/01/06 06:43:10.523| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf3348 [call2108]
2013/01/06 06:43:10.523| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=6
2013/01/06 06:43:10.523| cbdataLock: 0xb7bf21a8=7
2013/01/06 06:43:10.523| cbdataUnlock: 0xb7bf21a8=6
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=5
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=4
2013/01/06 06:43:10.524| comm.cc(1207) commSetTimeout: FD 247 timeout 300
2013/01/06 06:43:10.524| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:10.524| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:10.524| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:10.524| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:10.524| ACLList::matches: checking all
2013/01/06 06:43:10.524| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:10.524| aclIpAddrNetworkCompare: compare: 83.251.135.227:61083/[::] ([::]:61083) vs [::]-[::]/[::]
2013/01/06 06:43:10.524| aclIpMatchIp: '83.251.135.227:61083' found
2013/01/06 06:43:10.524| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:10.524| ACLList::matches: result is true
2013/01/06 06:43:10.524| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:10.524| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:10.524| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:10.524| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:10.524| clientReadSomeData: FD 247: reading request...
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=5
2013/01/06 06:43:10.524| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=6
2013/01/06 06:43:10.524| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=7
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=8
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=7
2013/01/06 06:43:10.524| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf3398 [call2109]
2013/01/06 06:43:10.524| cbdataReferenceValid: 0xb7bf21a8
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=8
2013/01/06 06:43:10.524| cbdataLock: 0xb7bf21a8=9
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=8
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=7
2013/01/06 06:43:10.524| cbdataUnlock: 0xb7bf21a8=6
2013/01/06 06:43:10.524| comm_read, queueing read for FD 247; asynCall 0xb7bf3398*1
2013/01/06 06:43:10.524| commSetSelect(FD 247,type=1,handler=1,client_data=0xb53b6960,timeout=0)
2013/01/06 06:43:10.525| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 247)
2013/01/06 06:43:10.525| cbdataUnlock: 0xb78880f8=230
2013/01/06 06:43:10.525| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.525| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.631| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:10.631| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:10.631| fd_open() FD 248 HTTP Request
2013/01/06 06:43:10.631| AcceptFD::acceptOne accepted: FD 22 newfd: 248 from: 83.251.135.227:61084 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:10.631| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 248) [call2106]
2013/01/06 06:43:10.631| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 248)
2013/01/06 06:43:10.631| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2106]
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:10.632| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:10.632| cbdataLock: 0xb78880f8=231
2013/01/06 06:43:10.632| cbdataLock: 0xb78880f8=232
2013/01/06 06:43:10.632| The AsyncCall SomeCommAcceptHandler constructed, this=0xb79643b8 [call2110]
2013/01/06 06:43:10.632| cbdataLock: 0xb78880f8=233
2013/01/06 06:43:10.632| cbdataUnlock: 0xb78880f8=232
2013/01/06 06:43:10.632| cbdataUnlock: 0xb78880f8=231
2013/01/06 06:43:10.632| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:10.632| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb79643b8*2
2013/01/06 06:43:10.632| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:10.632| httpAccept: FD 248: accepted
2013/01/06 06:43:10.632| AsyncJob constructed, this=0xb7bf352c type=ConnStateData [job322]
2013/01/06 06:43:10.632| cbdataLock: 0xb78880f8=232
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=1
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=2
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=3
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=4
2013/01/06 06:43:10.632| cbdataUnlock: 0xb7bf3400=3
2013/01/06 06:43:10.632| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf4550 [call2111]
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=4
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=5
2013/01/06 06:43:10.632| cbdataUnlock: 0xb7bf3400=4
2013/01/06 06:43:10.632| cbdataUnlock: 0xb7bf3400=3
2013/01/06 06:43:10.632| cbdataUnlock: 0xb7bf3400=2
2013/01/06 06:43:10.632| comm_add_close_handler: FD 248, AsyncCall=0xb7bf4550*1
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=3
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=4
2013/01/06 06:43:10.632| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=5
2013/01/06 06:43:10.632| cbdataLock: 0xb7bf3400=6
2013/01/06 06:43:10.632| cbdataUnlock: 0xb7bf3400=5
2013/01/06 06:43:10.633| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf45a0 [call2112]
2013/01/06 06:43:10.633| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=6
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=7
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=6
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=5
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=4
2013/01/06 06:43:10.633| comm.cc(1207) commSetTimeout: FD 248 timeout 300
2013/01/06 06:43:10.633| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:10.633| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:10.633| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:10.633| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:10.633| ACLList::matches: checking all
2013/01/06 06:43:10.633| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:10.633| aclIpAddrNetworkCompare: compare: 83.251.135.227:61084/[::] ([::]:61084) vs [::]-[::]/[::]
2013/01/06 06:43:10.633| aclIpMatchIp: '83.251.135.227:61084' found
2013/01/06 06:43:10.633| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:10.633| ACLList::matches: result is true
2013/01/06 06:43:10.633| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:10.633| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:10.633| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:10.633| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:10.633| clientReadSomeData: FD 248: reading request...
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=5
2013/01/06 06:43:10.633| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=6
2013/01/06 06:43:10.633| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=7
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=8
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=7
2013/01/06 06:43:10.633| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf45f0 [call2113]
2013/01/06 06:43:10.633| cbdataReferenceValid: 0xb7bf3400
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=8
2013/01/06 06:43:10.633| cbdataLock: 0xb7bf3400=9
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=8
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=7
2013/01/06 06:43:10.633| cbdataUnlock: 0xb7bf3400=6
2013/01/06 06:43:10.633| comm_read, queueing read for FD 248; asynCall 0xb7bf45f0*1
2013/01/06 06:43:10.633| commSetSelect(FD 248,type=1,handler=1,client_data=0xb53b69ac,timeout=0)
2013/01/06 06:43:10.634| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 248)
2013/01/06 06:43:10.634| cbdataUnlock: 0xb78880f8=231
2013/01/06 06:43:10.634| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.634| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.749| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:10.749| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:10.749| fd_open() FD 249 HTTP Request
2013/01/06 06:43:10.750| AcceptFD::acceptOne accepted: FD 22 newfd: 249 from: 83.251.135.227:61085 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:10.750| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 249) [call2110]
2013/01/06 06:43:10.750| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 249)
2013/01/06 06:43:10.750| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2110]
2013/01/06 06:43:10.750| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:10.750| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:10.750| cbdataLock: 0xb78880f8=232
2013/01/06 06:43:10.750| cbdataLock: 0xb78880f8=233
2013/01/06 06:43:10.750| The AsyncCall SomeCommAcceptHandler constructed, this=0xb795ee88 [call2114]
2013/01/06 06:43:10.750| cbdataLock: 0xb78880f8=234
2013/01/06 06:43:10.750| cbdataUnlock: 0xb78880f8=233
2013/01/06 06:43:10.750| cbdataUnlock: 0xb78880f8=232
2013/01/06 06:43:10.750| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:10.750| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb795ee88*2
2013/01/06 06:43:10.750| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:10.750| httpAccept: FD 249: accepted
2013/01/06 06:43:10.750| AsyncJob constructed, this=0xb7bf4784 type=ConnStateData [job323]
2013/01/06 06:43:10.750| cbdataLock: 0xb78880f8=233
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=1
2013/01/06 06:43:10.750| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=2
2013/01/06 06:43:10.750| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=3
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=4
2013/01/06 06:43:10.750| cbdataUnlock: 0xb7bf4658=3
2013/01/06 06:43:10.750| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf57a8 [call2115]
2013/01/06 06:43:10.750| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=4
2013/01/06 06:43:10.750| cbdataLock: 0xb7bf4658=5
2013/01/06 06:43:10.750| cbdataUnlock: 0xb7bf4658=4
2013/01/06 06:43:10.750| cbdataUnlock: 0xb7bf4658=3
2013/01/06 06:43:10.750| cbdataUnlock: 0xb7bf4658=2
2013/01/06 06:43:10.750| comm_add_close_handler: FD 249, AsyncCall=0xb7bf57a8*1
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=3
2013/01/06 06:43:10.751| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=4
2013/01/06 06:43:10.751| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=5
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=6
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7bf4658=5
2013/01/06 06:43:10.751| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf57f8 [call2116]
2013/01/06 06:43:10.751| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=6
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=7
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7bf4658=6
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7bf4658=5
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7bf4658=4
2013/01/06 06:43:10.751| comm.cc(1207) commSetTimeout: FD 249 timeout 300
2013/01/06 06:43:10.751| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:10.751| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:10.751| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:10.751| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:10.751| ACLList::matches: checking all
2013/01/06 06:43:10.751| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:10.751| aclIpAddrNetworkCompare: compare: 83.251.135.227:61085/[::] ([::]:61085) vs [::]-[::]/[::]
2013/01/06 06:43:10.751| aclIpMatchIp: '83.251.135.227:61085' found
2013/01/06 06:43:10.751| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:10.751| ACLList::matches: result is true
2013/01/06 06:43:10.751| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:10.751| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:10.751| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:10.751| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:10.751| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:10.751| clientReadSomeData: FD 249: reading request...
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=5
2013/01/06 06:43:10.751| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.751| cbdataLock: 0xb7bf4658=6
2013/01/06 06:43:10.752| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.752| cbdataLock: 0xb7bf4658=7
2013/01/06 06:43:10.752| cbdataLock: 0xb7bf4658=8
2013/01/06 06:43:10.752| cbdataUnlock: 0xb7bf4658=7
2013/01/06 06:43:10.752| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf5848 [call2117]
2013/01/06 06:43:10.752| cbdataReferenceValid: 0xb7bf4658
2013/01/06 06:43:10.752| cbdataLock: 0xb7bf4658=8
2013/01/06 06:43:10.752| cbdataLock: 0xb7bf4658=9
2013/01/06 06:43:10.752| cbdataUnlock: 0xb7bf4658=8
2013/01/06 06:43:10.752| cbdataUnlock: 0xb7bf4658=7
2013/01/06 06:43:10.752| cbdataUnlock: 0xb7bf4658=6
2013/01/06 06:43:10.752| comm_read, queueing read for FD 249; asynCall 0xb7bf5848*1
2013/01/06 06:43:10.752| commSetSelect(FD 249,type=1,handler=1,client_data=0xb53b69f8,timeout=0)
2013/01/06 06:43:10.752| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 249)
2013/01/06 06:43:10.752| cbdataUnlock: 0xb78880f8=232
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.753| event.cc(251) checkEvents: checkEvents
2013/01/06 06:43:10.753| The AsyncCall MaintainSwapSpace constructed, this=0xb7bba738 [call2118]
2013/01/06 06:43:10.753| event.cc(260) will call MaintainSwapSpace() [call2118]
2013/01/06 06:43:10.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.753| entering MaintainSwapSpace()
2013/01/06 06:43:10.753| AsyncCall.cc(32) make: make call MaintainSwapSpace [call2118]
2013/01/06 06:43:10.753| event.cc(343) schedule: schedule: Adding 'MaintainSwapSpace', in 1.00 seconds
2013/01/06 06:43:10.753| leaving MaintainSwapSpace()
2013/01/06 06:43:10.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.863| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:10.863| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:10.863| fd_open() FD 250 HTTP Request
2013/01/06 06:43:10.863| AcceptFD::acceptOne accepted: FD 22 newfd: 250 from: 83.251.135.227:61086 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:10.863| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 250) [call2114]
2013/01/06 06:43:10.863| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 250)
2013/01/06 06:43:10.864| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2114]
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:10.864| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:10.864| cbdataLock: 0xb78880f8=233
2013/01/06 06:43:10.864| cbdataLock: 0xb78880f8=234
2013/01/06 06:43:10.864| The AsyncCall SomeCommAcceptHandler constructed, this=0xb79643b8 [call2119]
2013/01/06 06:43:10.864| cbdataLock: 0xb78880f8=235
2013/01/06 06:43:10.864| cbdataUnlock: 0xb78880f8=234
2013/01/06 06:43:10.864| cbdataUnlock: 0xb78880f8=233
2013/01/06 06:43:10.864| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:10.864| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb79643b8*2
2013/01/06 06:43:10.864| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:10.864| httpAccept: FD 250: accepted
2013/01/06 06:43:10.864| AsyncJob constructed, this=0xb7bf59dc type=ConnStateData [job324]
2013/01/06 06:43:10.864| cbdataLock: 0xb78880f8=234
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=1
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=2
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=3
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=4
2013/01/06 06:43:10.864| cbdataUnlock: 0xb7bf58b0=3
2013/01/06 06:43:10.864| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf6a00 [call2120]
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=4
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=5
2013/01/06 06:43:10.864| cbdataUnlock: 0xb7bf58b0=4
2013/01/06 06:43:10.864| cbdataUnlock: 0xb7bf58b0=3
2013/01/06 06:43:10.864| cbdataUnlock: 0xb7bf58b0=2
2013/01/06 06:43:10.864| comm_add_close_handler: FD 250, AsyncCall=0xb7bf6a00*1
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=3
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=4
2013/01/06 06:43:10.864| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.864| cbdataLock: 0xb7bf58b0=5
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=6
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7bf58b0=5
2013/01/06 06:43:10.865| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf6a50 [call2121]
2013/01/06 06:43:10.865| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=6
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=7
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7bf58b0=6
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7bf58b0=5
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7bf58b0=4
2013/01/06 06:43:10.865| comm.cc(1207) commSetTimeout: FD 250 timeout 300
2013/01/06 06:43:10.865| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:10.865| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:10.865| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:10.865| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:10.865| ACLList::matches: checking all
2013/01/06 06:43:10.865| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:10.865| aclIpAddrNetworkCompare: compare: 83.251.135.227:61086/[::] ([::]:61086) vs [::]-[::]/[::]
2013/01/06 06:43:10.865| aclIpMatchIp: '83.251.135.227:61086' found
2013/01/06 06:43:10.865| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:10.865| ACLList::matches: result is true
2013/01/06 06:43:10.865| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:10.865| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:10.865| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:10.865| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:10.865| clientReadSomeData: FD 250: reading request...
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=5
2013/01/06 06:43:10.865| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=6
2013/01/06 06:43:10.865| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=7
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=8
2013/01/06 06:43:10.865| cbdataUnlock: 0xb7bf58b0=7
2013/01/06 06:43:10.865| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf6aa0 [call2122]
2013/01/06 06:43:10.865| cbdataReferenceValid: 0xb7bf58b0
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=8
2013/01/06 06:43:10.865| cbdataLock: 0xb7bf58b0=9
2013/01/06 06:43:10.866| cbdataUnlock: 0xb7bf58b0=8
2013/01/06 06:43:10.866| cbdataUnlock: 0xb7bf58b0=7
2013/01/06 06:43:10.866| cbdataUnlock: 0xb7bf58b0=6
2013/01/06 06:43:10.866| comm_read, queueing read for FD 250; asynCall 0xb7bf6aa0*1
2013/01/06 06:43:10.866| commSetSelect(FD 250,type=1,handler=1,client_data=0xb53b6a44,timeout=0)
2013/01/06 06:43:10.866| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 250)
2013/01/06 06:43:10.866| cbdataUnlock: 0xb78880f8=233
2013/01/06 06:43:10.866| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.866| Engine 0xbf95a124 is idle.
2013/01/06 06:43:10.975| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:10.975| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:10.975| fd_open() FD 251 HTTP Request
2013/01/06 06:43:10.975| AcceptFD::acceptOne accepted: FD 22 newfd: 251 from: 83.251.135.227:61087 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:10.975| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 251) [call2119]
2013/01/06 06:43:10.975| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 251)
2013/01/06 06:43:10.975| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2119]
2013/01/06 06:43:10.975| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:10.975| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:10.975| cbdataLock: 0xb78880f8=234
2013/01/06 06:43:10.975| cbdataLock: 0xb78880f8=235
2013/01/06 06:43:10.975| The AsyncCall SomeCommAcceptHandler constructed, this=0xb795ee88 [call2123]
2013/01/06 06:43:10.975| cbdataLock: 0xb78880f8=236
2013/01/06 06:43:10.975| cbdataUnlock: 0xb78880f8=235
2013/01/06 06:43:10.975| cbdataUnlock: 0xb78880f8=234
2013/01/06 06:43:10.975| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:10.975| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb795ee88*2
2013/01/06 06:43:10.975| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:10.975| httpAccept: FD 251: accepted
2013/01/06 06:43:10.975| AsyncJob constructed, this=0xb7bf6c34 type=ConnStateData [job325]
2013/01/06 06:43:10.975| cbdataLock: 0xb78880f8=235
2013/01/06 06:43:10.975| cbdataLock: 0xb7bf6b08=1
2013/01/06 06:43:10.975| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.975| cbdataLock: 0xb7bf6b08=2
2013/01/06 06:43:10.975| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.975| cbdataLock: 0xb7bf6b08=3
2013/01/06 06:43:10.975| cbdataLock: 0xb7bf6b08=4
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=3
2013/01/06 06:43:10.976| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf7c58 [call2124]
2013/01/06 06:43:10.976| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=4
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=5
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=4
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=3
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=2
2013/01/06 06:43:10.976| comm_add_close_handler: FD 251, AsyncCall=0xb7bf7c58*1
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=3
2013/01/06 06:43:10.976| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=4
2013/01/06 06:43:10.976| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=5
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=6
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=5
2013/01/06 06:43:10.976| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf7ca8 [call2125]
2013/01/06 06:43:10.976| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=6
2013/01/06 06:43:10.976| cbdataLock: 0xb7bf6b08=7
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=6
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=5
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7bf6b08=4
2013/01/06 06:43:10.976| comm.cc(1207) commSetTimeout: FD 251 timeout 300
2013/01/06 06:43:10.976| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:10.976| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:10.976| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:10.976| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:10.976| ACLList::matches: checking all
2013/01/06 06:43:10.976| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:10.976| aclIpAddrNetworkCompare: compare: 83.251.135.227:61087/[::] ([::]:61087) vs [::]-[::]/[::]
2013/01/06 06:43:10.976| aclIpMatchIp: '83.251.135.227:61087' found
2013/01/06 06:43:10.976| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:10.976| ACLList::matches: result is true
2013/01/06 06:43:10.976| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:10.976| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:10.976| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:10.976| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:10.976| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:10.976| clientReadSomeData: FD 251: reading request...
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=5
2013/01/06 06:43:10.977| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=6
2013/01/06 06:43:10.977| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=7
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=8
2013/01/06 06:43:10.977| cbdataUnlock: 0xb7bf6b08=7
2013/01/06 06:43:10.977| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf7cf8 [call2126]
2013/01/06 06:43:10.977| cbdataReferenceValid: 0xb7bf6b08
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=8
2013/01/06 06:43:10.977| cbdataLock: 0xb7bf6b08=9
2013/01/06 06:43:10.977| cbdataUnlock: 0xb7bf6b08=8
2013/01/06 06:43:10.977| cbdataUnlock: 0xb7bf6b08=7
2013/01/06 06:43:10.977| cbdataUnlock: 0xb7bf6b08=6
2013/01/06 06:43:10.977| comm_read, queueing read for FD 251; asynCall 0xb7bf7cf8*1
2013/01/06 06:43:10.977| commSetSelect(FD 251,type=1,handler=1,client_data=0xb53b6a90,timeout=0)
2013/01/06 06:43:10.977| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 251)
2013/01/06 06:43:10.977| cbdataUnlock: 0xb78880f8=234
2013/01/06 06:43:10.977| Engine 0xbf95a140 is idle.
2013/01/06 06:43:10.977| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.084| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:11.084| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:11.084| fd_open() FD 252 HTTP Request
2013/01/06 06:43:11.084| AcceptFD::acceptOne accepted: FD 22 newfd: 252 from: 83.251.135.227:61088 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:11.084| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 252) [call2123]
2013/01/06 06:43:11.084| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 252)
2013/01/06 06:43:11.084| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2123]
2013/01/06 06:43:11.084| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:11.084| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:11.084| cbdataLock: 0xb78880f8=235
2013/01/06 06:43:11.084| cbdataLock: 0xb78880f8=236
2013/01/06 06:43:11.084| The AsyncCall SomeCommAcceptHandler constructed, this=0xb79643b8 [call2127]
2013/01/06 06:43:11.085| cbdataLock: 0xb78880f8=237
2013/01/06 06:43:11.085| cbdataUnlock: 0xb78880f8=236
2013/01/06 06:43:11.085| cbdataUnlock: 0xb78880f8=235
2013/01/06 06:43:11.085| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:11.085| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb79643b8*2
2013/01/06 06:43:11.085| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:11.085| httpAccept: FD 252: accepted
2013/01/06 06:43:11.085| AsyncJob constructed, this=0xb7bf7e8c type=ConnStateData [job326]
2013/01/06 06:43:11.085| cbdataLock: 0xb78880f8=236
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=1
2013/01/06 06:43:11.085| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=2
2013/01/06 06:43:11.085| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=3
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=4
2013/01/06 06:43:11.085| cbdataUnlock: 0xb7bf7d60=3
2013/01/06 06:43:11.085| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bf8eb0 [call2128]
2013/01/06 06:43:11.085| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=4
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=5
2013/01/06 06:43:11.085| cbdataUnlock: 0xb7bf7d60=4
2013/01/06 06:43:11.085| cbdataUnlock: 0xb7bf7d60=3
2013/01/06 06:43:11.085| cbdataUnlock: 0xb7bf7d60=2
2013/01/06 06:43:11.085| comm_add_close_handler: FD 252, AsyncCall=0xb7bf8eb0*1
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=3
2013/01/06 06:43:11.085| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=4
2013/01/06 06:43:11.085| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=5
2013/01/06 06:43:11.085| cbdataLock: 0xb7bf7d60=6
2013/01/06 06:43:11.085| cbdataUnlock: 0xb7bf7d60=5
2013/01/06 06:43:11.085| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bf8f00 [call2129]
2013/01/06 06:43:11.086| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=6
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=7
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7bf7d60=6
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7bf7d60=5
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7bf7d60=4
2013/01/06 06:43:11.086| comm.cc(1207) commSetTimeout: FD 252 timeout 300
2013/01/06 06:43:11.086| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:11.086| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:11.086| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:11.086| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:11.086| ACLList::matches: checking all
2013/01/06 06:43:11.086| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:11.086| aclIpAddrNetworkCompare: compare: 83.251.135.227:61088/[::] ([::]:61088) vs [::]-[::]/[::]
2013/01/06 06:43:11.086| aclIpMatchIp: '83.251.135.227:61088' found
2013/01/06 06:43:11.086| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:11.086| ACLList::matches: result is true
2013/01/06 06:43:11.086| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:11.086| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:11.086| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:11.086| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:11.086| clientReadSomeData: FD 252: reading request...
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=5
2013/01/06 06:43:11.086| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=6
2013/01/06 06:43:11.086| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=7
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=8
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7bf7d60=7
2013/01/06 06:43:11.086| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bf8f50 [call2130]
2013/01/06 06:43:11.086| cbdataReferenceValid: 0xb7bf7d60
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=8
2013/01/06 06:43:11.086| cbdataLock: 0xb7bf7d60=9
2013/01/06 06:43:11.086| cbdataUnlock: 0xb7bf7d60=8
2013/01/06 06:43:11.087| cbdataUnlock: 0xb7bf7d60=7
2013/01/06 06:43:11.087| cbdataUnlock: 0xb7bf7d60=6
2013/01/06 06:43:11.087| comm_read, queueing read for FD 252; asynCall 0xb7bf8f50*1
2013/01/06 06:43:11.087| commSetSelect(FD 252,type=1,handler=1,client_data=0xb53b6adc,timeout=0)
2013/01/06 06:43:11.087| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 252)
2013/01/06 06:43:11.087| cbdataUnlock: 0xb78880f8=235
2013/01/06 06:43:11.087| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.087| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.198| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:11.198| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:11.198| fd_open() FD 253 HTTP Request
2013/01/06 06:43:11.198| AcceptFD::acceptOne accepted: FD 22 newfd: 253 from: 83.251.135.227:61089 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:11.198| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 253) [call2127]
2013/01/06 06:43:11.198| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 253)
2013/01/06 06:43:11.198| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2127]
2013/01/06 06:43:11.198| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:11.198| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:11.198| cbdataLock: 0xb78880f8=236
2013/01/06 06:43:11.198| cbdataLock: 0xb78880f8=237
2013/01/06 06:43:11.198| The AsyncCall SomeCommAcceptHandler constructed, this=0xb795ee88 [call2131]
2013/01/06 06:43:11.198| cbdataLock: 0xb78880f8=238
2013/01/06 06:43:11.198| cbdataUnlock: 0xb78880f8=237
2013/01/06 06:43:11.198| cbdataUnlock: 0xb78880f8=236
2013/01/06 06:43:11.198| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:11.198| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb795ee88*2
2013/01/06 06:43:11.199| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:11.199| httpAccept: FD 253: accepted
2013/01/06 06:43:11.199| AsyncJob constructed, this=0xb7bf90e4 type=ConnStateData [job327]
2013/01/06 06:43:11.199| cbdataLock: 0xb78880f8=237
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=1
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=2
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=3
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=4
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=3
2013/01/06 06:43:11.199| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bfa108 [call2132]
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=4
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=5
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=4
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=3
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=2
2013/01/06 06:43:11.199| comm_add_close_handler: FD 253, AsyncCall=0xb7bfa108*1
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=3
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=4
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=5
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=6
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=5
2013/01/06 06:43:11.199| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bfa158 [call2133]
2013/01/06 06:43:11.199| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=6
2013/01/06 06:43:11.199| cbdataLock: 0xb7bf8fb8=7
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=6
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=5
2013/01/06 06:43:11.199| cbdataUnlock: 0xb7bf8fb8=4
2013/01/06 06:43:11.199| comm.cc(1207) commSetTimeout: FD 253 timeout 300
2013/01/06 06:43:11.200| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:11.200| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:11.200| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:11.200| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:11.200| ACLList::matches: checking all
2013/01/06 06:43:11.200| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:11.200| aclIpAddrNetworkCompare: compare: 83.251.135.227:61089/[::] ([::]:61089) vs [::]-[::]/[::]
2013/01/06 06:43:11.200| aclIpMatchIp: '83.251.135.227:61089' found
2013/01/06 06:43:11.200| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:11.200| ACLList::matches: result is true
2013/01/06 06:43:11.200| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:11.200| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:11.200| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:11.200| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:11.200| clientReadSomeData: FD 253: reading request...
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=5
2013/01/06 06:43:11.200| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=6
2013/01/06 06:43:11.200| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=7
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=8
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7bf8fb8=7
2013/01/06 06:43:11.200| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bfa1a8 [call2134]
2013/01/06 06:43:11.200| cbdataReferenceValid: 0xb7bf8fb8
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=8
2013/01/06 06:43:11.200| cbdataLock: 0xb7bf8fb8=9
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7bf8fb8=8
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7bf8fb8=7
2013/01/06 06:43:11.200| cbdataUnlock: 0xb7bf8fb8=6
2013/01/06 06:43:11.200| comm_read, queueing read for FD 253; asynCall 0xb7bfa1a8*1
2013/01/06 06:43:11.200| commSetSelect(FD 253,type=1,handler=1,client_data=0xb53b6b28,timeout=0)
2013/01/06 06:43:11.200| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 253)
2013/01/06 06:43:11.200| cbdataUnlock: 0xb78880f8=236
2013/01/06 06:43:11.200| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.200| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.307| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:11.307| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:11.307| fd_open() FD 254 HTTP Request
2013/01/06 06:43:11.308| AcceptFD::acceptOne accepted: FD 22 newfd: 254 from: 83.251.135.227:61090 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:11.308| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 254) [call2131]
2013/01/06 06:43:11.308| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 254)
2013/01/06 06:43:11.308| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2131]
2013/01/06 06:43:11.308| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:11.308| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:11.308| cbdataLock: 0xb78880f8=237
2013/01/06 06:43:11.308| cbdataLock: 0xb78880f8=238
2013/01/06 06:43:11.308| The AsyncCall SomeCommAcceptHandler constructed, this=0xb79643b8 [call2135]
2013/01/06 06:43:11.308| cbdataLock: 0xb78880f8=239
2013/01/06 06:43:11.308| cbdataUnlock: 0xb78880f8=238
2013/01/06 06:43:11.308| cbdataUnlock: 0xb78880f8=237
2013/01/06 06:43:11.308| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:11.308| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb79643b8*2
2013/01/06 06:43:11.308| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:11.308| httpAccept: FD 254: accepted
2013/01/06 06:43:11.308| AsyncJob constructed, this=0xb7bfa33c type=ConnStateData [job328]
2013/01/06 06:43:11.308| cbdataLock: 0xb78880f8=238
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=1
2013/01/06 06:43:11.308| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=2
2013/01/06 06:43:11.308| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=3
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=4
2013/01/06 06:43:11.308| cbdataUnlock: 0xb7bfa210=3
2013/01/06 06:43:11.308| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bfb360 [call2136]
2013/01/06 06:43:11.308| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=4
2013/01/06 06:43:11.308| cbdataLock: 0xb7bfa210=5
2013/01/06 06:43:11.308| cbdataUnlock: 0xb7bfa210=4
2013/01/06 06:43:11.308| cbdataUnlock: 0xb7bfa210=3
2013/01/06 06:43:11.308| cbdataUnlock: 0xb7bfa210=2
2013/01/06 06:43:11.309| comm_add_close_handler: FD 254, AsyncCall=0xb7bfb360*1
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=3
2013/01/06 06:43:11.309| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=4
2013/01/06 06:43:11.309| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=5
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=6
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7bfa210=5
2013/01/06 06:43:11.309| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bfb3b0 [call2137]
2013/01/06 06:43:11.309| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=6
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=7
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7bfa210=6
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7bfa210=5
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7bfa210=4
2013/01/06 06:43:11.309| comm.cc(1207) commSetTimeout: FD 254 timeout 300
2013/01/06 06:43:11.309| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:11.309| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:11.309| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:11.309| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:11.309| ACLList::matches: checking all
2013/01/06 06:43:11.309| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:11.309| aclIpAddrNetworkCompare: compare: 83.251.135.227:61090/[::] ([::]:61090) vs [::]-[::]/[::]
2013/01/06 06:43:11.309| aclIpMatchIp: '83.251.135.227:61090' found
2013/01/06 06:43:11.309| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:11.309| ACLList::matches: result is true
2013/01/06 06:43:11.309| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:11.309| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:11.309| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:11.309| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:11.309| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:11.309| clientReadSomeData: FD 254: reading request...
2013/01/06 06:43:11.309| cbdataLock: 0xb7bfa210=5
2013/01/06 06:43:11.310| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.310| cbdataLock: 0xb7bfa210=6
2013/01/06 06:43:11.310| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.310| cbdataLock: 0xb7bfa210=7
2013/01/06 06:43:11.310| cbdataLock: 0xb7bfa210=8
2013/01/06 06:43:11.310| cbdataUnlock: 0xb7bfa210=7
2013/01/06 06:43:11.310| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bfb400 [call2138]
2013/01/06 06:43:11.310| cbdataReferenceValid: 0xb7bfa210
2013/01/06 06:43:11.310| cbdataLock: 0xb7bfa210=8
2013/01/06 06:43:11.310| cbdataLock: 0xb7bfa210=9
2013/01/06 06:43:11.310| cbdataUnlock: 0xb7bfa210=8
2013/01/06 06:43:11.310| cbdataUnlock: 0xb7bfa210=7
2013/01/06 06:43:11.310| cbdataUnlock: 0xb7bfa210=6
2013/01/06 06:43:11.310| comm_read, queueing read for FD 254; asynCall 0xb7bfb400*1
2013/01/06 06:43:11.310| commSetSelect(FD 254,type=1,handler=1,client_data=0xb53b6b74,timeout=0)
2013/01/06 06:43:11.310| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 254)
2013/01/06 06:43:11.310| cbdataUnlock: 0xb78880f8=237
2013/01/06 06:43:11.310| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.310| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.418| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:11.418| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:11.418| fd_open() FD 255 HTTP Request
2013/01/06 06:43:11.418| AcceptFD::acceptOne accepted: FD 22 newfd: 255 from: 83.251.135.227:61091 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:11.418| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 255) [call2135]
2013/01/06 06:43:11.418| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 255)
2013/01/06 06:43:11.418| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2135]
2013/01/06 06:43:11.418| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:11.418| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:11.418| cbdataLock: 0xb78880f8=238
2013/01/06 06:43:11.418| cbdataLock: 0xb78880f8=239
2013/01/06 06:43:11.418| The AsyncCall SomeCommAcceptHandler constructed, this=0xb795ee88 [call2139]
2013/01/06 06:43:11.418| cbdataLock: 0xb78880f8=240
2013/01/06 06:43:11.418| cbdataUnlock: 0xb78880f8=239
2013/01/06 06:43:11.418| cbdataUnlock: 0xb78880f8=238
2013/01/06 06:43:11.418| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:11.418| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb795ee88*2
2013/01/06 06:43:11.418| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:11.418| httpAccept: FD 255: accepted
2013/01/06 06:43:11.418| AsyncJob constructed, this=0xb7bfb594 type=ConnStateData [job329]
2013/01/06 06:43:11.418| cbdataLock: 0xb78880f8=239
2013/01/06 06:43:11.418| cbdataLock: 0xb7bfb468=1
2013/01/06 06:43:11.418| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.418| cbdataLock: 0xb7bfb468=2
2013/01/06 06:43:11.418| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=3
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=4
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=3
2013/01/06 06:43:11.419| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bfc5b8 [call2140]
2013/01/06 06:43:11.419| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=4
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=5
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=4
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=3
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=2
2013/01/06 06:43:11.419| comm_add_close_handler: FD 255, AsyncCall=0xb7bfc5b8*1
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=3
2013/01/06 06:43:11.419| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=4
2013/01/06 06:43:11.419| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=5
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=6
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=5
2013/01/06 06:43:11.419| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bfc608 [call2141]
2013/01/06 06:43:11.419| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=6
2013/01/06 06:43:11.419| cbdataLock: 0xb7bfb468=7
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=6
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=5
2013/01/06 06:43:11.419| cbdataUnlock: 0xb7bfb468=4
2013/01/06 06:43:11.419| comm.cc(1207) commSetTimeout: FD 255 timeout 300
2013/01/06 06:43:11.419| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:11.419| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:11.419| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:11.419| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:11.419| ACLList::matches: checking all
2013/01/06 06:43:11.419| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:11.419| aclIpAddrNetworkCompare: compare: 83.251.135.227:61091/[::] ([::]:61091) vs [::]-[::]/[::]
2013/01/06 06:43:11.419| aclIpMatchIp: '83.251.135.227:61091' found
2013/01/06 06:43:11.419| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:11.419| ACLList::matches: result is true
2013/01/06 06:43:11.419| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:11.419| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:11.420| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:11.420| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:11.420| clientReadSomeData: FD 255: reading request...
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=5
2013/01/06 06:43:11.420| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=6
2013/01/06 06:43:11.420| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=7
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=8
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7bfb468=7
2013/01/06 06:43:11.420| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bfc658 [call2142]
2013/01/06 06:43:11.420| cbdataReferenceValid: 0xb7bfb468
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=8
2013/01/06 06:43:11.420| cbdataLock: 0xb7bfb468=9
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7bfb468=8
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7bfb468=7
2013/01/06 06:43:11.420| cbdataUnlock: 0xb7bfb468=6
2013/01/06 06:43:11.420| comm_read, queueing read for FD 255; asynCall 0xb7bfc658*1
2013/01/06 06:43:11.420| commSetSelect(FD 255,type=1,handler=1,client_data=0xb53b6bc0,timeout=0)
2013/01/06 06:43:11.420| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 255)
2013/01/06 06:43:11.420| cbdataUnlock: 0xb78880f8=238
2013/01/06 06:43:11.420| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.420| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.520| comm_select(): got FD 22 events=1 monitoring=19 F->read_handler=1 F->write_handler=0
2013/01/06 06:43:11.520| comm_select(): Calling read handler on FD 22
2013/01/06 06:43:11.520| fd_open() FD 256 HTTP Request
2013/01/06 06:43:11.520| AcceptFD::acceptOne accepted: FD 22 newfd: 256 from: 83.251.135.227:61092 handler: SomeCommAcceptHandler(FD -1, data=0xb78880f8)
2013/01/06 06:43:11.520| comm.cc(2349) will call SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 256) [call2139]
2013/01/06 06:43:11.520| entering SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 256)
2013/01/06 06:43:11.520| AsyncCall.cc(32) make: make call SomeCommAcceptHandler [call2139]
2013/01/06 06:43:11.520| cbdataReferenceValid: 0xb78880f8
2013/01/06 06:43:11.520| comm_accept: FD 22 handler: 0xb7506c30
2013/01/06 06:43:11.521| cbdataLock: 0xb78880f8=239
2013/01/06 06:43:11.521| cbdataLock: 0xb78880f8=240
2013/01/06 06:43:11.521| The AsyncCall SomeCommAcceptHandler constructed, this=0xb79643b8 [call2143]
2013/01/06 06:43:11.521| cbdataLock: 0xb78880f8=241
2013/01/06 06:43:11.521| cbdataUnlock: 0xb78880f8=240
2013/01/06 06:43:11.521| cbdataUnlock: 0xb78880f8=239
2013/01/06 06:43:11.521| comm_old_accept: FD 22: (11) Resource temporarily unavailable
2013/01/06 06:43:11.521| comm.cc(2313) acceptOne: try later: FD 22 handler: 0xb79643b8*2
2013/01/06 06:43:11.521| commSetSelect(FD 22,type=1,handler=1,client_data=0,timeout=0)
2013/01/06 06:43:11.521| httpAccept: FD 256: accepted
2013/01/06 06:43:11.521| AsyncJob constructed, this=0xb7bfc7ec type=ConnStateData [job330]
2013/01/06 06:43:11.521| cbdataLock: 0xb78880f8=240
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=1
2013/01/06 06:43:11.521| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=2
2013/01/06 06:43:11.521| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=3
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=4
2013/01/06 06:43:11.521| cbdataUnlock: 0xb7bfc6c0=3
2013/01/06 06:43:11.521| The AsyncCall ConnStateData::connStateClosed constructed, this=0xb7bfd810 [call2144]
2013/01/06 06:43:11.521| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=4
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=5
2013/01/06 06:43:11.521| cbdataUnlock: 0xb7bfc6c0=4
2013/01/06 06:43:11.521| cbdataUnlock: 0xb7bfc6c0=3
2013/01/06 06:43:11.521| cbdataUnlock: 0xb7bfc6c0=2
2013/01/06 06:43:11.521| comm_add_close_handler: FD 256, AsyncCall=0xb7bfd810*1
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=3
2013/01/06 06:43:11.521| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=4
2013/01/06 06:43:11.521| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=5
2013/01/06 06:43:11.521| cbdataLock: 0xb7bfc6c0=6
2013/01/06 06:43:11.521| cbdataUnlock: 0xb7bfc6c0=5
2013/01/06 06:43:11.522| The AsyncCall ConnStateData::requestTimeout constructed, this=0xb7bfd860 [call2145]
2013/01/06 06:43:11.522| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=6
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=7
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7bfc6c0=6
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7bfc6c0=5
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7bfc6c0=4
2013/01/06 06:43:11.522| comm.cc(1207) commSetTimeout: FD 256 timeout 300
2013/01/06 06:43:11.522| cbdataLock: 0xb7886ae0=1
2013/01/06 06:43:11.522| aclCheckFast: list: 0xb7886ae0
2013/01/06 06:43:11.522| cbdataLock: 0xb7886ae0=2
2013/01/06 06:43:11.522| cbdataReferenceValid: 0xb7886ae0
2013/01/06 06:43:11.522| ACLList::matches: checking all
2013/01/06 06:43:11.522| ACL::checklistMatches: checking 'all'
2013/01/06 06:43:11.522| aclIpAddrNetworkCompare: compare: 83.251.135.227:61092/[::] ([::]:61092) vs [::]-[::]/[::]
2013/01/06 06:43:11.522| aclIpMatchIp: '83.251.135.227:61092' found
2013/01/06 06:43:11.522| ACL::ChecklistMatches: result for 'all' is 1
2013/01/06 06:43:11.522| ACLList::matches: result is true
2013/01/06 06:43:11.522| aclmatchAclList: 0xbf959e4c returning true (AND list satisfied)
2013/01/06 06:43:11.522| ACLChecklist::markFinished: 0xbf959e4c checklist processing finished
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7886ae0=1
2013/01/06 06:43:11.522| FilledChecklist.cc(168) ~ACLFilledChecklist: ACLFilledChecklist destroyed 0xbf959e4c
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7886ae0=0
2013/01/06 06:43:11.522| ACLChecklist::~ACLChecklist: destroyed 0xbf959e4c
2013/01/06 06:43:11.522| clientReadSomeData: FD 256: reading request...
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=5
2013/01/06 06:43:11.522| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=6
2013/01/06 06:43:11.522| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=7
2013/01/06 06:43:11.522| cbdataLock: 0xb7bfc6c0=8
2013/01/06 06:43:11.522| cbdataUnlock: 0xb7bfc6c0=7
2013/01/06 06:43:11.522| The AsyncCall ConnStateData::clientReadRequest constructed, this=0xb7bfd8b0 [call2146]
2013/01/06 06:43:11.523| cbdataReferenceValid: 0xb7bfc6c0
2013/01/06 06:43:11.523| cbdataLock: 0xb7bfc6c0=8
2013/01/06 06:43:11.523| cbdataLock: 0xb7bfc6c0=9
2013/01/06 06:43:11.523| cbdataUnlock: 0xb7bfc6c0=8
2013/01/06 06:43:11.523| cbdataUnlock: 0xb7bfc6c0=7
2013/01/06 06:43:11.523| cbdataUnlock: 0xb7bfc6c0=6
2013/01/06 06:43:11.523| comm_read, queueing read for FD 256; asynCall 0xb7bfd8b0*1
2013/01/06 06:43:11.523| commSetSelect(FD 256,type=1,handler=1,client_data=0xb53b6c0c,timeout=0)
2013/01/06 06:43:11.523| leaving SomeCommAcceptHandler(FD 22, data=0xb78880f8, newFD 256)
2013/01/06 06:43:11.523| cbdataUnlock: 0xb78880f8=239
2013/01/06 06:43:11.523| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.523| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.752| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| event.cc(251) checkEvents: checkEvents
2013/01/06 06:43:11.753| The AsyncCall MaintainSwapSpace constructed, this=0xb7bba738 [call2147]
2013/01/06 06:43:11.753| event.cc(260) will call MaintainSwapSpace() [call2147]
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
2013/01/06 06:43:11.753| entering MaintainSwapSpace()
2013/01/06 06:43:11.753| AsyncCall.cc(32) make: make call MaintainSwapSpace [call2147]
2013/01/06 06:43:11.753| event.cc(343) schedule: schedule: Adding 'MaintainSwapSpace', in 1.00 seconds
2013/01/06 06:43:11.753| leaving MaintainSwapSpace()
2013/01/06 06:43:11.753| Engine 0xbf95a140 is idle.
2013/01/06 06:43:11.753| Engine 0xbf95a124 is idle.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment