Unusual CPU usage on Bitcoin daemon over Tor (addcon, opencon) #16004

issue perefeliu openend this issue on May 10, 2019
  1. perefeliu commented at 9:26 am on May 10, 2019: none

    I am experiencing a boost in CPU usage once I used a the Bitcoin daemon over Tor&clearnet with a hidden service. The CPU usage was very low when my Bitcoin node was only on clearnet but rigth now is always using one or two core at 100%, out of 8 cores nearly all the time.

    I was expecting a similar or at least slightly higher CPU usage over Tor compared to a clearnet node.

    imagen

    The issue is continuous. I have usually 12 outbound connections (over Tor or Clearnet) and 3-5 inbound connections over Tor.

    My bitcoin version is the v0.18.0

    My sistem is an Odroid HC1 with an SSD. The OS is Ubuntu 16.04.6 LTS XENIAL. I am using a lightning node over LND within the same system.

    I don’t see anything strange other than a lot of refused connections on debug.log. I attach the last lines of the debug.log file.

      02019-05-09T23:26:22Z UpdateTip: new best=0000000000000000000afe04af305f885d67b6d666cea19fcb431c9b1b04a519 height=575340 version=0x20000000 log2_work=90.62208 tx=411607669 date='2019-05-09T23:26:11Z' progress=1.000000 cache=29.2MiB(256898txo) warning='37 of last 100 blocks have unexpected version'
  12019-05-09T23:26:57Z UpdateTip: new best=0000000000000000000553864f70dd499354f6ee46e1dcfdd5fa169135d69a67 height=575341 version=0x20800000 log2_work=90.622101 tx=411609206 date='2019-05-09T23:26:32Z' progress=1.000000 cache=29.7MiB(262016txo) warning='37 of last 100 blocks have unexpected version'
  22019-05-09T23:31:38Z UpdateTip: new best=00000000000000000013113b6bae51edcdb774450d85f6395f2fc2ddea497800 height=575342 version=0x20400000 log2_work=90.622123 tx=411611238 date='2019-05-09T23:31:04Z' progress=1.000000 cache=30.2MiB(266063txo) warning='37 of last 100 blocks have unexpected version'
  32019-05-09T23:35:59Z Socks5() connect to 2a02:8071:82cd:e100:778d:dc56:e57c:b1ce:8333 failed: host unreachable
  42019-05-09T23:38:59Z Socks5() connect to 146.52.89.93:8333 failed: host unreachable
  52019-05-09T23:39:31Z Pre-allocating up to position 0x700000 in rev01631.dat
  62019-05-09T23:39:31Z UpdateTip: new best=000000000000000000277e7a28795bafd466fe13ef7397e2c59994c9946eae9f height=575343 version=0x20c00000 log2_work=90.622145 tx=411613970 date='2019-05-09T23:39:13Z' progress=1.000000 cache=30.7MiB(271159txo) warning='37 of last 100 blocks have unexpected version'
  72019-05-09T23:44:34Z Socks5() connect to 92.76.174.124:8333 failed: general failure
  82019-05-09T23:45:41Z UpdateTip: new best=000000000000000000024fff922c2e823385d6669c31f99ad19b503659e8f0e6 height=575344 version=0x20000000 log2_work=90.622167 tx=411616160 date='2019-05-09T23:45:10Z' progress=1.000000 cache=31.1MiB(274652txo) warning='37 of last 100 blocks have unexpected version'
  92019-05-09T23:48:16Z Socks5() connect to 184.75.208.74:8333 failed: connection refused
 102019-05-09T23:50:06Z Socks5() connect to 195.95.232.166:8333 failed: host unreachable
 112019-05-09T23:55:03Z Socks5() connect to 2601:345:4202:e9a::d411:8333 failed: general failure
 122019-05-09T23:56:56Z New outbound peer connected: version: 70015, blocks=575344, peer=150
 132019-05-10T00:04:17Z Socks5() connect to 103.225.124.94:8333 failed: host unreachable
 142019-05-10T00:06:30Z New outbound peer connected: version: 70015, blocks=575344, peer=154
 152019-05-10T00:07:23Z Socks5() connect to 61.74.181.139:8333 failed: connection refused
 162019-05-10T00:16:10Z New outbound peer connected: version: 70015, blocks=575344, peer=158
 172019-05-10T00:17:18Z UpdateTip: new best=00000000000000000024ece831f33fbb489adb40bf921e4027fb7d035f7228c2 height=575345 version=0x20400000 log2_work=90.622188 tx=411619340 date='2019-05-10T00:16:40Z' progress=1.000000 cache=32.3MiB(286409txo) warning='37 of last 100 blocks have unexpected version'
 182019-05-10T00:19:56Z Socks5() connect to 2001:4dd4:1bfc:0:7f66:f8cf:d29:ecd2:8333 failed: connection refused
 192019-05-10T00:21:09Z Socks5() connect to 46.0.68.2:8333 failed: connection refused
 202019-05-10T00:21:46Z Socks5() connect to 165.165.166.154:8333 failed: connection refused
 212019-05-10T00:23:43Z Socks5() connect to 220.240.30.5:8333 failed: general failure
 222019-05-10T00:29:02Z Socks5() connect to 178.45.197.88:8333 failed: connection refused
 232019-05-10T00:31:01Z Socks5() connect to 74.202.83.27:8333 failed: connection refused
 242019-05-10T00:32:04Z Socks5() connect to 2604:2d80:cc11:8ae1:7430:57dc:36bc:e6d5:8333 failed: host unreachable
 252019-05-10T00:33:45Z Socks5() connect to 101.51.154.239:8333 failed: connection refused
 262019-05-10T00:37:21Z Socks5() connect to 185.117.215.9:8333 failed: connection refused
 272019-05-10T00:43:10Z Pre-allocating up to position 0x4000000 in blk01631.dat
 282019-05-10T00:43:11Z UpdateTip: new best=0000000000000000001261f67440b680e53418264e5f488bbb16a9f2941aaad2 height=575346 version=0x20000000 log2_work=90.62221 tx=411622641 date='2019-05-10T00:42:49Z' progress=1.000000 cache=33.2MiB(294217txo) warning='37 of last 100 blocks have unexpected version'
 292019-05-10T00:50:00Z Socks5() connect to 194.44.53.2:8333 failed: connection refused
 302019-05-10T00:51:54Z Socks5() connect to 2604:6000:1012:c633::285:8333 failed: general failure
 312019-05-10T00:54:11Z Socks5() connect to 2001:1b60:3:221:3132:102:0:1:8333 failed: connection refused
 322019-05-10T01:06:41Z UpdateTip: new best=000000000000000000020349af1964eb3a47451b51f172b768e377a6842194dd height=575347 version=0x20000000 log2_work=90.622232 tx=411625634 date='2019-05-10T01:06:35Z' progress=1.000000 cache=34.0MiB(302312txo) warning='37 of last 100 blocks have unexpected version'
 332019-05-10T01:08:20Z Socks5() connect to 162.156.84.221:8333 failed: connection refused
 342019-05-10T01:19:51Z UpdateTip: new best=0000000000000000000bd90f53dcc5b8813a96d6df5304e73558d73f578073de height=575348 version=0x20400000 log2_work=90.622254 tx=411627496 date='2019-05-10T01:19:36Z' progress=1.000000 cache=35.7MiB(318270txo) warning='38 of last 100 blocks have unexpected version'
 352019-05-10T01:21:07Z Socks5() connect to 2001:16b8:48f:6300:31af:469:ed12:be91:8333 failed: connection refused
 362019-05-10T01:22:47Z Socks5() connect to 2607:fa18:3a01::50:8333 failed: general failure
 372019-05-10T01:37:55Z UpdateTip: new best=00000000000000000015d88c1c77d8cd4e340e610e04be9dec57482fdd735847 height=575349 version=0x20000000 log2_work=90.622276 tx=411630311 date='2019-05-10T01:37:43Z' progress=1.000000 cache=36.7MiB(327420txo) warning='38 of last 100 blocks have unexpected version'
 382019-05-10T01:44:54Z Pre-allocating up to position 0x800000 in rev01631.dat
 392019-05-10T01:44:54Z UpdateTip: new best=0000000000000000001debdb1474501b68123a0979a175d388dbe27f508f2a49 height=575350 version=0x20000000 log2_work=90.622297 tx=411632622 date='2019-05-10T01:44:45Z' progress=1.000000 cache=37.6MiB(335786txo) warning='38 of last 100 blocks have unexpected version'
 402019-05-10T01:48:16Z Socks5() connect to 179.83.249.217:8333 failed: connection refused
 412019-05-10T01:50:49Z Socks5() connect to 2001:470:6f:14b:5091:2641:33aa:f6b:8333 failed: host unreachable
 422019-05-10T01:59:38Z Socks5() connect to 188.167.251.17:8333 failed: connection refused
 432019-05-10T02:03:51Z UpdateTip: new best=00000000000000000001af4445650c03f7812f9bd6e5c6bd1d09b19e32f6ecba height=575351 version=0x20800000 log2_work=90.622319 tx=411634960 date='2019-05-10T02:03:15Z' progress=1.000000 cache=38.8MiB(346742txo) warning='39 of last 100 blocks have unexpected version'
 442019-05-10T02:06:57Z Socks5() connect to 2001:1bc0:cc::a001:8333 failed: general failure
 452019-05-10T02:07:21Z UpdateTip: new best=0000000000000000001025947f4f7e07a4e7478fe54a1c75ddfc24aa3d02d107 height=575352 version=0x20000000 log2_work=90.622341 tx=411636487 date='2019-05-10T02:06:50Z' progress=1.000000 cache=39.7MiB(355465txo) warning='39 of last 100 blocks have unexpected version'
 462019-05-10T02:08:21Z Socks5() connect to 83.251.255.201:8333 failed: connection refused
 472019-05-10T02:10:36Z New outbound peer connected: version: 70015, blocks=575352, peer=202
 482019-05-10T02:18:21Z Socks5() connect to 2600:8801:db00:8a3::3d05:8333 failed: general failure
 492019-05-10T02:20:10Z New outbound peer connected: version: 70015, blocks=575352, peer=207
 502019-05-10T02:21:34Z Socks5() connect to 46.38.44.125:8333 failed: connection refused
 512019-05-10T02:23:58Z Socks5() connect to 66.254.234.20:8333 failed: connection refused
 522019-05-10T02:29:44Z New outbound peer connected: version: 70015, blocks=575352, peer=212
 532019-05-10T02:30:43Z Socks5() connect to 212.92.123.25:8333 failed: connection refused
 542019-05-10T02:30:44Z UpdateTip: new best=000000000000000000295cf01850067c2ca6bca5b0c1eeaabf520433d88bee54 height=575353 version=0x20000000 log2_work=90.622363 tx=411638239 date='2019-05-10T02:30:18Z' progress=1.000000 cache=41.2MiB(369382txo) warning='39 of last 100 blocks have unexpected version'
 552019-05-10T02:34:04Z Socks5() connect to 5.12.251.236:8333 failed: connection refused
 562019-05-10T02:35:54Z New outbound peer connected: version: 70015, blocks=575353, peer=216
 572019-05-10T02:39:21Z New outbound peer connected: version: 70015, blocks=575353, peer=218
 582019-05-10T02:43:00Z Socks5() connect to 195.201.71.60:8333 failed: connection refused
 592019-05-10T02:44:40Z Socks5() connect to 94.134.40.42:8333 failed: host unreachable
 602019-05-10T02:48:07Z Socks5() connect to 5.63.46.78:8333 failed: general failure
 612019-05-10T02:48:55Z New outbound peer connected: version: 70015, blocks=575353, peer=222
 622019-05-10T02:56:57Z UpdateTip: new best=0000000000000000001f221f95ab5ef4fcd3bd5daef93c0733f8fbfc79d427d2 height=575354 version=0x20000000 log2_work=90.622385 tx=411640557 date='2019-05-10T02:56:57Z' progress=1.000000 cache=42.2MiB(378722txo) warning='39 of last 100 blocks have unexpected version'
 632019-05-10T02:58:29Z New outbound peer connected: version: 70015, blocks=575354, peer=227
 642019-05-10T03:02:34Z Socks5() connect to 78.55.173.143:8333 failed: host unreachable
 652019-05-10T03:04:11Z Socks5() connect to 82.207.200.54:8333 failed: connection refused
 662019-05-10T03:16:55Z UpdateTip: new best=000000000000000000254a5c0bc74e13f30a05e845933cd9edf8f343ea68c0f1 height=575355 version=0x20000000 log2_work=90.622406 tx=411642951 date='2019-05-10T03:16:08Z' progress=1.000000 cache=42.7MiB(382888txo) warning='39 of last 100 blocks have unexpected version'
 672019-05-10T03:17:05Z Socks5() connect to 79.238.94.191:8333 failed: host unreachable
 682019-05-10T03:17:36Z New outbound peer connected: version: 70015, blocks=575355, peer=232
 692019-05-10T03:19:41Z UpdateTip: new best=0000000000000000002236af2a588d3afcb3a161c168e882b9cc37a2e90652fc height=575356 version=0x20c00000 log2_work=90.622428 tx=411645219 date='2019-05-10T03:19:15Z' progress=1.000000 cache=43.1MiB(386955txo) warning='40 of last 100 blocks have unexpected version'
 702019-05-10T03:21:57Z Socks5() connect to 104.254.90.87:8333 failed: connection refused
 712019-05-10T03:26:19Z Socks5() connect to 24.85.181.241:8333 failed: general failure
 722019-05-10T03:28:53Z Socks5() connect to 78.94.232.189:8333 failed: connection refused
 732019-05-10T03:30:32Z Pre-allocating up to position 0x900000 in rev01631.dat
 742019-05-10T03:30:32Z UpdateTip: new best=000000000000000000007d00d8514b5dad5773a202bfd6ef6b970e53a56109d9 height=575357 version=0x20c00000 log2_work=90.62245 tx=411647204 date='2019-05-10T03:29:51Z' progress=1.000000 cache=43.9MiB(394314txo) warning='40 of last 100 blocks have unexpected version'
 752019-05-10T03:35:50Z Socks5() connect to 2a01:4f9:2b:fa2::2:8333 failed: general failure
 762019-05-10T03:36:42Z New outbound peer connected: version: 70015, blocks=575357, peer=238
 772019-05-10T03:46:16Z New outbound peer connected: version: 70015, blocks=575357, peer=241
 782019-05-10T03:48:20Z Pre-allocating up to position 0x5000000 in blk01631.dat
 792019-05-10T03:48:20Z UpdateTip: new best=0000000000000000001e91f514c47e9014893ac1418ec5b9a6590c38f71585e9 height=575358 version=0x20800000 log2_work=90.622472 tx=411649826 date='2019-05-10T03:48:04Z' progress=1.000000 cache=44.5MiB(399663txo) warning='40 of last 100 blocks have unexpected version'
 802019-05-10T03:49:02Z UpdateTip: new best=0000000000000000002841e341db47a5c7ab84c416fea4dc9b600953e6095193 height=575359 version=0x20c00000 log2_work=90.622494 tx=411651867 date='2019-05-10T03:48:51Z' progress=1.000000 cache=45.2MiB(406977txo) warning='40 of last 100 blocks have unexpected version'
 812019-05-10T03:51:40Z Socks5() connect to 2a00:23c5:fd07:8b00:411:2ece:f640:db46:8333 failed: host unreachable
 822019-05-10T03:52:54Z Socks5() connect to 103.254.153.113:8333 failed: connection refused
 832019-05-10T03:55:50Z New outbound peer connected: version: 70015, blocks=575359, peer=245
 842019-05-10T04:07:17Z UpdateTip: new best=0000000000000000000c50a7eb416230eee9da618c5b15e4a09c83d906c4f1bb height=575360 version=0x20000000 log2_work=90.622515 tx=411653904 date='2019-05-10T04:06:53Z' progress=1.000000 cache=45.8MiB(412046txo) warning='39 of last 100 blocks have unexpected version'
 852019-05-10T04:07:20Z Socks5() connect to 5.63.46.78:8333 failed: host unreachable
 862019-05-10T04:10:37Z UpdateTip: new best=0000000000000000001ce8354135997c8f6a64b3b004bb5f17cbdba7181dfed4 height=575361 version=0x20000000 log2_work=90.622537 tx=411656853 date='2019-05-10T04:09:48Z' progress=1.000000 cache=46.2MiB(415954txo) warning='39 of last 100 blocks have unexpected version'
 872019-05-10T04:14:56Z New outbound peer connected: version: 70015, blocks=575361, peer=252
 882019-05-10T04:19:59Z Socks5() connect to 2a03:4000:6:8009::1:8333 failed: general failure
 892019-05-10T04:21:52Z UpdateTip: new best=000000000000000000114778e9b3160f764b2dfca2a197e750dc0796037712b6 height=575362 version=0x20400000 log2_work=90.622559 tx=411659249 date='2019-05-10T04:21:34Z' progress=1.000000 cache=46.8MiB(421325txo) warning='40 of last 100 blocks have unexpected version'
 902019-05-10T04:24:31Z New outbound peer connected: version: 70015, blocks=575362, peer=257
 912019-05-10T04:35:47Z Socks5() connect to 24.218.181.99:8333 failed: connection refused
 922019-05-10T04:43:16Z Pre-allocating up to position 0xa00000 in rev01631.dat
 932019-05-10T04:43:16Z UpdateTip: new best=00000000000000000013db6fe1d96cdee876db82939bdc61445b6b5115ad81d1 height=575363 version=0x20000000 log2_work=90.622581 tx=411661926 date='2019-05-10T04:43:10Z' progress=1.000000 cache=47.4MiB(427196txo) warning='39 of last 100 blocks have unexpected version'
 942019-05-10T04:50:23Z UpdateTip: new best=00000000000000000014017ec0f7a9b039905d074c406acdd0c8b154cc33d38c height=575364 version=0x20800000 log2_work=90.622603 tx=411664243 date='2019-05-10T04:50:02Z' progress=1.000000 cache=48.0MiB(433000txo) warning='40 of last 100 blocks have unexpected version'
 952019-05-10T04:52:54Z Socks5() connect to 3.83.172.33:8333 failed: connection refused
 962019-05-10T04:53:09Z New outbound peer connected: version: 70015, blocks=575364, peer=267
 972019-05-10T05:01:50Z UpdateTip: new best=00000000000000000018074c18e3177e6c304a96fe18c46f7bb8f26633a20871 height=575365 version=0x20000000 log2_work=90.622624 tx=411666638 date='2019-05-10T05:01:46Z' progress=1.000000 cache=48.7MiB(439049txo) warning='40 of last 100 blocks have unexpected version'
 982019-05-10T05:02:43Z New outbound peer connected: version: 70015, blocks=575365, peer=272
 992019-05-10T05:12:18Z New outbound peer connected: version: 70015, blocks=575365, peer=277
