]>
Commit | Line | Data |
---|---|---|
9b7de833 | 1 | /* |
bde978a6 | 2 | * Copyright (C) 1996-2015 The Squid Software Foundation and contributors |
e25c139f | 3 | * |
bbc27441 AJ |
4 | * Squid software is distributed under GPLv2+ license and includes |
5 | * contributions from numerous individuals and organizations. | |
6 | * Please see the COPYING and CONTRIBUTORS files for details. | |
9b7de833 | 7 | */ |
8 | ||
bbc27441 AJ |
9 | /* DEBUG: section 72 Peer Digest Routines */ |
10 | ||
582c2af2 | 11 | #include "squid.h" |
6cfa8966 | 12 | #if USE_CACHE_DIGESTS |
b814e8d4 | 13 | #include "CacheDigest.h" |
a011edee | 14 | #include "CachePeer.h" |
a553a5a3 | 15 | #include "event.h" |
eb13c21e | 16 | #include "FwdState.h" |
af69c635 | 17 | #include "globals.h" |
528b2c61 | 18 | #include "HttpReply.h" |
582c2af2 | 19 | #include "HttpRequest.h" |
308e60be | 20 | #include "internal.h" |
528b2c61 | 21 | #include "MemObject.h" |
b6149797 | 22 | #include "mime_header.h" |
602d9612 | 23 | #include "neighbors.h" |
aa839030 | 24 | #include "PeerDigest.h" |
985c86bc | 25 | #include "SquidTime.h" |
582c2af2 | 26 | #include "Store.h" |
fb548aaf | 27 | #include "store_key_md5.h" |
598465f1 | 28 | #include "StoreClient.h" |
4e540555 | 29 | #include "tools.h" |
ed6e9fb9 | 30 | #include "util.h" |
598465f1 | 31 | |
9b7de833 | 32 | /* local types */ |
33 | ||
34 | /* local prototypes */ | |
e13ee7ad | 35 | static time_t peerDigestIncDelay(const PeerDigest * pd); |
36 | static time_t peerDigestNewDelay(const StoreEntry * e); | |
37 | static void peerDigestSetCheck(PeerDigest * pd, time_t delay); | |
eb16313f | 38 | static void peerDigestClean(PeerDigest *); |
e13ee7ad | 39 | static EVH peerDigestCheck; |
40 | static void peerDigestRequest(PeerDigest * pd); | |
add2192d | 41 | static STCB peerDigestHandleReply; |
3dfaa3d2 | 42 | static int peerDigestFetchReply(void *, char *, ssize_t); |
1f140227 | 43 | int peerDigestSwapInHeaders(void *, char *, ssize_t); |
44 | int peerDigestSwapInCBlock(void *, char *, ssize_t); | |
45 | int peerDigestSwapInMask(void *, char *, ssize_t); | |
4b4cd312 | 46 | static int peerDigestFetchedEnough(DigestFetchState * fetch, char *buf, ssize_t size, const char *step_name); |
551e60a9 | 47 | static void peerDigestFetchStop(DigestFetchState * fetch, char *buf, const char *reason); |
e13ee7ad | 48 | static void peerDigestFetchAbort(DigestFetchState * fetch, char *buf, const char *reason); |
49 | static void peerDigestReqFinish(DigestFetchState * fetch, char *buf, int, int, int, const char *reason, int err); | |
50 | static void peerDigestPDFinish(DigestFetchState * fetch, int pcb_valid, int err); | |
51 | static void peerDigestFetchFinish(DigestFetchState * fetch, int err); | |
52 | static void peerDigestFetchSetStats(DigestFetchState * fetch); | |
53 | static int peerDigestSetCBlock(PeerDigest * pd, const char *buf); | |
54 | static int peerDigestUseful(const PeerDigest * pd); | |
395b813e | 55 | |
9b7de833 | 56 | /* local constants */ |
aa839030 | 57 | Version const CacheDigestVer = { 5, 3 }; |
9d486b43 | 58 | |
9b7de833 | 59 | #define StoreDigestCBlockSize sizeof(StoreDigestCBlock) |
60 | ||
e13ee7ad | 61 | /* min interval for requesting digests from a given peer */ |
f53969cc | 62 | static const time_t PeerDigestReqMinGap = 5 * 60; /* seconds */ |
e13ee7ad | 63 | /* min interval for requesting digests (cumulative request stream) */ |
f53969cc | 64 | static const time_t GlobDigestReqMinGap = 1 * 60; /* seconds */ |
bd890734 | 65 | |
66 | /* local vars */ | |
9d486b43 | 67 | |
f53969cc | 68 | static time_t pd_last_req_time = 0; /* last call to Check */ |
9b7de833 | 69 | |
e13ee7ad | 70 | /* initialize peer digest */ |
71 | static void | |
a3c6762c | 72 | peerDigestInit(PeerDigest * pd, CachePeer * p) |
9b7de833 | 73 | { |
e13ee7ad | 74 | assert(pd && p); |
75 | ||
76 | memset(pd, 0, sizeof(*pd)); | |
4e454ade | 77 | /* |
78 | * DPW 2007-04-12 | |
79 | * Lock on to the peer here. The corresponding cbdataReferenceDone() | |
80 | * is in peerDigestDestroy(). | |
81 | */ | |
82 | pd->peer = cbdataReference(p); | |
e13ee7ad | 83 | /* if peer disappears, we will know it's name */ |
528b2c61 | 84 | pd->host = p->host; |
e13ee7ad | 85 | |
86 | pd->times.initialized = squid_curtime; | |
9b7de833 | 87 | } |
88 | ||
4b4cd312 | 89 | static void |
8a6218c6 | 90 | peerDigestClean(PeerDigest * pd) |
9b7de833 | 91 | { |
e13ee7ad | 92 | assert(pd); |
62e76326 | 93 | |
e13ee7ad | 94 | if (pd->cd) |
62e76326 | 95 | cacheDigestDestroy(pd->cd); |
96 | ||
30abd221 | 97 | pd->host.clean(); |
9b7de833 | 98 | } |
99 | ||
0353e724 | 100 | CBDATA_CLASS_INIT(PeerDigest); |
101 | ||
a44986dc AJ |
102 | CBDATA_CLASS_INIT(DigestFetchState); |
103 | ||
022099cb | 104 | DigestFetchState::DigestFetchState(PeerDigest *aPd, HttpRequest *req) : |
a44986dc AJ |
105 | pd(cbdataReference(aPd)), |
106 | entry(NULL), | |
107 | old_entry(NULL), | |
108 | sc(NULL), | |
109 | old_sc(NULL), | |
110 | request(req), | |
111 | offset(0), | |
112 | mask_offset(0), | |
113 | start_time(squid_curtime), | |
114 | resp_time(0), | |
115 | expires(0), | |
116 | bufofs(0), | |
117 | state(DIGEST_READ_REPLY) | |
118 | { | |
119 | HTTPMSGLOCK(request); | |
120 | ||
121 | sent.msg = 0; | |
122 | sent.bytes = 0; | |
123 | ||
124 | recv.msg = 0; | |
125 | recv.bytes = 0; | |
126 | ||
127 | *buf = 0; | |
128 | } | |
129 | ||
130 | DigestFetchState::~DigestFetchState() | |
131 | { | |
132 | /* unlock everything */ | |
133 | storeUnregister(sc, entry, this); | |
134 | ||
135 | entry->unlock("DigestFetchState destructed"); | |
136 | entry = NULL; | |
137 | ||
138 | HTTPMSGUNLOCK(request); | |
139 | ||
140 | assert(pd == NULL); | |
141 | } | |
142 | ||
e13ee7ad | 143 | /* allocate new peer digest, call Init, and lock everything */ |
144 | PeerDigest * | |
a3c6762c | 145 | peerDigestCreate(CachePeer * p) |
e13ee7ad | 146 | { |
147 | PeerDigest *pd; | |
8a6218c6 | 148 | assert(p); |
e13ee7ad | 149 | |
0353e724 | 150 | pd = new PeerDigest; |
e13ee7ad | 151 | peerDigestInit(pd, p); |
e13ee7ad | 152 | |
fa80a8ef | 153 | /* XXX This does not look right, and the same thing again in the caller */ |
154 | return cbdataReference(pd); | |
e13ee7ad | 155 | } |
156 | ||
157 | /* call Clean and free/unlock everything */ | |
2d72d4fd | 158 | static void |
8a6218c6 | 159 | peerDigestDestroy(PeerDigest * pd) |
e13ee7ad | 160 | { |
8abf232c | 161 | void *p; |
e13ee7ad | 162 | assert(pd); |
8abf232c | 163 | void * peerTmp = pd->peer; |
e13ee7ad | 164 | |
4e454ade | 165 | /* |
166 | * DPW 2007-04-12 | |
167 | * We locked the peer in peerDigestInit(), this is | |
168 | * where we unlock it. If the peer is still valid, | |
169 | * tell it that the digest is gone. | |
170 | */ | |
8abf232c | 171 | if (cbdataReferenceValidDone(peerTmp, &p)) |
a3c6762c | 172 | peerNoteDigestGone((CachePeer *)p); |
e13ee7ad | 173 | |
174 | peerDigestClean(pd); | |
62e76326 | 175 | |
00d77d6b | 176 | delete pd; |
e13ee7ad | 177 | } |
178 | ||
179 | /* called by peer to indicate that somebody actually needs this digest */ | |
180 | void | |
8a6218c6 | 181 | peerDigestNeeded(PeerDigest * pd) |
e13ee7ad | 182 | { |
183 | assert(pd); | |
184 | assert(!pd->flags.needed); | |
185 | assert(!pd->cd); | |
186 | ||
be4d35dc | 187 | pd->flags.needed = true; |
e13ee7ad | 188 | pd->times.needed = squid_curtime; |
f53969cc | 189 | peerDigestSetCheck(pd, 0); /* check asap */ |
e13ee7ad | 190 | } |
191 | ||
192 | /* currently we do not have a reason to disable without destroying */ | |
8a6218c6 | 193 | #if FUTURE_CODE |
395b813e | 194 | /* disables peer for good */ |
195 | static void | |
8a6218c6 | 196 | peerDigestDisable(PeerDigest * pd) |
395b813e | 197 | { |
bf8fe701 | 198 | debugs(72, 2, "peerDigestDisable: peer " << pd->host.buf() << " disabled for good"); |
e13ee7ad | 199 | pd->times.disabled = squid_curtime; |
f53969cc | 200 | pd->times.next_check = -1; /* never */ |
e13ee7ad | 201 | pd->flags.usable = 0; |
202 | ||
203 | if (pd->cd) { | |
62e76326 | 204 | cacheDigestDestroy(pd->cd); |
205 | pd->cd = NULL; | |
e13ee7ad | 206 | } |
62e76326 | 207 | |
e13ee7ad | 208 | /* we do not destroy the pd itself to preserve its "history" and stats */ |
395b813e | 209 | } |
62e76326 | 210 | |
e13ee7ad | 211 | #endif |
395b813e | 212 | |
e13ee7ad | 213 | /* increment retry delay [after an unsuccessful attempt] */ |
395b813e | 214 | static time_t |
8a6218c6 | 215 | peerDigestIncDelay(const PeerDigest * pd) |
395b813e | 216 | { |
e13ee7ad | 217 | assert(pd); |
218 | return pd->times.retry_delay > 0 ? | |
f53969cc SM |
219 | 2 * pd->times.retry_delay : /* exponential backoff */ |
220 | PeerDigestReqMinGap; /* minimal delay */ | |
395b813e | 221 | } |
222 | ||
62e76326 | 223 | /* artificially increases Expires: setting to avoid race conditions |
e13ee7ad | 224 | * returns the delay till that [increased] expiration time */ |
00485c29 | 225 | static time_t |
e13ee7ad | 226 | peerDigestNewDelay(const StoreEntry * e) |
00485c29 | 227 | { |
e13ee7ad | 228 | assert(e); |
62e76326 | 229 | |
00485c29 | 230 | if (e->expires > 0) |
62e76326 | 231 | return e->expires + PeerDigestReqMinGap - squid_curtime; |
232 | ||
e13ee7ad | 233 | return PeerDigestReqMinGap; |
00485c29 | 234 | } |
235 | ||
e13ee7ad | 236 | /* registers next digest verification */ |
395b813e | 237 | static void |
e13ee7ad | 238 | peerDigestSetCheck(PeerDigest * pd, time_t delay) |
395b813e | 239 | { |
e13ee7ad | 240 | eventAdd("peerDigestCheck", peerDigestCheck, pd, (double) delay, 1); |
241 | pd->times.next_check = squid_curtime + delay; | |
bb790702 | 242 | debugs(72, 3, "peerDigestSetCheck: will check peer " << pd->host << " in " << delay << " secs"); |
e13ee7ad | 243 | } |
244 | ||
5385c86a | 245 | /* |
246 | * called when peer is about to disappear or have already disappeared | |
247 | */ | |
e13ee7ad | 248 | void |
8a6218c6 | 249 | peerDigestNotePeerGone(PeerDigest * pd) |
250 | { | |
e13ee7ad | 251 | if (pd->flags.requested) { |
bb790702 | 252 | debugs(72, 2, "peerDigest: peer " << pd->host << " gone, will destroy after fetch."); |
62e76326 | 253 | /* do nothing now, the fetching chain will notice and take action */ |
395b813e | 254 | } else { |
bb790702 | 255 | debugs(72, 2, "peerDigest: peer " << pd->host << " is gone, destroying now."); |
62e76326 | 256 | peerDigestDestroy(pd); |
395b813e | 257 | } |
258 | } | |
259 | ||
e13ee7ad | 260 | /* callback for eventAdd() (with peer digest locked) |
26ac0430 | 261 | * request new digest if our copy is too old or if we lack one; |
e13ee7ad | 262 | * schedule next check otherwise */ |
9b7de833 | 263 | static void |
e13ee7ad | 264 | peerDigestCheck(void *data) |
9b7de833 | 265 | { |
e6ccf245 | 266 | PeerDigest *pd = (PeerDigest *)data; |
e13ee7ad | 267 | time_t req_time; |
268 | ||
e13ee7ad | 269 | assert(!pd->flags.requested); |
5d9bb360 | 270 | |
f53969cc | 271 | pd->times.next_check = 0; /* unknown */ |
e13ee7ad | 272 | |
fa80a8ef | 273 | if (!cbdataReferenceValid(pd->peer)) { |
62e76326 | 274 | peerDigestNotePeerGone(pd); |
275 | return; | |
9b7de833 | 276 | } |
62e76326 | 277 | |
cc192b50 | 278 | debugs(72, 3, "peerDigestCheck: peer " << pd->peer->host << ":" << pd->peer->http_port); |
26ac0430 AJ |
279 | debugs(72, 3, "peerDigestCheck: time: " << squid_curtime << |
280 | ", last received: " << (long int) pd->times.received << " (" << | |
bf8fe701 | 281 | std::showpos << (int) (squid_curtime - pd->times.received) << ")"); |
e13ee7ad | 282 | |
283 | /* decide when we should send the request: | |
284 | * request now unless too close to other requests */ | |
285 | req_time = squid_curtime; | |
286 | ||
287 | /* per-peer limit */ | |
62e76326 | 288 | |
e13ee7ad | 289 | if (req_time - pd->times.received < PeerDigestReqMinGap) { |
b4197865 | 290 | debugs(72, 2, "peerDigestCheck: " << pd->host << |
bf8fe701 | 291 | ", avoiding close peer requests (" << |
292 | (int) (req_time - pd->times.received) << " < " << | |
293 | (int) PeerDigestReqMinGap << " secs)."); | |
294 | ||
62e76326 | 295 | req_time = pd->times.received + PeerDigestReqMinGap; |
bd890734 | 296 | } |
62e76326 | 297 | |
e13ee7ad | 298 | /* global limit */ |
299 | if (req_time - pd_last_req_time < GlobDigestReqMinGap) { | |
b4197865 | 300 | debugs(72, 2, "peerDigestCheck: " << pd->host << |
bf8fe701 | 301 | ", avoiding close requests (" << |
302 | (int) (req_time - pd_last_req_time) << " < " << | |
303 | (int) GlobDigestReqMinGap << " secs)."); | |
304 | ||
62e76326 | 305 | req_time = pd_last_req_time + GlobDigestReqMinGap; |
9b7de833 | 306 | } |
62e76326 | 307 | |
e13ee7ad | 308 | if (req_time <= squid_curtime) |
f53969cc | 309 | peerDigestRequest(pd); /* will set pd->flags.requested */ |
e13ee7ad | 310 | else |
62e76326 | 311 | peerDigestSetCheck(pd, req_time - squid_curtime); |
9b7de833 | 312 | } |
313 | ||
e13ee7ad | 314 | /* ask store for a digest */ |
9b7de833 | 315 | static void |
e13ee7ad | 316 | peerDigestRequest(PeerDigest * pd) |
9b7de833 | 317 | { |
a3c6762c | 318 | CachePeer *p = pd->peer; |
9b7de833 | 319 | StoreEntry *e, *old_e; |
7e928efc | 320 | char *url = NULL; |
9d486b43 | 321 | const cache_key *key; |
190154cf | 322 | HttpRequest *req; |
528b2c61 | 323 | StoreIOBuffer tempBuffer; |
e13ee7ad | 324 | |
325 | pd->req_result = NULL; | |
be4d35dc | 326 | pd->flags.requested = true; |
e13ee7ad | 327 | |
9b7de833 | 328 | /* compute future request components */ |
62e76326 | 329 | |
7e3ce7b9 | 330 | if (p->digest_url) |
62e76326 | 331 | url = xstrdup(p->digest_url); |
7e3ce7b9 | 332 | else |
51b5dcf5 | 333 | url = xstrdup(internalRemoteUri(p->host, p->http_port, "/squid-internal-periodic/", SBuf(StoreDigestFileName))); |
7e3ce7b9 | 334 | |
c21ad0f5 | 335 | req = HttpRequest::CreateFromUrl(url); |
62e76326 | 336 | |
e13ee7ad | 337 | assert(req); |
62e76326 | 338 | |
f66a9ef4 | 339 | key = storeKeyPublicByRequest(req); |
62e76326 | 340 | |
bf8fe701 | 341 | debugs(72, 2, "peerDigestRequest: " << url << " key: " << storeKeyText(key)); |
e13ee7ad | 342 | |
9b7de833 | 343 | /* add custom headers */ |
2246b732 | 344 | assert(!req->header.len); |
62e76326 | 345 | |
789217a2 | 346 | req->header.putStr(Http::HdrType::ACCEPT, StoreDigestMimeStr); |
62e76326 | 347 | |
789217a2 | 348 | req->header.putStr(Http::HdrType::ACCEPT, "text/html"); |
62e76326 | 349 | |
89000349 AJ |
350 | if (p->login && |
351 | p->login[0] != '*' && | |
b552ea1f A |
352 | strcmp(p->login, "PASS") != 0 && |
353 | strcmp(p->login, "PASSTHRU") != 0 && | |
98ace3e4 | 354 | strncmp(p->login, "NEGOTIATE",9) != 0 && |
89000349 | 355 | strcmp(p->login, "PROXYPASS") != 0) { |
c486d50a | 356 | req->url.userInfo(SBuf(p->login)); // XXX: performance regression make peer login SBuf as well. |
89000349 | 357 | } |
9b7de833 | 358 | /* create fetch state structure */ |
022099cb | 359 | DigestFetchState *fetch = new DigestFetchState(pd, req); |
e13ee7ad | 360 | |
361 | /* update timestamps */ | |
e13ee7ad | 362 | pd->times.requested = squid_curtime; |
363 | pd_last_req_time = squid_curtime; | |
e857372a | 364 | req->flags.cachable = true; |
62e76326 | 365 | |
9b7de833 | 366 | /* the rest is based on clientProcessExpired() */ |
e857372a | 367 | req->flags.refresh = true; |
62e76326 | 368 | |
c8f4eac4 | 369 | old_e = fetch->old_entry = Store::Root().get(key); |
62e76326 | 370 | |
9b7de833 | 371 | if (old_e) { |
bf8fe701 | 372 | debugs(72, 5, "peerDigestRequest: found old entry"); |
34266cde | 373 | |
acc5dc4c | 374 | old_e->lock("peerDigestRequest"); |
c877c0bc | 375 | old_e->createMemObject(url, url, req->method); |
34266cde | 376 | |
62e76326 | 377 | fetch->old_sc = storeClientListAdd(old_e, fetch); |
9b7de833 | 378 | } |
62e76326 | 379 | |
9b7de833 | 380 | e = fetch->entry = storeCreateEntry(url, url, req->flags, req->method); |
e13ee7ad | 381 | assert(EBIT_TEST(e->flags, KEY_PRIVATE)); |
06d2839d | 382 | fetch->sc = storeClientListAdd(e, fetch); |
9b7de833 | 383 | /* set lastmod to trigger IMS request if possible */ |
62e76326 | 384 | |
9b7de833 | 385 | if (old_e) |
62e76326 | 386 | e->lastmod = old_e->lastmod; |
e13ee7ad | 387 | |
9b7de833 | 388 | /* push towards peer cache */ |
bf8fe701 | 389 | debugs(72, 3, "peerDigestRequest: forwarding to fwdStart..."); |
62e76326 | 390 | |
e83cc785 | 391 | FwdState::fwdStart(Comm::ConnectionPointer(), e, req); |
62e76326 | 392 | |
598465f1 | 393 | tempBuffer.offset = 0; |
62e76326 | 394 | |
f95db407 | 395 | tempBuffer.length = SM_PAGE_SIZE; |
62e76326 | 396 | |
598465f1 | 397 | tempBuffer.data = fetch->buf; |
62e76326 | 398 | |
598465f1 | 399 | storeClientCopy(fetch->sc, e, tempBuffer, |
62e76326 | 400 | peerDigestHandleReply, fetch); |
7e928efc AJ |
401 | |
402 | safe_free(url); | |
9b7de833 | 403 | } |
404 | ||
add2192d | 405 | /* Handle the data copying .. */ |
406 | ||
407 | /* | |
408 | * This routine handles the copy data and then redirects the | |
409 | * copy to a bunch of subfunctions depending upon the copy state. | |
410 | * It also tracks the buffer offset and "seen", since I'm actually | |
411 | * not interested in rewriting everything to suit my little idea. | |
412 | */ | |
9b7de833 | 413 | static void |
2324cda2 | 414 | peerDigestHandleReply(void *data, StoreIOBuffer receivedData) |
add2192d | 415 | { |
e6ccf245 | 416 | DigestFetchState *fetch = (DigestFetchState *)data; |
add2192d | 417 | int retsize = -1; |
418 | digest_read_state_t prevstate; | |
419 | int newsize; | |
420 | ||
2324cda2 | 421 | assert(fetch->pd && receivedData.data); |
422 | /* The existing code assumes that the received pointer is | |
598465f1 | 423 | * where we asked the data to be put |
424 | */ | |
2324cda2 | 425 | assert(fetch->buf + fetch->bufofs == receivedData.data); |
add2192d | 426 | |
427 | /* Update the buffer size */ | |
2324cda2 | 428 | fetch->bufofs += receivedData.length; |
add2192d | 429 | |
430 | assert(fetch->bufofs <= SM_PAGE_SIZE); | |
431 | ||
432 | /* If we've fetched enough, return */ | |
62e76326 | 433 | |
add2192d | 434 | if (peerDigestFetchedEnough(fetch, fetch->buf, fetch->bufofs, "peerDigestHandleReply")) |
62e76326 | 435 | return; |
add2192d | 436 | |
437 | /* Call the right function based on the state */ | |
438 | /* (Those functions will update the state if needed) */ | |
fa80a8ef | 439 | |
e2848e94 | 440 | /* Give us a temporary reference. Some of the calls we make may |
441 | * try to destroy the fetch structure, and we like to know if they | |
442 | * do | |
bac6d4bd | 443 | */ |
a44986dc | 444 | CbcPointer<DigestFetchState> tmpLock = fetch; |
add2192d | 445 | |
446 | /* Repeat this loop until we're out of data OR the state changes */ | |
447 | /* (So keep going if the state has changed and we still have data */ | |
448 | do { | |
62e76326 | 449 | prevstate = fetch->state; |
450 | ||
451 | switch (fetch->state) { | |
452 | ||
453 | case DIGEST_READ_REPLY: | |
454 | retsize = peerDigestFetchReply(fetch, fetch->buf, fetch->bufofs); | |
455 | break; | |
456 | ||
457 | case DIGEST_READ_HEADERS: | |
458 | retsize = peerDigestSwapInHeaders(fetch, fetch->buf, fetch->bufofs); | |
459 | break; | |
460 | ||
461 | case DIGEST_READ_CBLOCK: | |
462 | retsize = peerDigestSwapInCBlock(fetch, fetch->buf, fetch->bufofs); | |
463 | break; | |
464 | ||
465 | case DIGEST_READ_MASK: | |
466 | retsize = peerDigestSwapInMask(fetch, fetch->buf, fetch->bufofs); | |
467 | break; | |
468 | ||
469 | case DIGEST_READ_NONE: | |
470 | break; | |
471 | ||
472 | case DIGEST_READ_DONE: | |
a44986dc | 473 | return; |
62e76326 | 474 | break; |
475 | ||
476 | default: | |
477 | fatal("Bad digest transfer mode!\n"); | |
478 | } | |
479 | ||
480 | if (retsize < 0) | |
a44986dc | 481 | return; |
62e76326 | 482 | |
483 | /* | |
484 | * The returned size indicates how much of the buffer was read - | |
485 | * so move the remainder of the buffer to the beginning | |
486 | * and update the bufofs / bufsize | |
487 | */ | |
488 | newsize = fetch->bufofs - retsize; | |
489 | ||
41d00cd3 | 490 | memmove(fetch->buf, fetch->buf + retsize, fetch->bufofs - newsize); |
62e76326 | 491 | |
492 | fetch->bufofs = newsize; | |
add2192d | 493 | |
e2848e94 | 494 | } while (cbdataReferenceValid(fetch) && prevstate != fetch->state && fetch->bufofs > 0); |
add2192d | 495 | |
496 | /* Update the copy offset */ | |
2324cda2 | 497 | fetch->offset += receivedData.length; |
add2192d | 498 | |
499 | /* Schedule another copy */ | |
fa80a8ef | 500 | if (cbdataReferenceValid(fetch)) { |
62e76326 | 501 | StoreIOBuffer tempBuffer; |
502 | tempBuffer.offset = fetch->offset; | |
503 | tempBuffer.length = SM_PAGE_SIZE - fetch->bufofs; | |
504 | tempBuffer.data = fetch->buf + fetch->bufofs; | |
505 | storeClientCopy(fetch->sc, fetch->entry, tempBuffer, | |
506 | peerDigestHandleReply, fetch); | |
add2192d | 507 | } |
add2192d | 508 | } |
509 | ||
add2192d | 510 | /* wait for full http headers to be received then parse them */ |
511 | /* | |
512 | * This routine handles parsing the reply line. | |
513 | * If the reply line indicates an OK, the same data is thrown | |
514 | * to SwapInHeaders(). If the reply line is a NOT_MODIFIED, | |
515 | * we simply stop parsing. | |
516 | */ | |
517 | static int | |
9b7de833 | 518 | peerDigestFetchReply(void *data, char *buf, ssize_t size) |
519 | { | |
e6ccf245 | 520 | DigestFetchState *fetch = (DigestFetchState *)data; |
e13ee7ad | 521 | PeerDigest *pd = fetch->pd; |
9bc73deb | 522 | size_t hdr_size; |
e13ee7ad | 523 | assert(pd && buf); |
9b7de833 | 524 | assert(!fetch->offset); |
e13ee7ad | 525 | |
add2192d | 526 | assert(fetch->state == DIGEST_READ_REPLY); |
62e76326 | 527 | |
9b7de833 | 528 | if (peerDigestFetchedEnough(fetch, buf, size, "peerDigestFetchReply")) |
62e76326 | 529 | return -1; |
e13ee7ad | 530 | |
9bc73deb | 531 | if ((hdr_size = headersEnd(buf, size))) { |
62e76326 | 532 | HttpReply const *reply = fetch->entry->getReply(); |
533 | assert(reply); | |
9b769c67 AJ |
534 | assert(reply->sline.status() != Http::scNone); |
535 | const Http::StatusCode status = reply->sline.status(); | |
b4197865 | 536 | debugs(72, 3, "peerDigestFetchReply: " << pd->host << " status: " << status << |
26ac0430 | 537 | ", expires: " << (long int) reply->expires << " (" << std::showpos << |
bf8fe701 | 538 | (int) (reply->expires - squid_curtime) << ")"); |
62e76326 | 539 | |
540 | /* this "if" is based on clientHandleIMSReply() */ | |
541 | ||
955394ce | 542 | if (status == Http::scNotModified) { |
62e76326 | 543 | /* our old entry is fine */ |
544 | assert(fetch->old_entry); | |
545 | ||
b248c2a3 AJ |
546 | if (!fetch->old_entry->mem_obj->request) { |
547 | fetch->old_entry->mem_obj->request = fetch->entry->mem_obj->request; | |
548 | HTTPMSGLOCK(fetch->old_entry->mem_obj->request); | |
549 | } | |
62e76326 | 550 | |
551 | assert(fetch->old_entry->mem_obj->request); | |
552 | ||
07947ad8 | 553 | HttpReply *old_rep = (HttpReply *) fetch->old_entry->getReply(); |
554 | ||
06a5ae20 | 555 | old_rep->updateOnNotModified(reply); |
62e76326 | 556 | |
3900307b | 557 | fetch->old_entry->timestampsSet(); |
62e76326 | 558 | |
559 | /* get rid of 304 reply */ | |
560 | storeUnregister(fetch->sc, fetch->entry, fetch); | |
561 | ||
acc5dc4c | 562 | fetch->entry->unlock("peerDigestFetchReply 304"); |
62e76326 | 563 | |
564 | fetch->entry = fetch->old_entry; | |
565 | ||
566 | fetch->old_entry = NULL; | |
567 | ||
568 | /* preserve request -- we need its size to update counters */ | |
569 | /* requestUnlink(r); */ | |
570 | /* fetch->entry->mem_obj->request = NULL; */ | |
955394ce | 571 | } else if (status == Http::scOkay) { |
62e76326 | 572 | /* get rid of old entry if any */ |
573 | ||
574 | if (fetch->old_entry) { | |
bf8fe701 | 575 | debugs(72, 3, "peerDigestFetchReply: got new digest, releasing old one"); |
62e76326 | 576 | storeUnregister(fetch->old_sc, fetch->old_entry, fetch); |
d88e3c49 | 577 | fetch->old_entry->releaseRequest(); |
acc5dc4c | 578 | fetch->old_entry->unlock("peerDigestFetchReply 200"); |
62e76326 | 579 | fetch->old_entry = NULL; |
580 | } | |
581 | } else { | |
582 | /* some kind of a bug */ | |
9b769c67 | 583 | peerDigestFetchAbort(fetch, buf, reply->sline.reason()); |
f53969cc | 584 | return -1; /* XXX -1 will abort stuff in ReadReply! */ |
62e76326 | 585 | } |
586 | ||
587 | /* must have a ready-to-use store entry if we got here */ | |
588 | /* can we stay with the old in-memory digest? */ | |
955394ce | 589 | if (status == Http::scNotModified && fetch->pd->cd) { |
62e76326 | 590 | peerDigestFetchStop(fetch, buf, "Not modified"); |
591 | fetch->state = DIGEST_READ_DONE; | |
592 | } else { | |
593 | fetch->state = DIGEST_READ_HEADERS; | |
594 | } | |
9b7de833 | 595 | } else { |
62e76326 | 596 | /* need more data, do we have space? */ |
597 | ||
598 | if (size >= SM_PAGE_SIZE) | |
599 | peerDigestFetchAbort(fetch, buf, "reply header too big"); | |
9b7de833 | 600 | } |
add2192d | 601 | |
602 | /* We don't want to actually ack that we've handled anything, | |
603 | * otherwise SwapInHeaders() won't get the reply line .. */ | |
604 | return 0; | |
9b7de833 | 605 | } |
606 | ||
607 | /* fetch headers from disk, pass on to SwapInCBlock */ | |
1f140227 | 608 | int |
9b7de833 | 609 | peerDigestSwapInHeaders(void *data, char *buf, ssize_t size) |
610 | { | |
e6ccf245 | 611 | DigestFetchState *fetch = (DigestFetchState *)data; |
9b7de833 | 612 | size_t hdr_size; |
e13ee7ad | 613 | |
add2192d | 614 | assert(fetch->state == DIGEST_READ_HEADERS); |
62e76326 | 615 | |
9b7de833 | 616 | if (peerDigestFetchedEnough(fetch, buf, size, "peerDigestSwapInHeaders")) |
62e76326 | 617 | return -1; |
e13ee7ad | 618 | |
9d486b43 | 619 | assert(!fetch->offset); |
62e76326 | 620 | |
9b7de833 | 621 | if ((hdr_size = headersEnd(buf, size))) { |
62e76326 | 622 | assert(fetch->entry->getReply()); |
9b769c67 | 623 | assert(fetch->entry->getReply()->sline.status() != Http::scNone); |
62e76326 | 624 | |
9b769c67 | 625 | if (fetch->entry->getReply()->sline.status() != Http::scOkay) { |
e0236918 | 626 | debugs(72, DBG_IMPORTANT, "peerDigestSwapInHeaders: " << fetch->pd->host << |
9b769c67 | 627 | " status " << fetch->entry->getReply()->sline.status() << |
bf8fe701 | 628 | " got cached!"); |
629 | ||
62e76326 | 630 | peerDigestFetchAbort(fetch, buf, "internal status error"); |
631 | return -1; | |
632 | } | |
633 | ||
634 | fetch->state = DIGEST_READ_CBLOCK; | |
f53969cc | 635 | return hdr_size; /* Say how much data we read */ |
cfd861ab | 636 | } |
62e76326 | 637 | |
cfd861ab AJ |
638 | /* need more data, do we have space? */ |
639 | if (size >= SM_PAGE_SIZE) { | |
640 | peerDigestFetchAbort(fetch, buf, "stored header too big"); | |
641 | return -1; | |
9b7de833 | 642 | } |
62e76326 | 643 | |
cfd861ab | 644 | return 0; /* We need to read more to parse .. */ |
9b7de833 | 645 | } |
646 | ||
1f140227 | 647 | int |
9b7de833 | 648 | peerDigestSwapInCBlock(void *data, char *buf, ssize_t size) |
649 | { | |
e6ccf245 | 650 | DigestFetchState *fetch = (DigestFetchState *)data; |
e13ee7ad | 651 | |
add2192d | 652 | assert(fetch->state == DIGEST_READ_CBLOCK); |
62e76326 | 653 | |
9b7de833 | 654 | if (peerDigestFetchedEnough(fetch, buf, size, "peerDigestSwapInCBlock")) |
62e76326 | 655 | return -1; |
e13ee7ad | 656 | |
e6ccf245 | 657 | if (size >= (ssize_t)StoreDigestCBlockSize) { |
62e76326 | 658 | PeerDigest *pd = fetch->pd; |
62e76326 | 659 | |
e4a67a80 | 660 | assert(pd && fetch->entry->getReply()); |
62e76326 | 661 | |
662 | if (peerDigestSetCBlock(pd, buf)) { | |
663 | /* XXX: soon we will have variable header size */ | |
664 | /* switch to CD buffer and fetch digest guts */ | |
665 | buf = NULL; | |
666 | assert(pd->cd->mask); | |
667 | fetch->state = DIGEST_READ_MASK; | |
668 | return StoreDigestCBlockSize; | |
669 | } else { | |
670 | peerDigestFetchAbort(fetch, buf, "invalid digest cblock"); | |
671 | return -1; | |
672 | } | |
cfd861ab | 673 | } |
62e76326 | 674 | |
cfd861ab AJ |
675 | /* need more data, do we have space? */ |
676 | if (size >= SM_PAGE_SIZE) { | |
677 | peerDigestFetchAbort(fetch, buf, "digest cblock too big"); | |
678 | return -1; | |
9b7de833 | 679 | } |
62e76326 | 680 | |
cfd861ab | 681 | return 0; /* We need more data */ |
9b7de833 | 682 | } |
683 | ||
1f140227 | 684 | int |
9b7de833 | 685 | peerDigestSwapInMask(void *data, char *buf, ssize_t size) |
686 | { | |
e6ccf245 | 687 | DigestFetchState *fetch = (DigestFetchState *)data; |
e13ee7ad | 688 | PeerDigest *pd; |
689 | ||
e13ee7ad | 690 | pd = fetch->pd; |
691 | assert(pd->cd && pd->cd->mask); | |
9d486b43 | 692 | |
add2192d | 693 | /* |
694 | * NOTENOTENOTENOTENOTE: buf doesn't point to pd->cd->mask anymore! | |
695 | * we need to do the copy ourselves! | |
696 | */ | |
41d00cd3 | 697 | memcpy(pd->cd->mask + fetch->mask_offset, buf, size); |
add2192d | 698 | |
699 | /* NOTE! buf points to the middle of pd->cd->mask! */ | |
62e76326 | 700 | |
add2192d | 701 | if (peerDigestFetchedEnough(fetch, NULL, size, "peerDigestSwapInMask")) |
62e76326 | 702 | return -1; |
add2192d | 703 | |
da407def | 704 | fetch->mask_offset += size; |
62e76326 | 705 | |
57d55dfa | 706 | if (fetch->mask_offset >= pd->cd->mask_size) { |
e4049756 | 707 | debugs(72, 2, "peerDigestSwapInMask: Done! Got " << |
708 | fetch->mask_offset << ", expected " << pd->cd->mask_size); | |
57d55dfa | 709 | assert(fetch->mask_offset == pd->cd->mask_size); |
62e76326 | 710 | assert(peerDigestFetchedEnough(fetch, NULL, 0, "peerDigestSwapInMask")); |
f53969cc | 711 | return -1; /* XXX! */ |
9b7de833 | 712 | } |
62e76326 | 713 | |
cfd861ab AJ |
714 | /* We always read everything, so return size */ |
715 | return size; | |
9b7de833 | 716 | } |
717 | ||
718 | static int | |
4b4cd312 | 719 | peerDigestFetchedEnough(DigestFetchState * fetch, char *buf, ssize_t size, const char *step_name) |
9b7de833 | 720 | { |
e13ee7ad | 721 | PeerDigest *pd = NULL; |
f53969cc SM |
722 | const char *host = "<unknown>"; /* peer host */ |
723 | const char *reason = NULL; /* reason for completion */ | |
724 | const char *no_bug = NULL; /* successful completion if set */ | |
e2848e94 | 725 | const int pdcb_valid = cbdataReferenceValid(fetch->pd); |
726 | const int pcb_valid = cbdataReferenceValid(fetch->pd->peer); | |
e13ee7ad | 727 | |
728 | /* test possible exiting conditions (the same for most steps!) | |
729 | * cases marked with '?!' should not happen */ | |
730 | ||
731 | if (!reason) { | |
62e76326 | 732 | if (!(pd = fetch->pd)) |
733 | reason = "peer digest disappeared?!"; | |
734 | ||
f53969cc | 735 | #if DONT /* WHY NOT? /HNO */ |
62e76326 | 736 | |
737 | else if (!cbdataReferenceValid(pd)) | |
738 | reason = "invalidated peer digest?!"; | |
739 | ||
5385c86a | 740 | #endif |
62e76326 | 741 | |
742 | else | |
b4197865 | 743 | host = pd->host.termedBuf(); |
e13ee7ad | 744 | } |
62e76326 | 745 | |
e4049756 | 746 | debugs(72, 6, step_name << ": peer " << host << ", offset: " << |
747 | fetch->offset << " size: " << size << "."); | |
e13ee7ad | 748 | |
749 | /* continue checking (with pd and host known and valid) */ | |
62e76326 | 750 | |
e13ee7ad | 751 | if (!reason) { |
62e76326 | 752 | if (!cbdataReferenceValid(pd->peer)) |
753 | reason = "peer disappeared"; | |
754 | else if (size < 0) | |
755 | reason = "swap failure"; | |
756 | else if (!fetch->entry) | |
757 | reason = "swap aborted?!"; | |
758 | else if (EBIT_TEST(fetch->entry->flags, ENTRY_ABORTED)) | |
759 | reason = "swap aborted"; | |
e13ee7ad | 760 | } |
62e76326 | 761 | |
e13ee7ad | 762 | /* continue checking (maybe-successful eof case) */ |
763 | if (!reason && !size) { | |
62e76326 | 764 | if (!pd->cd) |
765 | reason = "null digest?!"; | |
47f6e231 | 766 | else if (fetch->mask_offset != (int)pd->cd->mask_size) |
62e76326 | 767 | reason = "premature end of digest?!"; |
768 | else if (!peerDigestUseful(pd)) | |
769 | reason = "useless digest"; | |
770 | else | |
771 | reason = no_bug = "success"; | |
e13ee7ad | 772 | } |
62e76326 | 773 | |
e13ee7ad | 774 | /* finish if we have a reason */ |
9b7de833 | 775 | if (reason) { |
62e76326 | 776 | const int level = strstr(reason, "?!") ? 1 : 3; |
bf8fe701 | 777 | debugs(72, level, "" << step_name << ": peer " << host << ", exiting after '" << reason << "'"); |
62e76326 | 778 | peerDigestReqFinish(fetch, buf, |
779 | 1, pdcb_valid, pcb_valid, reason, !no_bug); | |
e13ee7ad | 780 | } else { |
62e76326 | 781 | /* paranoid check */ |
782 | assert(pdcb_valid && pcb_valid); | |
e13ee7ad | 783 | } |
62e76326 | 784 | |
e13ee7ad | 785 | return reason != NULL; |
786 | } | |
787 | ||
551e60a9 | 788 | /* call this when all callback data is valid and fetch must be stopped but |
789 | * no error has occurred (e.g. we received 304 reply and reuse old digest) */ | |
790 | static void | |
791 | peerDigestFetchStop(DigestFetchState * fetch, char *buf, const char *reason) | |
792 | { | |
793 | assert(reason); | |
b4197865 | 794 | debugs(72, 2, "peerDigestFetchStop: peer " << fetch->pd->host << ", reason: " << reason); |
551e60a9 | 795 | peerDigestReqFinish(fetch, buf, 1, 1, 1, reason, 0); |
796 | } | |
797 | ||
e13ee7ad | 798 | /* call this when all callback data is valid but something bad happened */ |
799 | static void | |
800 | peerDigestFetchAbort(DigestFetchState * fetch, char *buf, const char *reason) | |
801 | { | |
551e60a9 | 802 | assert(reason); |
b4197865 | 803 | debugs(72, 2, "peerDigestFetchAbort: peer " << fetch->pd->host << ", reason: " << reason); |
e13ee7ad | 804 | peerDigestReqFinish(fetch, buf, 1, 1, 1, reason, 1); |
805 | } | |
806 | ||
807 | /* complete the digest transfer, update stats, unlock/release everything */ | |
808 | static void | |
809 | peerDigestReqFinish(DigestFetchState * fetch, char *buf, | |
62e76326 | 810 | int fcb_valid, int pdcb_valid, int pcb_valid, |
811 | const char *reason, int err) | |
e13ee7ad | 812 | { |
813 | assert(reason); | |
814 | ||
815 | /* must go before peerDigestPDFinish */ | |
62e76326 | 816 | |
e13ee7ad | 817 | if (pdcb_valid) { |
be4d35dc | 818 | fetch->pd->flags.requested = false; |
62e76326 | 819 | fetch->pd->req_result = reason; |
e13ee7ad | 820 | } |
62e76326 | 821 | |
e13ee7ad | 822 | /* schedule next check if peer is still out there */ |
823 | if (pcb_valid) { | |
62e76326 | 824 | PeerDigest *pd = fetch->pd; |
825 | ||
826 | if (err) { | |
827 | pd->times.retry_delay = peerDigestIncDelay(pd); | |
828 | peerDigestSetCheck(pd, pd->times.retry_delay); | |
829 | } else { | |
830 | pd->times.retry_delay = 0; | |
831 | peerDigestSetCheck(pd, peerDigestNewDelay(fetch->entry)); | |
832 | } | |
9b7de833 | 833 | } |
62e76326 | 834 | |
e13ee7ad | 835 | /* note: order is significant */ |
836 | if (fcb_valid) | |
62e76326 | 837 | peerDigestFetchSetStats(fetch); |
838 | ||
e13ee7ad | 839 | if (pdcb_valid) |
62e76326 | 840 | peerDigestPDFinish(fetch, pcb_valid, err); |
841 | ||
e13ee7ad | 842 | if (fcb_valid) |
62e76326 | 843 | peerDigestFetchFinish(fetch, err); |
9b7de833 | 844 | } |
845 | ||
e13ee7ad | 846 | /* destroys digest if peer disappeared |
847 | * must be called only when fetch and pd cbdata are valid */ | |
9b7de833 | 848 | static void |
e13ee7ad | 849 | peerDigestPDFinish(DigestFetchState * fetch, int pcb_valid, int err) |
9b7de833 | 850 | { |
e13ee7ad | 851 | PeerDigest *pd = fetch->pd; |
b4197865 | 852 | const char *host = pd->host.termedBuf(); |
e13ee7ad | 853 | |
854 | pd->times.received = squid_curtime; | |
855 | pd->times.req_delay = fetch->resp_time; | |
a0864754 AJ |
856 | pd->stats.sent.kbytes += fetch->sent.bytes; |
857 | pd->stats.recv.kbytes += fetch->recv.bytes; | |
e13ee7ad | 858 | pd->stats.sent.msgs += fetch->sent.msg; |
859 | pd->stats.recv.msgs += fetch->recv.msg; | |
860 | ||
861 | if (err) { | |
e0236918 | 862 | debugs(72, DBG_IMPORTANT, "" << (pcb_valid ? "temporary " : "" ) << "disabling (" << pd->req_result << ") digest from " << host); |
62e76326 | 863 | |
864 | if (pd->cd) { | |
865 | cacheDigestDestroy(pd->cd); | |
866 | pd->cd = NULL; | |
867 | } | |
868 | ||
be4d35dc | 869 | pd->flags.usable = false; |
62e76326 | 870 | |
871 | if (!pcb_valid) | |
872 | peerDigestNotePeerGone(pd); | |
e13ee7ad | 873 | } else { |
62e76326 | 874 | assert(pcb_valid); |
875 | ||
be4d35dc | 876 | pd->flags.usable = true; |
e13ee7ad | 877 | |
62e76326 | 878 | /* XXX: ugly condition, but how? */ |
e13ee7ad | 879 | |
62e76326 | 880 | if (fetch->entry->store_status == STORE_OK) |
bf8fe701 | 881 | debugs(72, 2, "re-used old digest from " << host); |
62e76326 | 882 | else |
bf8fe701 | 883 | debugs(72, 2, "received valid digest from " << host); |
d1cdaa16 | 884 | } |
62e76326 | 885 | |
fa80a8ef | 886 | cbdataReferenceDone(fetch->pd); |
e13ee7ad | 887 | } |
888 | ||
889 | /* free fetch state structures | |
890 | * must be called only when fetch cbdata is valid */ | |
891 | static void | |
892 | peerDigestFetchFinish(DigestFetchState * fetch, int err) | |
893 | { | |
894 | assert(fetch->entry && fetch->request); | |
895 | ||
9b7de833 | 896 | if (fetch->old_entry) { |
48e7baac | 897 | debugs(72, 3, "peerDigestFetchFinish: deleting old entry"); |
8121ba82 | 898 | storeUnregister(fetch->old_sc, fetch->old_entry, fetch); |
d88e3c49 | 899 | fetch->old_entry->releaseRequest(); |
acc5dc4c | 900 | fetch->old_entry->unlock("peerDigestFetchFinish old"); |
62e76326 | 901 | fetch->old_entry = NULL; |
9b7de833 | 902 | } |
62e76326 | 903 | |
1543ab6c | 904 | /* update global stats */ |
a0864754 AJ |
905 | statCounter.cd.kbytes_sent += fetch->sent.bytes; |
906 | statCounter.cd.kbytes_recv += fetch->recv.bytes; | |
83704487 | 907 | statCounter.cd.msgs_sent += fetch->sent.msg; |
908 | statCounter.cd.msgs_recv += fetch->recv.msg; | |
e13ee7ad | 909 | |
a44986dc | 910 | delete fetch; |
9b7de833 | 911 | } |
912 | ||
e13ee7ad | 913 | /* calculate fetch stats after completion */ |
914 | static void | |
915 | peerDigestFetchSetStats(DigestFetchState * fetch) | |
916 | { | |
917 | MemObject *mem; | |
918 | assert(fetch->entry && fetch->request); | |
919 | ||
920 | mem = fetch->entry->mem_obj; | |
921 | assert(mem); | |
922 | ||
923 | /* XXX: outgoing numbers are not precise */ | |
924 | /* XXX: we must distinguish between 304 hits and misses here */ | |
e11fe29a | 925 | fetch->sent.bytes = fetch->request->prefixLen(); |
528b2c61 | 926 | /* XXX: this is slightly wrong: we don't KNOW that the entire memobject |
927 | * was fetched. We only know how big it is | |
928 | */ | |
929 | fetch->recv.bytes = mem->size(); | |
e13ee7ad | 930 | fetch->sent.msg = fetch->recv.msg = 1; |
931 | fetch->expires = fetch->entry->expires; | |
932 | fetch->resp_time = squid_curtime - fetch->start_time; | |
933 | ||
bf8fe701 | 934 | debugs(72, 3, "peerDigestFetchFinish: recv " << fetch->recv.bytes << |
935 | " bytes in " << (int) fetch->resp_time << " secs"); | |
936 | ||
937 | debugs(72, 3, "peerDigestFetchFinish: expires: " << | |
938 | (long int) fetch->expires << " (" << std::showpos << | |
939 | (int) (fetch->expires - squid_curtime) << "), lmt: " << | |
940 | std::noshowpos << (long int) fetch->entry->lastmod << " (" << | |
941 | std::showpos << (int) (fetch->entry->lastmod - squid_curtime) << | |
942 | ")"); | |
943 | ||
e13ee7ad | 944 | } |
945 | ||
9b7de833 | 946 | static int |
8a6218c6 | 947 | peerDigestSetCBlock(PeerDigest * pd, const char *buf) |
9b7de833 | 948 | { |
949 | StoreDigestCBlock cblock; | |
950 | int freed_size = 0; | |
b4197865 | 951 | const char *host = pd->host.termedBuf(); |
e13ee7ad | 952 | |
41d00cd3 | 953 | memcpy(&cblock, buf, sizeof(cblock)); |
9b7de833 | 954 | /* network -> host conversions */ |
955 | cblock.ver.current = ntohs(cblock.ver.current); | |
956 | cblock.ver.required = ntohs(cblock.ver.required); | |
957 | cblock.capacity = ntohl(cblock.capacity); | |
958 | cblock.count = ntohl(cblock.count); | |
959 | cblock.del_count = ntohl(cblock.del_count); | |
960 | cblock.mask_size = ntohl(cblock.mask_size); | |
bf8fe701 | 961 | debugs(72, 2, "got digest cblock from " << host << "; ver: " << |
962 | (int) cblock.ver.current << " (req: " << (int) cblock.ver.required << | |
963 | ")"); | |
964 | ||
26ac0430 AJ |
965 | debugs(72, 2, "\t size: " << |
966 | cblock.mask_size << " bytes, e-cnt: " << | |
967 | cblock.count << ", e-util: " << | |
bf8fe701 | 968 | xpercentInt(cblock.count, cblock.capacity) << "%" ); |
6106c6fc | 969 | /* check version requirements (both ways) */ |
62e76326 | 970 | |
9b7de833 | 971 | if (cblock.ver.required > CacheDigestVer.current) { |
e0236918 | 972 | debugs(72, DBG_IMPORTANT, "" << host << " digest requires version " << |
bf8fe701 | 973 | cblock.ver.required << "; have: " << CacheDigestVer.current); |
974 | ||
62e76326 | 975 | return 0; |
9b7de833 | 976 | } |
62e76326 | 977 | |
6106c6fc | 978 | if (cblock.ver.current < CacheDigestVer.required) { |
e0236918 | 979 | debugs(72, DBG_IMPORTANT, "" << host << " digest is version " << |
bf8fe701 | 980 | cblock.ver.current << "; we require: " << |
981 | CacheDigestVer.required); | |
982 | ||
62e76326 | 983 | return 0; |
6106c6fc | 984 | } |
62e76326 | 985 | |
9b7de833 | 986 | /* check consistency */ |
4b4cd312 | 987 | if (cblock.ver.required > cblock.ver.current || |
62e76326 | 988 | cblock.mask_size <= 0 || cblock.capacity <= 0 || |
989 | cblock.bits_per_entry <= 0 || cblock.hash_func_count <= 0) { | |
fa84c01d | 990 | debugs(72, DBG_CRITICAL, "" << host << " digest cblock is corrupted."); |
62e76326 | 991 | return 0; |
9b7de833 | 992 | } |
62e76326 | 993 | |
d1cdaa16 | 994 | /* check consistency further */ |
e6ccf245 | 995 | if ((size_t)cblock.mask_size != cacheDigestCalcMaskSize(cblock.capacity, cblock.bits_per_entry)) { |
fa84c01d | 996 | debugs(72, DBG_CRITICAL, host << " digest cblock is corrupted " << |
e4049756 | 997 | "(mask size mismatch: " << cblock.mask_size << " ? " << |
998 | cacheDigestCalcMaskSize(cblock.capacity, cblock.bits_per_entry) | |
999 | << ")."); | |
62e76326 | 1000 | return 0; |
d1cdaa16 | 1001 | } |
62e76326 | 1002 | |
d1cdaa16 | 1003 | /* there are some things we cannot do yet */ |
1004 | if (cblock.hash_func_count != CacheDigestHashFuncCount) { | |
fa84c01d | 1005 | debugs(72, DBG_CRITICAL, "" << host << " digest: unsupported #hash functions: " << |
bf8fe701 | 1006 | cblock.hash_func_count << " ? " << CacheDigestHashFuncCount << "."); |
62e76326 | 1007 | return 0; |
d1cdaa16 | 1008 | } |
62e76326 | 1009 | |
9b7de833 | 1010 | /* |
1011 | * no cblock bugs below this point | |
1012 | */ | |
1013 | /* check size changes */ | |
e6ccf245 | 1014 | if (pd->cd && cblock.mask_size != (ssize_t)pd->cd->mask_size) { |
e4049756 | 1015 | debugs(72, 2, host << " digest changed size: " << cblock.mask_size << |
1016 | " -> " << pd->cd->mask_size); | |
62e76326 | 1017 | freed_size = pd->cd->mask_size; |
1018 | cacheDigestDestroy(pd->cd); | |
1019 | pd->cd = NULL; | |
9b7de833 | 1020 | } |
62e76326 | 1021 | |
e13ee7ad | 1022 | if (!pd->cd) { |
26ac0430 AJ |
1023 | debugs(72, 2, "creating " << host << " digest; size: " << cblock.mask_size << " (" << |
1024 | std::showpos << (int) (cblock.mask_size - freed_size) << ") bytes"); | |
62e76326 | 1025 | pd->cd = cacheDigestCreate(cblock.capacity, cblock.bits_per_entry); |
1026 | ||
1027 | if (cblock.mask_size >= freed_size) | |
a0864754 | 1028 | statCounter.cd.memory += (cblock.mask_size - freed_size); |
9b7de833 | 1029 | } |
62e76326 | 1030 | |
e13ee7ad | 1031 | assert(pd->cd); |
9b7de833 | 1032 | /* these assignments leave us in an inconsistent state until we finish reading the digest */ |
e13ee7ad | 1033 | pd->cd->count = cblock.count; |
1034 | pd->cd->del_count = cblock.del_count; | |
9b7de833 | 1035 | return 1; |
1036 | } | |
1037 | ||
9b7de833 | 1038 | static int |
8a6218c6 | 1039 | peerDigestUseful(const PeerDigest * pd) |
9b7de833 | 1040 | { |
d1cdaa16 | 1041 | /* TODO: we should calculate the prob of a false hit instead of bit util */ |
e13ee7ad | 1042 | const int bit_util = cacheDigestBitUtil(pd->cd); |
62e76326 | 1043 | |
e13ee7ad | 1044 | if (bit_util > 65) { |
fa84c01d | 1045 | debugs(72, DBG_CRITICAL, "Warning: " << pd->host << |
bf8fe701 | 1046 | " peer digest has too many bits on (" << bit_util << "%%)."); |
1047 | ||
62e76326 | 1048 | return 0; |
9b7de833 | 1049 | } |
62e76326 | 1050 | |
9b7de833 | 1051 | return 1; |
1052 | } | |
7f6eb0fe | 1053 | |
e13ee7ad | 1054 | static int |
1055 | saneDiff(time_t diff) | |
1056 | { | |
3db6fb54 | 1057 | return abs((int) diff) > squid_curtime / 2 ? 0 : diff; |
e13ee7ad | 1058 | } |
1059 | ||
1060 | void | |
8a6218c6 | 1061 | peerDigestStatsReport(const PeerDigest * pd, StoreEntry * e) |
e13ee7ad | 1062 | { |
1063 | #define f2s(flag) (pd->flags.flag ? "yes" : "no") | |
38650cc8 | 1064 | #define appendTime(tm) storeAppendPrintf(e, "%s\t %10ld\t %+d\t %+d\n", \ |
1065 | ""#tm, (long int)pd->times.tm, \ | |
e13ee7ad | 1066 | saneDiff(pd->times.tm - squid_curtime), \ |
1067 | saneDiff(pd->times.tm - pd->times.initialized)) | |
1068 | ||
e13ee7ad | 1069 | assert(pd); |
1070 | ||
b4197865 | 1071 | const char *host = pd->host.termedBuf(); |
e13ee7ad | 1072 | storeAppendPrintf(e, "\npeer digest from %s\n", host); |
1073 | ||
1074 | cacheDigestGuessStatsReport(&pd->stats.guess, e, host); | |
1075 | ||
1076 | storeAppendPrintf(e, "\nevent\t timestamp\t secs from now\t secs from init\n"); | |
1077 | appendTime(initialized); | |
1078 | appendTime(needed); | |
1079 | appendTime(requested); | |
1080 | appendTime(received); | |
1081 | appendTime(next_check); | |
1082 | ||
1083 | storeAppendPrintf(e, "peer digest state:\n"); | |
1084 | storeAppendPrintf(e, "\tneeded: %3s, usable: %3s, requested: %3s\n", | |
62e76326 | 1085 | f2s(needed), f2s(usable), f2s(requested)); |
e13ee7ad | 1086 | storeAppendPrintf(e, "\n\tlast retry delay: %d secs\n", |
62e76326 | 1087 | (int) pd->times.retry_delay); |
e13ee7ad | 1088 | storeAppendPrintf(e, "\tlast request response time: %d secs\n", |
62e76326 | 1089 | (int) pd->times.req_delay); |
e13ee7ad | 1090 | storeAppendPrintf(e, "\tlast request result: %s\n", |
62e76326 | 1091 | pd->req_result ? pd->req_result : "(none)"); |
e13ee7ad | 1092 | |
1093 | storeAppendPrintf(e, "\npeer digest traffic:\n"); | |
1094 | storeAppendPrintf(e, "\trequests sent: %d, volume: %d KB\n", | |
62e76326 | 1095 | pd->stats.sent.msgs, (int) pd->stats.sent.kbytes.kb); |
e13ee7ad | 1096 | storeAppendPrintf(e, "\treplies recv: %d, volume: %d KB\n", |
62e76326 | 1097 | pd->stats.recv.msgs, (int) pd->stats.recv.kbytes.kb); |
e13ee7ad | 1098 | |
1099 | storeAppendPrintf(e, "\npeer digest structure:\n"); | |
62e76326 | 1100 | |
e13ee7ad | 1101 | if (pd->cd) |
62e76326 | 1102 | cacheDigestReport(pd->cd, host, e); |
e13ee7ad | 1103 | else |
62e76326 | 1104 | storeAppendPrintf(e, "\tno in-memory copy\n"); |
e13ee7ad | 1105 | } |
1106 | ||
7f6eb0fe | 1107 | #endif |
f53969cc | 1108 |