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