[tor-bugs] #20423 [Core Tor/Tor]: Clock jumps on FreeBSD relay

[Tor Bug Tracker & Wiki]

#20423: Clock jumps on FreeBSD relay
--------------------------------+------------------------------------
 Reporter:  Felixix             |          Owner:
     Type:  defect              |         Status:  new
 Priority:  High                |      Milestone:  Tor: 0.2.9.x-final
Component:  Core Tor/Tor        |        Version:  Tor: 0.2.8.9
 Severity:  Normal              |     Resolution:
 Keywords:  regression freebsd  |  Actual Points:
Parent ID:                      |         Points:
 Reviewer:                      |        Sponsor:
--------------------------------+------------------------------------

Comment (by Felixix):

 There is an obvious difference in the log files between 0.2.7.6 and
 0.2.8.9:
 * 0.2.8.9 in the jail, debug after reload with about 23k times
 resolve_my_address etc, 5-6 min Tor down to 4% CPU
 * 0.2.7.6_1 in the *same* jail and keys, debug after reload with 4 times
 resolve_my_address etc, pushing data on 25% CPU

 For now I keep it like it is. If you want me to do anything please tell
 me. I would be glad if I can assist/test.

 ----
 0.2.8.9 in the jail, debug after reload:

 Nov 03 18:35:02.000 [info] router_write_fingerprint: Dumping fingerprint
 to "/var/db/tor/fingerprint"...
 Nov 03 18:35:02.000 [notice] Your Tor server's identity key fingerprint is
 'blabla fingerprint'
 Nov 03 18:35:02.000 [info] cell_ewma_set_scale_factor: Enabled cell_ewma
 algorithm because of value in CircuitPriorityHalflifeMsec in consensus;
 scale factor is 0.793701 per 10 seconds
 Nov 03 18:35:02.000 [info] options_act: Worker-related options changed.
 Rotating workers.
 Nov 03 18:35:02.000 [debug] configure_nameservers: stat()ing
 /etc/resolv.conf
 Nov 03 18:35:02.000 [info] configure_nameservers: No change to
 '/etc/resolv.conf'

 23484*
 Nov 03 18:35:02.000 [debug] resolve_my_address: Guessed local host name as
 'jail1'
 Nov 03 18:35:02.000 [info] resolve_my_address: Could not resolve guessed
 local hostname 'jail1'. Trying something else.
 Nov 03 18:35:02.000 [info] resolve_my_address: Learned IP address
 '10.x.x.x' for local interface. Using that.
 Nov 03 18:35:02.000 [info] resolve_my_address: Address '<guessed from
 interfaces>' resolves to private IP address '10.x.x.x'. Tor servers that
 use the default DirAuthorities must have public IP addresses.
 Nov 03 18:35:02.000 [info] router_pick_published_address: Could not
 determine our address locally. Checking if directory headers provide any
 hints.
 Nov 03 18:35:02.000 [info] router_pick_published_address: Success: chose
 address 'm.y.i.p'.
 ...

 25432*
 Nov 03 18:40:34.000 [debug] connection_bucket_refill_helper:
 or_conn->read_bucket now 1073741824.

 !!!
 Nov 03 18:40:34.000 [warn] Your system clock just jumped 332 seconds
 forward; assuming established circuits no longer work.

 2498*
 Nov 03 18:40:34.000 [debug] run_connection_housekeeping: Sending keepalive
 to (an.y.i.p:port)

 ----
 0.2.7.6_1 in the same jail, debug after reload:

 Nov 03 21:25:46.000 [info] int router_write_fingerprint(int): Dumping
 fingerprint to "/var/db/tor/fingerprint"...
 Nov 03 21:25:46.000 [notice] Your Tor server's identity key fingerprint is
 'blabla fingerprint'
 Nov 03 21:25:46.000 [info] void cell_ewma_set_scale_factor(const
 or_options_t *, const networkstatus_t *): Enabled cell_ewma algorithm
 because of value in CircuitPriorityHalflifeMsec in consensus; scale factor
 is 0.793701 per 10 seconds
 Nov 03 21:25:46.000 [info] int options_act(const or_options_t *): Worker-
 related options changed. Rotating workers.
 Nov 03 21:25:46.000 [debug] int configure_nameservers(int): stat()ing
 /etc/resolv.conf
 Nov 03 21:25:46.000 [info] int configure_nameservers(int): No change to
 '/etc/resolv.conf'

 4*
 Nov 03 21:25:46.000 [debug] int resolve_my_address(int, const or_options_t
 *, uint32_t *, const char **, char **): Guessed local host name as 'jail1'
 Nov 03 21:25:46.000 [info] int resolve_my_address(int, const or_options_t
 *, uint32_t *, const char **, char **): Could not resolve guessed local
 hostname 'jail1'. Trying something else.
 Nov 03 21:25:46.000 [info] int resolve_my_address(int, const or_options_t
 *, uint32_t *, const char **, char **): Learned IP address '10.x.x.x' for
 local interface. Using that.
 Nov 03 21:25:46.000 [info] int resolve_my_address(int, const or_options_t
 *, uint32_t *, const char **, char **): Address '<guessed from
 interfaces>' resolves to private IP address '10.x.x.x'. Tor servers that
 use the default DirAuthorities must have public IP addresses.
 Nov 03 21:25:46.000 [info] int router_pick_published_address(const
 or_options_t *, uint32_t *): Could not determine our address locally.
 Checking if directory headers provide any hints.
 Nov 03 21:25:46.000 [info] int router_pick_published_address(const
 or_options_t *, uint32_t *): Success: chose address 'm.y.i.p'.
 ...

 Nov 03 21:25:46.000 [debug] void directory_initiate_command_rend(const
 tor_addr_t *, uint16_t, uint16_t, const char *, uint8_t, uint8_t,
 dir_indirection_t, const char *, const char *, size_t, time_t, const
 rend_data_t *): anonymized 0, use_begindir 0.
 ...

 20*
 Nov 03 21:25:46.000 [debug] void connection_bucket_refill_helper(int *,
 int, int, int, const char *): or_conn->read_bucket now 1073741824.

--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/20423#comment:13>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online