[tor-bugs] #22212 [Core Tor/Tor]: [warn] channelpadding_compute_time_until_pad_for_netflow(): Bug: Channel padding timeout scheduled 164729ms in the past. Did the monotonic clock just jump?

[Tor Bug Tracker & Wiki]

#22212: [warn] channelpadding_compute_time_until_pad_for_netflow(): Bug: Channel
padding timeout scheduled 164729ms in the past. Did the monotonic clock
just jump?
--------------------------+------------------------------------
 Reporter:  arma          |          Owner:  mikeperry
     Type:  defect        |         Status:  reopened
 Priority:  Medium        |      Milestone:  Tor: 0.3.2.x-final
Component:  Core Tor/Tor  |        Version:  Tor: 0.3.1.1-alpha
 Severity:  Normal        |     Resolution:
 Keywords:  tor-client    |  Actual Points:
Parent ID:                |         Points:
 Reviewer:                |        Sponsor:  Sponsor2
--------------------------+------------------------------------

Comment (by Pine64ARMv8):

 I this can help, "Channel padding timeout scheduled XXXXXXms in the past."
 appears also with Tor 0.3.2.9:


 {{{
 Jan 09 21:10:25.461 [notice] Tor 0.3.2.9 (git-9e8b762fcecfece6) running on
 Linux with Libevent 2.1.8-stable, OpenSSL 1.1.1-dev, Zlib 1.2.8, Liblzma
 5.1.0alpha, and Libzstd 1.3.2.
 .../...
 Jan 14 22:45:33.000 [notice] Channel padding timeout scheduled 182518ms in
 the past.
 Jan 15 01:59:48.000 [notice] Heartbeat: Tor's uptime is 5 days 3:59 hours,
 with 6126 circuits open. I've sent 324.43 GB and received 309.87 GB.
 Jan 15 01:59:48.000 [notice] Circuit handshake stats since last time:
 2349/2349 TAP, 866755/867105 NTor.
 Jan 15 01:59:48.000 [notice] Since startup, we have initiated 0 v1
 connections, 0 v2 connections, 0 v3 connections, and 109957 v4
 connections; and received 182 v1 connections, 3720 v2 connections, 6311 v3
 connections, and 458930 v4 connections.
 Jan 15 05:59:48.000 [notice] Heartbeat: Tor's uptime is 5 days 7:59 hours,
 with 5870 circuits open. I've sent 336.13 GB and received 321.51 GB.
 Jan 15 05:59:48.000 [notice] Circuit handshake stats since last time:
 1602/1602 TAP, 811672/811672 NTor.
 Jan 15 05:59:48.000 [notice] Since startup, we have initiated 0 v1
 connections, 0 v2 connections, 0 v3 connections, and 112952 v4
 connections; and received 182 v1 connections, 3835 v2 connections, 6599 v3
 connections, and 475508 v4 connections.
 Jan 15 06:22:19.000 [notice] Channel padding timeout scheduled 221453ms in
 the past.
 Jan 15 09:59:48.000 [notice] Heartbeat: Tor's uptime is 5 days 11:59
 hours, with 7482 circuits open. I've sent 351.16 GB and received 336.47
 GB.
 Jan 15 09:59:48.000 [notice] Circuit handshake stats since last time:
 2110/2110 TAP, 841999/841999 NTor.
 Jan 15 09:59:48.000 [notice] Since startup, we have initiated 0 v1
 connections, 0 v2 connections, 0 v3 connections, and 116107 v4
 connections; and received 183 v1 connections, 4016 v2 connections, 6939 v3
 connections, and 493174 v4 connections.
 Jan 15 12:26:07.000 [notice] Channel padding timeout scheduled 263389ms in
 the past.
 Jan 15 13:59:48.000 [notice] Heartbeat: Tor's uptime is 5 days 15:59
 hours, with 8796 circuits open. I've sent 363.28 GB and received 348.51
 GB.
 Jan 15 13:59:48.000 [notice] Circuit handshake stats since last time:
 2072/2072 TAP, 750040/750040 NTor.
 Jan 15 13:59:48.000 [notice] Since startup, we have initiated 0 v1
 connections, 0 v2 connections, 0 v3 connections, and 119247 v4
 connections; and received 184 v1 connections, 4184 v2 connections, 7267 v3
 connections, and 509112 v4 connections.

 }}}

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