#24346: prop224: Service stops uploading one of its two descriptors
-----------------------------+------------------------------------
Reporter: asn | Owner: dgoulet
Type: defect | Status: needs_revision
Priority: Medium | Milestone: Tor: 0.3.2.x-final
Component: Core Tor/Tor | Version: Tor: 0.3.2.4-alpha
Severity: Normal | Resolution:
Keywords: prop224, tor-hs | Actual Points:
Parent ID: | Points: 2
Reviewer: | Sponsor:
-----------------------------+------------------------------------
Changes (by asn):
* status: needs_review => needs_revision
Comment:
Replying to [comment:3 dgoulet]:
> See branch for the added logging statements: `ticket24346_032_01`
>
> Once merged, lets move this ticket to 033 in `needs_information` because
without these log statements, I fear understanding whats going on will be
near impossible.
Hm. Here is how this branch looks like on my HS (I bumped the msgs to
warn):
{{{
Nov 30 08:25:03.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512030303. [1198
similar message(s) suppressed in last 600 seconds]
Nov 30 08:35:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512030902. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 08:45:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512031502. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 08:55:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512032102. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 09:05:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512032702. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 09:15:03.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512033303. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 09:25:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512033902. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 09:35:03.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512034503. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 09:45:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512035656, it is now 1512035102. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 09:55:03.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512035703. [1198
similar message(s) suppressed in last 600 seconds]
Nov 30 10:05:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512036302. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 10:15:02.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512036902. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 10:20:59.000 [warn] Service onion can't upload its current
descriptor. Intro circuits aren't yet all established (2/3). [712 similar
message(s) suppressed in last 60 seconds]
Nov 30 10:30:58.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512037858. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 10:40:59.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512038459. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 10:50:58.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512039058. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 11:00:58.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512039658. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 11:10:58.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512040258. [1197
similar message(s) suppressed in last 600 seconds]
Nov 30 11:20:58.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512040858. [1199
similar message(s) suppressed in last 600 seconds]
Nov 30 11:30:59.000 [warn] Service onion can't upload its current
descriptor. Next upload time is 1512042695, it is now 1512041459. [1199
similar message(s) suppressed in last 600 seconds]
}}}
As you can see it only cares about current desc. I think that's because
the rate limiting subsystem does not care about the log msg, but only
about the rate limiting block. So it will suppress different msgs as well
(in this case suppress the next descriptor msgs), if they are within the
same rate limiting block.
If the above is correct, I think the branch needs revision because it will
hide useful information from us.
--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/24346#comment:4>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online
_______________________________________________
tor-bugs mailing list
tor-bugs@lists.torproject.org
https://lists.torproject.org/cgi-bin/mailman/listinfo/tor-bugs