1002019-05-10T05:21:51Z New outbound peer connected: version: 70015, blocks=575365, peer=282
1012019-05-10T05:24:42Z UpdateTip: new best=00000000000000000029cab7ff4ce891126e010be5d6dd8b02a11c7a3bb221a4 height=575366 version=0x20000000 log2_work=90.622646 tx=411669168 date='2019-05-10T05:24:21Z' progress=1.000000 cache=51.5MiB(449504txo) warning='39 of last 100 blocks have unexpected version'
1022019-05-10T05:26:25Z UpdateTip: new best=00000000000000000001908a10f469b3dfd6d44a1bccbd51a2e567fd7eb67b53 height=575367 version=0x20000000 log2_work=90.622668 tx=411671593 date='2019-05-10T05:26:23Z' progress=1.000000 cache=51.9MiB(453376txo) warning='38 of last 100 blocks have unexpected version'
1032019-05-10T05:28:12Z Socks5() connect to 186.90.243.233:8333 failed: host unreachable
1042019-05-10T05:29:22Z UpdateTip: new best=0000000000000000001ba7b93749701300daa4a53319d3162222dd36e75201f0 height=575368 version=0x3fffe000 log2_work=90.62269 tx=411673946 date='2019-05-10T05:29:22Z' progress=1.000000 cache=52.5MiB(458790txo) warning='38 of last 100 blocks have unexpected version'
1052019-05-10T05:29:40Z UpdateTip: new best=00000000000000000023cbed8eddf35ca23bca74d46ea1a9e9d38199a4c46c61 height=575369 version=0x20800000 log2_work=90.622711 tx=411675834 date='2019-05-10T05:29:21Z' progress=1.000000 cache=53.1MiB(464350txo) warning='39 of last 100 blocks have unexpected version'
1062019-05-10T05:37:58Z Pre-allocating up to position 0xb00000 in rev01631.dat
1072019-05-10T05:37:58Z UpdateTip: new best=000000000000000000241e5a3f4275e90a7c70782e1d2499159bbfeaea0397ee height=575370 version=0x20400000 log2_work=90.622733 tx=411677867 date='2019-05-10T05:37:30Z' progress=1.000000 cache=53.4MiB(466827txo) warning='40 of last 100 blocks have unexpected version'
1082019-05-10T05:38:12Z UpdateTip: new best=000000000000000000011c85ae7e66e7a81cea0caa3af06a9b355012dd5ebe3d height=575371 version=0x20400000 log2_work=90.622755 tx=411681219 date='2019-05-10T05:37:58Z' progress=1.000000 cache=53.8MiB(470546txo) warning='40 of last 100 blocks have unexpected version'
1092019-05-10T05:41:04Z Pre-allocating up to position 0x6000000 in blk01631.dat
1102019-05-10T05:41:05Z UpdateTip: new best=0000000000000000000f06b6e4d7f4ebbf62c5b9dabcfd5f78c698362dd1e49e height=575372 version=0x3fffe000 log2_work=90.622777 tx=411683288 date='2019-05-10T05:40:45Z' progress=1.000000 cache=54.3MiB(475068txo) warning='40 of last 100 blocks have unexpected version'
1112019-05-10T05:46:23Z Socks5() connect to 2601:19c:4802:6930::b56b:8333 failed: general failure
1122019-05-10T05:47:18Z Socks5() connect to 2001:5b0:48e0:a9b8:4031:5983:7f7c:da84:8333 failed: host unreachable
1132019-05-10T05:49:16Z UpdateTip: new best=000000000000000000265af46c5330d911d45ef24d20f1b545fbb37869dac6ea height=575373 version=0x20000000 log2_work=90.622799 tx=411685741 date='2019-05-10T05:48:32Z' progress=1.000000 cache=54.6MiB(478098txo) warning='40 of last 100 blocks have unexpected version'
1142019-05-10T05:50:34Z New outbound peer connected: version: 70015, blocks=575373, peer=294
1152019-05-10T06:00:08Z New outbound peer connected: version: 70015, blocks=575373, peer=298
1162019-05-10T06:01:02Z UpdateTip: new best=000000000000000000131a324b39b490ada693f0a3b63ff9761d61d0efe64635 height=575374 version=0x20000000 log2_work=90.62282 tx=411688241 date='2019-05-10T06:00:59Z' progress=1.000000 cache=55.1MiB(482572txo) warning='39 of last 100 blocks have unexpected version'
1172019-05-10T06:05:34Z Socks5() connect to 2a01:4f9:c010:2cee::1:8333 failed: general failure
1182019-05-10T06:08:05Z UpdateTip: new best=00000000000000000009b1a4e061071faa9ed8e4738756d124688ddd6400f1d0 height=575375 version=0x20000000 log2_work=90.622842 tx=411690516 date='2019-05-10T06:08:13Z' progress=1.000000 cache=55.4MiB(485928txo) warning='39 of last 100 blocks have unexpected version'
1192019-05-10T06:08:47Z UpdateTip: new best=0000000000000000000e9b400e2dc58a008f461b3668a908f97321e85e9536d6 height=575376 version=0x20000000 log2_work=90.622864 tx=411692775 date='2019-05-10T06:08:49Z' progress=1.000000 cache=55.7MiB(488460txo) warning='39 of last 100 blocks have unexpected version'
1202019-05-10T06:09:41Z New outbound peer connected: version: 70015, blocks=575376, peer=302
1212019-05-10T06:10:03Z Socks5() connect to 188.172.198.43:8333 failed: connection refused
1222019-05-10T06:12:29Z Pre-allocating up to position 0xc00000 in rev01631.dat
1232019-05-10T06:12:30Z UpdateTip: new best=0000000000000000000f692c5a3853940eec49e45fe9179980e308a1d6e0e1e2 height=575377 version=0x2000e000 log2_work=90.622886 tx=411695356 date='2019-05-10T06:12:35Z' progress=1.000000 cache=56.0MiB(490820txo) warning='39 of last 100 blocks have unexpected version'
1242019-05-10T06:16:42Z Socks5() connect to 88.149.180.187:8333 failed: host unreachable
1252019-05-10T06:19:16Z New outbound peer connected: version: 70015, blocks=575377, peer=307
1262019-05-10T06:25:31Z Socks5() connect to 2a03:b0c0:3:d0::23f7:b001:8333 failed: general failure
1272019-05-10T06:28:50Z New outbound peer connected: version: 70015, blocks=575377, peer=313
1282019-05-10T06:35:50Z UpdateTip: new best=0000000000000000000f8c6760212fd07b668324133e30418442fcb712e6732f height=575378 version=0x20000000 log2_work=90.622908 tx=411698267 date='2019-05-10T06:35:27Z' progress=1.000000 cache=56.7MiB(497893txo) warning='39 of last 100 blocks have unexpected version'
1292019-05-10T06:38:24Z New outbound peer connected: version: 70015, blocks=575378, peer=319
1302019-05-10T06:39:52Z UpdateTip: new best=0000000000000000000604e1f98e0791fce79bb6bb6322aab83bffecb73b6de3 height=575379 version=0x20000000 log2_work=90.622929 tx=411700940 date='2019-05-10T06:39:23Z' progress=1.000000 cache=57.0MiB(500432txo) warning='38 of last 100 blocks have unexpected version'
1312019-05-10T06:43:22Z Socks5() connect to 173.255.139.144:8333 failed: connection refused
1322019-05-10T06:46:33Z UpdateTip: new best=0000000000000000000904294acafe54bf1383233007a95f1aede347a1149bce height=575380 version=0x20000000 log2_work=90.622951 tx=411703491 date='2019-05-10T06:46:25Z' progress=1.000000 cache=57.3MiB(503392txo) warning='38 of last 100 blocks have unexpected version'
1332019-05-10T06:48:52Z UpdateTip: new best=000000000000000000047296d09074b23b6e7d9fc07cc67960884f2dfddaaae9 height=575381 version=0x20000000 log2_work=90.622973 tx=411705029 date='2019-05-10T06:48:48Z' progress=1.000000 cache=57.4MiB(504597txo) warning='37 of last 100 blocks have unexpected version'
1342019-05-10T06:49:48Z UpdateTip: new best=000000000000000000107000cda51a31343520e15ba5843a88dbdf6924df1852 height=575382 version=0x20000000 log2_work=90.622995 tx=411706987 date='2019-05-10T06:49:23Z' progress=1.000000 cache=57.6MiB(506046txo) warning='37 of last 100 blocks have unexpected version'
1352019-05-10T06:51:30Z Socks5() connect to 65.204.58.114:8333 failed: connection refused
1362019-05-10T06:57:31Z New outbound peer connected: version: 70015, blocks=575382, peer=330
1372019-05-10T07:07:06Z New outbound peer connected: version: 70015, blocks=575382, peer=334
1382019-05-10T07:11:31Z Pre-allocating up to position 0xd00000 in rev01631.dat
1392019-05-10T07:11:31Z UpdateTip: new best=00000000000000000011e2a5b9b270479740ddb9623cc0da9e5a327bd996d777 height=575383 version=0x3fff0000 log2_work=90.623016 tx=411709930 date='2019-05-10T07:11:25Z' progress=1.000000 cache=58.4MiB(513719txo) warning='38 of last 100 blocks have unexpected version'
1402019-05-10T07:12:51Z UpdateTip: new best=000000000000000000037a0e7053b2b6c677857c2ef0487f841decfe9c3761f2 height=575384 version=0x20000000 log2_work=90.623038 tx=411712411 date='2019-05-10T07:12:13Z' progress=1.000000 cache=59.1MiB(520649txo) warning='37 of last 100 blocks have unexpected version'
1412019-05-10T07:14:26Z Socks5() connect to 87.178.226.188:8333 failed: connection refused
1422019-05-10T07:19:57Z UpdateTip: new best=0000000000000000000fe96e43513887191bade5585f843cfdc3163a641b9b1d height=575385 version=0x2000e000 log2_work=90.62306 tx=411714975 date='2019-05-10T07:20:08Z' progress=1.000000 cache=59.5MiB(524146txo) warning='37 of last 100 blocks have unexpected version'
1432019-05-10T07:32:19Z Pre-allocating up to position 0x7000000 in blk01631.dat
1442019-05-10T07:32:19Z UpdateTip: new best=0000000000000000000a0935a536f098984bfed20748553a47384d42069bebb6 height=575386 version=0x20000000 log2_work=90.623082 tx=411717525 date='2019-05-10T07:32:11Z' progress=1.000000 cache=61.6MiB(543121txo) warning='37 of last 100 blocks have unexpected version'
1452019-05-10T07:33:28Z UpdateTip: new best=0000000000000000000ca88bb299f7f462f1c46fd463d57e987f48e034818fee height=575387 version=0x20000000 log2_work=90.623104 tx=411718273 date='2019-05-10T07:32:55Z' progress=1.000000 cache=61.6MiB(543781txo) warning='37 of last 100 blocks have unexpected version'
1462019-05-10T07:49:46Z UpdateTip: new best=00000000000000000015c064d4870c99888ea95f1d94637fcb3bee2d7b7a8323 height=575388 version=0x20000000 log2_work=90.623125 tx=411721477 date='2019-05-10T07:49:18Z' progress=1.000000 cache=62.5MiB(551787txo) warning='37 of last 100 blocks have unexpected version'
1472019-05-10T08:03:10Z UpdateTip: new best=00000000000000000009ae5e1f0e473f0c4f72b54138262bc742b8148ba109c9 height=575389 version=0x20000000 log2_work=90.623147 tx=411724151 date='2019-05-10T08:02:56Z' progress=1.000000 cache=63.3MiB(559335txo) warning='37 of last 100 blocks have unexpected version'
1482019-05-10T08:18:28Z Socks5() connect to 159.69.68.214:8333 failed: connection refused
1492019-05-10T08:30:09Z Pre-allocating up to position 0xe00000 in rev01631.dat
1502019-05-10T08:30:09Z UpdateTip: new best=0000000000000000000e148dfa1b8919a327d3cb310dc7e84610793f8092628d height=575390 version=0x20000000 log2_work=90.623169 tx=411726929 date='2019-05-10T08:29:43Z' progress=1.000000 cache=65.1MiB(576398txo) warning='37 of last 100 blocks have unexpected version'
1512019-05-10T08:36:01Z UpdateTip: new best=000000000000000000214b742af9a1c57049a64bf0214e217a6b8a11c88e1951 height=575391 version=0x20000000 log2_work=90.623191 tx=411729753 date='2019-05-10T08:35:46Z' progress=1.000000 cache=65.7MiB(582381txo) warning='36 of last 100 blocks have unexpected version'
1522019-05-10T08:56:01Z Socks5() connect to 2001:56a:f317:4e00:526f:e70d:4a25:e22:8333 failed: host unreachable
1532019-05-10T08:59:02Z Socks5() connect to 2604:3d08:6b7f:e7e0::203e:8333 failed: general failure
1542019-05-10T09:01:18Z Socks5() connect to 196.52.84.22:8333 failed: connection refused
1552019-05-10T09:01:36Z UpdateTip: new best=00000000000000000014c2a4d1e29cb32cca2731b6b286b40b55173f4938c667 height=575392 version=0x20000000 log2_work=90.623213 tx=411732531 date='2019-05-10T09:01:01Z' progress=1.000000 cache=66.9MiB(592708txo) warning='36 of last 100 blocks have unexpected version'
1562019-05-10T09:08:52Z Socks5() connect to 87.101.95.115:8333 failed: connection refused
1572019-05-10T09:10:34Z Socks5() connect to 95.90.248.39:8333 failed: connection refused
1582019-05-10T09:11:10Z New outbound peer connected: version: 70015, blocks=575392, peer=384
  2. MarcoFalke commented at 11:17 am on May 10, 2019: member
    If you enable to show threads in htop, what is the name of the thread that uses all the cpu?
  3. perefeliu commented at 11:34 am on May 10, 2019: none

    I’ve anbled “Show Custom Thread Names” and if not mistaken, bitcoin-opencon and bitcoin-addcon are the threads consuming CPU. Nearly all the time, it is bitcoin-addcon. Usually both.

    imagen

  4. fanquake commented at 11:35 am on May 10, 2019: member
    Might be the same as #15665.
  5. MarcoFalke commented at 11:39 am on May 10, 2019: member
    This one also shows a spike in addcon
  6. MarcoFalke renamed this:
    Unusual CPU usage on Bitcoin daemon over Tor
    Unusual CPU usage on Bitcoin daemon over Tor (addcon, openconn)
    on May 10, 2019
  7. MarcoFalke renamed this:
    Unusual CPU usage on Bitcoin daemon over Tor (addcon, openconn)
    Unusual CPU usage on Bitcoin daemon over Tor (addcon, opencon)
    on May 10, 2019
  8. perefeliu commented at 12:16 pm on May 10, 2019: none
    addcon is running nearly all the time, rather than a spike, it is more of a constant charge on CPU. opencon follows more an spike pattern. I’m trying #15665 but having some problems that I have written within #15665. I will come back with results.
  9. fanquake added the label P2P on May 13, 2019
  10. fanquake added the label Resource usage on May 13, 2019
  11. perefeliu commented at 6:09 am on May 14, 2019: none

    I am having trouble following #15665

    This is what I get:

     0(gdb) run
 1Starting program: /usr/local/bin/bitcoin-qt
 2Cannot parse expression `.L1185 4@r4'.
 3warning: Probes-based dynamic linker interface failed.
 4Reverting to original interface.
 5
 6[Thread debugging using libthread_db enabled]
 7Using host libthread_db library "/lib/arm-linux-gnueabihf/libthread_db.so.1".
 8qt.qpa.screen: QXcbConnection: Could not connect to display
 9Could not connect to any X display.
10[Inferior 1 (process 3987) exited with code 01]

    Do I need a display to perform that action? I also assume that I need a the bitcoin daemon to be running.

    I also checked the flag debug=net and I don’t see anything outside normal. Could it be a DoS by some of the nodes?

  12. MarcoFalke commented at 12:21 pm on May 14, 2019: member
    If you are not using the gui, but bitcoind, replace bitcoin-qt with bitcoind in those instructions, please
  13. MatzFan commented at 2:33 pm on May 14, 2019: none

    Can confirm similar symptoms (1 of 4 cores running at 100% almost continually) in v0.18.0 when using a SOCKS5 proxy with Tor running locally. Network settings as per screenshot. This is on Ubuntu 18.04. I did not experience this issue in v0.17.1 with the same settings. Only workaround appears to be to stop using the proxy.

    image

  14. perefeliu commented at 7:10 pm on May 14, 2019: none

    Doing what is asked in #15665 does not appear to solve the issue, if I’ve done it correctly.

    To be clear about what I’ve done, I’ve stopped the bitcoind as a service. After thatm I run gdb and wait until I see the bitcoin-addcon thread start, (which is instantly, no need to wait). To perform this action, I’ve stopped the LND service, so it does not appear that LND is causing the issue.

    0sudo systemctl stop bitcoind
1gdb --args /usr/local/bin/bitcoind
2run
3Ctrl+C
  15. MarcoFalke added this to the milestone 0.19.0 on May 22, 2019
  16. initCCG commented at 4:03 am on June 1, 2019: none

    If you use only “connect” and disable “listen”, the problem goes away.

    So, it does seem more like some DoS bug exploit.

  17. perefeliu commented at 1:47 pm on June 1, 2019: none

    Interesting… @initCCG thank you for the hint. It hasn’t been fixed in my case with only disabling “listen”. To be more specific, I’ve changed the line from listenonion=1 to listenonion=0. The onion service is no longer created, but the addcon thread still at 100%.

    Then I’ve then masked all lines that connected me to other Tor nodes such as addnode=kvd44sw7skb5folw.onion . I took the list from here

    Right now the problem is solved, so perhaps there’s indeed some node in the list that is DoS-ing. Would it be useful to identify this/these nodes?

  18. jb55 commented at 5:15 am on June 4, 2019: member

    Seems like it’s spending most of it’s time in:

    0static IntrRecvError InterruptibleRecv(uint8_t* data, size_t len, int timeout, const SOCKET& hSocket)
1{
2    int64_t curTime = GetTimeMillis();
3    int64_t endTime = curTime + timeout;
4    // Maximum time to wait in one select call. It will take up until this time (in millis)
5    // to break off in case of an interruption.
6    const int64_t maxWait = 1000;
7    while (len > 0 && curTime < endTime) {
8>        ssize_t ret = recv(hSocket, (char*)data, len, 0); // Optimistically try the recv first
  19. MarcoFalke commented at 7:33 pm on July 18, 2019: member
    Is this the same as #15665?
  20. fanquake removed this from the milestone 0.19.0 on Jul 19, 2019
  21. fanquake added this to the milestone 0.18.1 on Jul 19, 2019
  22. fanquake commented at 0:51 am on July 19, 2019: member
    @MarcoFalke I think so. However I’m going to close that issue, and re-milestone this one, as this has a bit more discussion.
  23. laanwj closed this on Jul 19, 2019
  24. laanwj referenced this in commit f4b1fe7165 on Jul 19, 2019
  25. PastaPastaPasta referenced this in commit fef222ee22 on Jun 27, 2021
  26. PastaPastaPasta referenced this in commit c829979a40 on Jun 28, 2021
  27. PastaPastaPasta referenced this in commit de2f854518 on Jun 29, 2021
  28. PastaPastaPasta referenced this in commit aced52aa6c on Jul 1, 2021
  29. PastaPastaPasta referenced this in commit dbff400783 on Jul 1, 2021
  30. PastaPastaPasta referenced this in commit 852798aa91 on Jul 12, 2021
  31. PastaPastaPasta referenced this in commit c2e52af388 on Jul 13, 2021
  32. DrahtBot locked this on Dec 16, 2021
  33. gades referenced this in commit cc9ec714ec on Apr 30, 2022


perefeliu MarcoFalke fanquake MatzFan initCCG jb55

Labels
P2P Resource usage

Milestone
0.18.1

github-metadata-mirror

This is a metadata mirror of the GitHub repository bitcoin/bitcoin. This site is not affiliated with GitHub. Content is generated from a GitHub metadata backup.
generated: 2024-12-22 06:12 UTC
This site is hosted by @0xB10C
More mirrored repositories can be found on mirror.b10c.me