[tor-bugs] #2003 [Tor Relay]: Hibernation Soft and Hard Limits Reached Simultaneously
Tor Bug Tracker & Wiki
torproject-admin at torproject.org
Thu Sep 1 02:45:55 UTC 2011
#2003: Hibernation Soft and Hard Limits Reached Simultaneously
-----------------------------------+----------------------------------------
Reporter: BarkerJr | Type: defect
Status: needs_information | Priority: normal
Milestone: Tor: 0.2.2.x-final | Component: Tor Relay
Version: Tor: unspecified | Keywords:
Parent: | Points:
Actualpoints: |
-----------------------------------+----------------------------------------
Comment(by BarkerJr):
Here are the august logs:
Aug 01 00:00:00.302 [info] configure_accounting(): Accounting interval
elapsed; starting a new one
Aug 01 00:00:00.326 [info] reset_accounting(): Starting new accounting
interval.
Aug 01 00:00:00.326 [notice] Configured hibernation. This interval began
at 2011-08-01 00:00:00; the scheduled wake-up time was 2011-08-01
00:00:00; we expect to exhaust our quota for this interval around
2011-09-01 00:00:00; the next interval begins at 2011-09-01 00:00:00 (all
times local)
Aug 01 00:00:00.326 [notice] Hibernation period ended. Resuming normal
activity.
Aug 01 00:00:00.326 [notice] Opening OR listener on 0.0.0.0:0
Aug 01 00:00:00.326 [notice] OR listener listening on port 55198.
Aug 01 00:00:45.451 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 96/2495 usable
descriptors.
Aug 01 00:00:45.572 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 192/2495 usable
descriptors.
Aug 01 00:00:45.639 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 288/2495 usable
descriptors.
Aug 01 00:00:45.856 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 383/2495 usable
descriptors.
Aug 01 00:00:45.925 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 479/2495 usable
descriptors.
Aug 01 00:00:45.951 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 575/2495 usable
descriptors.
Aug 01 00:00:46.010 [notice] We now have enough directory information to
build circuits.
Aug 01 01:09:55.756 [notice] Tor has successfully opened a circuit. Looks
like client functionality is working.
Aug 01 01:09:57.695 [notice] Performing bandwidth self-test...done.
Aug 06 00:45:22.711 [notice] Bandwidth soft limit reached; commencing
hibernation. No new conncetions will be accepted
Aug 06 00:45:23.712 [notice] Going dormant. Blowing away remaining
connections.
Aug 07 15:12:44.888 [notice] Tor 0.2.2.30-rc (git-085c9754ccae6cae)
opening log file.
Aug 07 15:12:45.005 [notice] Based on 1000 circuit times, it looks like we
don't need to wait so long for circuits to finish. We will now assume a
circuit is too slow to use after waiting 9 seconds.
Aug 07 15:12:45.005 [info] read_bandwidth_usage(): Reading bandwidth
accounting data from state file
Aug 07 15:12:45.005 [info] read_bandwidth_usage(): Successfully read
bandwidth accounting info from state written at 2011-08-07 12:56:20 for
interval starting at 2011-08-01 00:00:00. We have been active for 564920
seconds in this interval. At the start of the interval, we expected to
use about 82363 KB per second. (158892689408 bytes read so far,
161061789696 bytes written so far)
Aug 07 15:12:45.005 [info] configure_accounting(): Continuing accounting
interval.
Aug 07 15:12:45.542 [notice] OpenSSL OpenSSL 1.0.0d 8 Feb 2011 looks like
version 0.9.8m or later; I will try SSL_OP to enable renegotiation
Aug 07 15:12:45.871 [notice] Your Tor server's identity key fingerprint is
'BarkerJrAtom2 94E35409D98D1E43663999B9BF30A4982CD3A40E'
Aug 07 15:12:45.871 [notice] Configured hibernation. This interval began
at 2011-08-01 00:00:00; the scheduled wake-up time was 2011-08-01
00:00:00; we expect to exhaust our quota for this interval around
2011-09-01 00:00:00; the next interval begins at 2011-09-01 00:00:00 (all
times local)
Aug 07 15:12:46.105 [notice] Parsing GEOIP file
/usr/local/share/tor/geoip.
Aug 07 15:13:00.688 [notice] Bootstrapped 45%: Asking for relay
descriptors.
Aug 07 15:13:00.688 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 0/2607 usable descriptors.
Aug 07 15:13:00.896 [notice] Bootstrapped 50%: Loading relay descriptors.
Aug 07 15:13:00.896 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 14/2607 usable
descriptors.
Aug 07 15:13:00.924 [notice] Bootstrapped 54%: Loading relay descriptors.
Aug 07 15:13:00.924 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 110/2607 usable
descriptors.
Aug 07 15:13:00.951 [notice] Bootstrapped 59%: Loading relay descriptors.
Aug 07 15:13:00.951 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 205/2607 usable
descriptors.
Aug 07 15:13:01.074 [notice] Bootstrapped 63%: Loading relay descriptors.
Aug 07 15:13:01.074 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 301/2607 usable
descriptors.
Aug 07 15:13:01.240 [notice] Bootstrapped 67%: Loading relay descriptors.
Aug 07 15:13:01.240 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 397/2606 usable
descriptors.
Aug 07 15:13:01.384 [notice] Bootstrapped 71%: Loading relay descriptors.
Aug 07 15:13:01.384 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 490/2606 usable
descriptors.
Aug 07 15:13:01.710 [notice] Bandwidth soft limit reached; commencing
hibernation. No new conncetions will be accepted
Aug 07 15:13:01.710 [notice] Going dormant. Blowing away remaining
connections.
Aug 07 15:13:01.953 [notice] Bootstrapped 76%: Loading relay descriptors.
Aug 07 15:13:01.953 [notice] I learned some more directory information,
but not enough to build a circuit: We have only 585/2604 usable
descriptors.
Aug 07 15:13:01.975 [notice] We now have enough directory information to
build circuits.
Aug 07 15:13:01.975 [notice] Bootstrapped 80%: Connecting to the Tor
network.
Aug 16 23:59:45.153 [notice] Tor 0.2.2.30-rc (git-085c9754ccae6cae)
opening log file.
Aug 16 23:59:45.442 [notice] Based on 1000 circuit times, it looks like we
don't need to wait so long for circuits to finish. We will now assume a
circuit is too slow to use after waiting 9 seconds.
Aug 16 23:59:45.442 [info] read_bandwidth_usage(): Reading bandwidth
accounting data from state file
Aug 16 23:59:45.442 [info] read_bandwidth_usage(): Successfully read
bandwidth accounting info from state written at 2011-08-16 23:04:01 for
interval starting at 2011-08-01 00:00:00. We have been active for 1370720
seconds in this interval. At the start of the interval, we expected to
use about 82363 KB per second. (158963741696 bytes read so far,
161065438208 bytes written so far)
Aug 16 23:59:45.442 [info] configure_accounting(): Continuing accounting
interval.
Aug 16 23:59:45.981 [notice] OpenSSL OpenSSL 1.0.0d 8 Feb 2011 looks like
version 0.9.8m or later; I will try SSL_OP to enable renegotiation
Aug 16 23:59:46.067 [notice] Your Tor server's identity key fingerprint is
'BarkerJrAtom2 94E35409D98D1E43663999B9BF30A4982CD3A40E'
Aug 16 23:59:46.067 [notice] Configured hibernation. This interval began
at 2011-08-01 00:00:00; the scheduled wake-up time was 2011-08-01
00:00:00; we expect to exhaust our quota for this interval around
2011-09-01 00:00:00; the next interval begins at 2011-09-01 00:00:00 (all
times local)
Aug 16 23:59:46.282 [notice] Parsing GEOIP file
/usr/local/share/tor/geoip.
Aug 16 23:59:55.332 [notice] We now have enough directory information to
build circuits.
Aug 16 23:59:55.332 [notice] Bootstrapped 80%: Connecting to the Tor
network.
Aug 16 23:59:56.332 [notice] Bandwidth soft limit reached; commencing
hibernation. No new conncetions will be accepted
Aug 16 23:59:56.333 [notice] Going dormant. Blowing away remaining
connections.
Aug 27 00:02:23.848 [notice] SIGINT received while hibernating; exiting
now.
Aug 27 00:03:01.595 [notice] Tor 0.2.2.31-rc (git-dd18fcbbae84a9ac)
opening log file.
Aug 27 00:03:01.601 [notice] Based on 1000 circuit times, it looks like we
don't need to wait so long for circuits to finish. We will now assume a
circuit is too slow to use after waiting 9 seconds.
Aug 27 00:03:01.601 [info] read_bandwidth_usage(): Reading bandwidth
accounting data from state file
Aug 27 00:03:01.601 [info] read_bandwidth_usage(): Successfully read
bandwidth accounting info from state written at 2011-08-27 00:02:23 for
interval starting at 2011-08-01 00:00:00. We have been active for 2234867
seconds in this interval. At the start of the interval, we expected to
use about 82363 KB per second. (159034652672 bytes read so far,
161068877824 bytes written so far)
Aug 27 00:03:01.601 [info] configure_accounting(): Continuing accounting
interval.
Aug 27 00:03:01.676 [notice] OpenSSL OpenSSL 1.0.0d 8 Feb 2011 looks like
version 0.9.8m or later; I will try SSL_OP to enable renegotiation
Aug 27 00:03:01.752 [notice] Your Tor server's identity key fingerprint is
'BarkerJrAtom2 94E35409D98D1E43663999B9BF30A4982CD3A40E'
Aug 27 00:03:01.752 [notice] Configured hibernation. This interval began
at 2011-08-01 00:00:00; the scheduled wake-up time was 2011-08-01
00:00:00; we expect to exhaust our quota for this interval around
2011-09-01 00:00:00; the next interval begins at 2011-09-01 00:00:00 (all
times local)
Aug 27 00:03:01.752 [notice] Parsing GEOIP file
/usr/local/share/tor/geoip.
Aug 27 00:03:02.793 [notice] We now have enough directory information to
build circuits.
Aug 27 00:03:02.793 [notice] Bootstrapped 80%: Connecting to the Tor
network.
Aug 27 00:03:03.794 [notice] Bandwidth soft limit reached; commencing
hibernation. No new conncetions will be accepted
Aug 27 00:03:03.794 [notice] Going dormant. Blowing away remaining
connections.
Sep 01 00:00:00.600 [info] configure_accounting(): Accounting interval
elapsed; starting a new one
Sep 01 00:00:00.621 [info] reset_accounting(): Starting new accounting
interval.
Sep 01 00:00:00.621 [notice] Configured hibernation. This interval began
at 2011-09-01 00:00:00; the scheduled wake-up time was 2011-09-01
00:00:00; we expect to exhaust our quota for this interval around
2011-10-01 00:00:00; the next interval begins at 2011-10-01 00:00:00 (all
times local)
Sep 01 00:00:00.621 [notice] Hibernation period ended. Resuming normal
activity.
Sep 01 00:00:00.621 [notice] Opening OR listener on 0.0.0.0:0
Sep 01 00:00:00.621 [notice] OR listener listening on port 38837.
Sep 01 00:00:00.836 [notice] Bootstrapped 85%: Finishing handshake with
first hop.
Sep 01 00:00:02.172 [notice] Bootstrapped 90%: Establishing a Tor circuit.
Sep 01 00:00:05.446 [notice] Tor has successfully opened a circuit. Looks
like client functionality is working.
Sep 01 00:00:05.446 [notice] Bootstrapped 100%: Done.
Sep 01 00:00:05.446 [notice] Now checking whether ORPort
74.207.254.217:38837 is reachable... (this may take up to 20 minutes --
look for log messages indicating success)
Sep 01 00:00:08.442 [notice] Self-testing indicates your ORPort is
reachable from the outside. Excellent. Publishing server descriptor.
Sep 01 00:00:09.660 [notice] We're missing a certificate from authority
with signing key F7C7B9191C74C0BA07363C84D37BBAD3A8A6C6D8: launching
request.
Sep 01 00:00:09.660 [notice] We're missing a certificate from authority
with signing key 604834622B54F2D9BA39B34AC53924546733AA60: launching
request.
Sep 01 00:00:13.703 [notice] Performing bandwidth self-test...done.
--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/2003#comment:16>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online
More information about the tor-bugs
mailing list