please check my debug.log

2 messages, 29 Apr 2014. Started by Eugen Leitl.

Eugen Leitl, Mike Hearn

The peer-to-peer protocol

Eugen Leitl 29 Apr 2014, 08:13 UTC permalink original

I've put up some bitcoind nodes after the network is in need of some, and would like some feedback in that the nodes are fully operational and doing something useful. Please check the logs and tell me whether I'm doing good.

debug.log from a node that has been running for a day:

2014-04-29 08:06:18 ERROR: CheckTransaction() : vin empty 2014-04-29 08:06:18 ERROR: AcceptToMemoryPool: : CheckTransaction failed 2014-04-29 08:06:18 Misbehaving: 122.224.182.248:23159 (0 -> 10) 2014-04-29 08:07:00 receive version message: /getaddr.bitnodes.io:0.1/: version 70001, blocks=298263, us=88.198.51.132:8333, them=0.0.0.0:0, peer=148.251.238.178:63657 2014-04-29 08:07:19 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=[2a01:4f8:131:13ed::2]:8333, them=0.0.0.0:0, peer=[2a02:348:5e:5a29::1]:53921 2014-04-29 08:09:37 receive version message: /Snoopy:0.1/: version 60001, blocks=0, us=88.198.51.132:8333, them=192.33.90.253:8333, peer=192.33.90.253:43104 2014-04-29 08:09:37 socket recv error 104 2014-04-29 08:10:26 receive version message: /getaddr.bitnodes.io:0.1/: version 70001, blocks=298263, us=[2a01:4f8:131:13ed::2]:8333, them=0.0.0.0:0, peer=[2a01:4f8:202:81b1::2]:50624 2014-04-29 08:10:32 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=88.198.51.132:8333, them=0.0.0.0:0, peer=217.78.0.153:37275 2014-04-29 08:10:50 receive version message: /getaddr.bitnodes.io:0.1/: version 70001, blocks=298263, us=88.198.51.132:8333, them=0.0.0.0:0, peer=148.251.238.178:50788

debug.log from a node that I just restarted:

2014-04-29 08:06:16 Opening LevelDB in /home/bitcoind/.bitcoin/blocks/index 2014-04-29 08:06:17 Opened LevelDB successfully 2014-04-29 08:06:17 Opening LevelDB in /home/bitcoind/.bitcoin/chainstate 2014-04-29 08:06:19 Opened LevelDB successfully 2014-04-29 08:06:22 LoadBlockIndexDB(): last block file = 135 2014-04-29 08:06:22 LoadBlockIndexDB(): last block file info: CBlockFileInfo(blocks=631, size=128154379, heights=297633...298263, time=2014-04-25...2014-04-29) 2014-04-29 08:06:22 LoadBlockIndexDB(): transaction index disabled 2014-04-29 08:06:22 LoadBlockIndexDB(): hashBestChain=0000000000000000162f5f571eef4742b70204d983bda3c4b18fc1496ac27f86 height=298263 date=2014-04-29 08:00:23 progress=0.999981 2014-04-29 08:06:22 init message: Verifying blocks... 2014-04-29 08:06:22 Verifying last 288 blocks at level 3 2014-04-29 08:07:42 No coin database inconsistencies in last 289 blocks (111189 transactions) 2014-04-29 08:07:42 block index 86284ms 2014-04-29 08:07:42 init message: Loading wallet... 2014-04-29 08:07:42 nFileVersion = 90100 2014-04-29 08:07:42 Keys: 101 plaintext, 0 encrypted, 101 w/ metadata, 101 total 2014-04-29 08:07:43 wallet 108ms 2014-04-29 08:07:43 init message: Rescanning... 2014-04-29 08:07:43 Rescanning last 39 blocks (from block 298224)... 2014-04-29 08:07:43 rescan 204ms 2014-04-29 08:07:43 init message: Loading addresses... 2014-04-29 08:07:43 Loaded 14015 addresses from peers.dat 84ms 2014-04-29 08:07:43 mapBlockIndex.size() = 298264 2014-04-29 08:07:43 nBestHeight = 298263 2014-04-29 08:07:43 setKeyPool.size() = 100 2014-04-29 08:07:43 mapWallet.size() = 0 2014-04-29 08:07:43 mapAddressBook.size() = 1 2014-04-29 08:07:43 AddLocal(213.239.218.20:8333,1) 2014-04-29 08:07:43 IPv4 eth0: 213.239.218.20 2014-04-29 08:07:43 AddLocal([2a01:4f8:a0:74c8::2]:8333,1) 2014-04-29 08:07:43 IPv6 eth0: 2a01:4f8:a0:74c8::2 2014-04-29 08:07:43 ext-ip thread start 2014-04-29 08:07:43 dnsseed thread start 2014-04-29 08:07:43 Loading addresses from DNS seeds (could take a while) 2014-04-29 08:07:43 net thread start 2014-04-29 08:07:43 upnp thread start 2014-04-29 08:07:43 opencon thread start 2014-04-29 08:07:43 addcon thread start 2014-04-29 08:07:43 dumpaddr thread start 2014-04-29 08:07:43 msghand thread start 2014-04-29 08:07:43 init message: Done loading 2014-04-29 08:07:43 GetMyExternalIP() received [213.239.218.20] 213.239.218.20:0 2014-04-29 08:07:43 GetMyExternalIP() returned 213.239.218.20 2014-04-29 08:07:43 AddLocal(213.239.218.20:8333,4) 2014-04-29 08:07:43 ext-ip thread exit 2014-04-29 08:07:44 receive version message: /Satoshi:0.8.6/: version 70001, blocks=298263, us=213.239.218.20:44169, them=166.78.243.104:8333, peer=166.78.243.104:8333 2014-04-29 08:07:44 Added time data, samples 2, offset +8 (+0 minutes) 2014-04-29 08:07:51 No valid UPnP IGDs found 2014-04-29 08:07:51 upnp thread exit 2014-04-29 08:07:53 connect() to 71.23.29.162:8333 failed after select(): No route to host 2014-04-29 08:07:53 receive version message: /Satoshi:0.9.1/: version 70002, blocks=298263, us=213.239.218.20:46921, them=91.238.134.58:8333, peer=91.238.134.58:8333 2014-04-29 08:07:53 Added time data, samples 3, offset +0 (+0 minutes) 2014-04-29 08:07:54 106 addresses found from DNS seeds 2014-04-29 08:07:54 dnsseed thread exit 2014-04-29 08:08:16 receive version message: /Satoshi:0.8.6/: version 70001, blocks=298263, us=213.239.218.20:50533, them=98.218.92.212:8333, peer=98.218.92.212:8333 2014-04-29 08:08:16 Added time data, samples 4, offset +2 (+0 minutes) 2014-04-29 08:08:22 receive version message: /Satoshi:0.8.5/: version 70001, blocks=298263, us=213.239.218.20:35016, them=108.3.172.22:8333, peer=108.3.172.22:8333 2014-04-29 08:08:22 Added time data, samples 5, offset +3 (+0 minutes) 2014-04-29 08:08:22 nTimeOffset = +2 (+0 minutes) 2014-04-29 08:08:27 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=178.18.90.41:52783 2014-04-29 08:08:27 Added time data, samples 6, offset +0 (+0 minutes) 2014-04-29 08:08:31 connect() to 24.136.254.2:8333 failed after select(): No route to host 2014-04-29 08:08:37 connect() to 187.15.64.129:8333 failed after select(): Connection refused 2014-04-29 08:08:38 receive version message: /Satoshi:0.8.5/: version 70001, blocks=298263, us=213.239.218.20:37793, them=209.99.52.77:8333, peer=209.99.52.77:8333 2014-04-29 08:08:38 Added time data, samples 7, offset -1 (+0 minutes) 2014-04-29 08:08:38 nTimeOffset = +0 (+0 minutes) 2014-04-29 08:08:50 receive version message: /Satoshi:0.9.0/: version 70002, blocks=298263, us=213.239.218.20:54044, them=69.23.94.246:8333, peer=69.23.94.246:8333 2014-04-29 08:08:50 Added time data, samples 8, offset -15 (+0 minutes) 2014-04-29 08:08:50 receive version message: /Satoshi:0.8.6/: version 70001, blocks=298263, us=213.239.218.20:45277, them=84.126.227.120:8333, peer=84.126.227.120:8333 2014-04-29 08:08:50 Added time data, samples 9, offset -1 (+0 minutes) 2014-04-29 08:08:50 nTimeOffset = +0 (+0 minutes) 2014-04-29 08:08:51 receive version message: /Satoshi:0.8.6/: version 70001, blocks=298263, us=213.239.218.20:55627, them=91.66.153.44:8333, peer=91.66.153.44:8333 2014-04-29 08:08:51 Added time data, samples 10, offset -2 (+0 minutes) 2014-04-29 08:09:05 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=[2a01:4f8:a0:74c8::2]:8333, them=0.0.0.0:0, peer=[2a02:348:5e:5a29::1]:39788 2014-04-29 08:09:05 Added time data, samples 11, offset +0 (+0 minutes) 2014-04-29 08:09:05 nTimeOffset = +0 (+0 minutes) 2014-04-29 08:09:35 receive version message: Dain 0.0.1: version 70001, blocks=298263, us=213.239.218.20:8333, them=162.242.155.221:8333, peer=162.242.155.221:53878 2014-04-29 08:09:35 Added time data, samples 12, offset +0 (+0 minutes) 2014-04-29 08:09:38 receive version message: /Snoopy:0.1/: version 60001, blocks=0, us=213.239.218.20:8333, them=192.33.90.253:8333, peer=192.33.90.253:34143 2014-04-29 08:09:38 Added time data, samples 13, offset +5 (+0 minutes) 2014-04-29 08:09:38 nTimeOffset = +0 (+0 minutes) 2014-04-29 08:10:16 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=192.3.11.20:49902 2014-04-29 08:10:16 Added time data, samples 14, offset +36 (+0 minutes) 2014-04-29 08:10:36 receive version message: /getaddr.bitnodes.io:0.1/: version 70001, blocks=298263, us=213.239.218.20:8333, them=0.0.0.0:0, peer=148.251.238.178:13436 2014-04-29 08:10:36 Added time data, samples 15, offset +0 (+0 minutes) 2014-04-29 08:10:36 nTimeOffset = +0 (+0 minutes) 2014-04-29 08:11:11 receive version message: /bitcoinseeder:0.01/: version 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=108.18.18.4:46999 2014-04-29 08:11:11 Added time data, samples 16, offset +36 (+0 minutes) 2014-04-29 08:11:23 receive version message: /getaddr.bitnodes.io:0.1/: version 70001, blocks=298263, us=[2a01:4f8:a0:74c8::2]:8333, them=0.0.0.0:0, peer=[2a01:4f8:202:81b1::2]:54634 2014-04-29 08:11:23 Added time data, samples 17, offset +0 (+0 minutes) 2014-04-29 08:11:23 nTimeOffset = +0 (+0 minutes)

Mike Hearn 29 Apr 2014, 14:15 UTC in reply to Eugen Leitl permalink original

Looks good to me!

You're not in the DNS seeds yet. If you leave your nodes up for a while then you'll start getting traffic from bitcoinj clients too.

On Tue, Apr 29, 2014 at 10:13 AM, Eugen Leitl <eugen@leitl•org> wrote:

Quoted text (179 lines)

> I've put up some bitcoind nodes after the network is
> in need of some, and would like some feedback in that
> the nodes are fully operational and doing something
> useful. Please check the logs and tell me whether
> I'm doing good.
>
> debug.log from a node that has been running for a day:
>
> 2014-04-29 08:06:18 ERROR: CheckTransaction() : vin empty
> 2014-04-29 08:06:18 ERROR: AcceptToMemoryPool: : CheckTransaction failed
> 2014-04-29 08:06:18 Misbehaving: 122.224.182.248:23159 (0 -> 10)
> 2014-04-29 08:07:00 receive version message: /getaddr.bitnodes.io:0.1/:
> version 70001, blocks=298263, us=88.198.51.132:8333, them=0.0.0.0:0, peer=
> 148.251.238.178:63657
> 2014-04-29 08:07:19 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=[2a01:4f8:131:13ed::2]:8333, them=0.0.0.0:0,
> peer=[2a02:348:5e:5a29::1]:53921
> 2014-04-29 08:09:37 receive version message: /Snoopy:0.1/: version 60001,
> blocks=0, us=88.198.51.132:8333, them=192.33.90.253:8333, peer=
> 192.33.90.253:43104
> 2014-04-29 08:09:37 socket recv error 104
> 2014-04-29 08:10:26 receive version message: /getaddr.bitnodes.io:0.1/:
> version 70001, blocks=298263, us=[2a01:4f8:131:13ed::2]:8333, them=
> 0.0.0.0:0, peer=[2a01:4f8:202:81b1::2]:50624
> 2014-04-29 08:10:32 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=88.198.51.132:8333, them=0.0.0.0:0, peer=
> 217.78.0.153:37275
> 2014-04-29 08:10:50 receive version message: /getaddr.bitnodes.io:0.1/:
> version 70001, blocks=298263, us=88.198.51.132:8333, them=0.0.0.0:0, peer=
> 148.251.238.178:50788
>
> debug.log from a node that I just restarted:
>
> 2014-04-29 08:06:16 Opening LevelDB in /home/bitcoind/.bitcoin/blocks/index
> 2014-04-29 08:06:17 Opened LevelDB successfully
> 2014-04-29 08:06:17 Opening LevelDB in /home/bitcoind/.bitcoin/chainstate
> 2014-04-29 08:06:19 Opened LevelDB successfully
> 2014-04-29 08:06:22 LoadBlockIndexDB(): last block file = 135
> 2014-04-29 08:06:22 LoadBlockIndexDB(): last block file info:
> CBlockFileInfo(blocks=631, size=128154379, heights=297633...298263,
> time=2014-04-25...2014-04-29)
> 2014-04-29 08:06:22 LoadBlockIndexDB(): transaction index disabled
> 2014-04-29 08:06:22 LoadBlockIndexDB():
> hashBestChain=0000000000000000162f5f571eef4742b70204d983bda3c4b18fc1496ac27f86
> height=298263 date=2014-04-29 08:00:23 progress=0.999981
> 2014-04-29 08:06:22 init message: Verifying blocks...
> 2014-04-29 08:06:22 Verifying last 288 blocks at level 3
> 2014-04-29 08:07:42 No coin database inconsistencies in last 289 blocks
> (111189 transactions)
> 2014-04-29 08:07:42  block index           86284ms
> 2014-04-29 08:07:42 init message: Loading wallet...
> 2014-04-29 08:07:42 nFileVersion = 90100
> 2014-04-29 08:07:42 Keys: 101 plaintext, 0 encrypted, 101 w/ metadata, 101
> total
> 2014-04-29 08:07:43  wallet                  108ms
> 2014-04-29 08:07:43 init message: Rescanning...
> 2014-04-29 08:07:43 Rescanning last 39 blocks (from block 298224)...
> 2014-04-29 08:07:43  rescan                  204ms
> 2014-04-29 08:07:43 init message: Loading addresses...
> 2014-04-29 08:07:43 Loaded 14015 addresses from peers.dat  84ms
> 2014-04-29 08:07:43 mapBlockIndex.size() = 298264
> 2014-04-29 08:07:43 nBestHeight = 298263
> 2014-04-29 08:07:43 setKeyPool.size() = 100
> 2014-04-29 08:07:43 mapWallet.size() = 0
> 2014-04-29 08:07:43 mapAddressBook.size() = 1
> 2014-04-29 08:07:43 AddLocal(213.239.218.20:8333,1)
> 2014-04-29 08:07:43 IPv4 eth0: 213.239.218.20
> 2014-04-29 08:07:43 AddLocal([2a01:4f8:a0:74c8::2]:8333,1)
> 2014-04-29 08:07:43 IPv6 eth0: 2a01:4f8:a0:74c8::2
> 2014-04-29 08:07:43 ext-ip thread start
> 2014-04-29 08:07:43 dnsseed thread start
> 2014-04-29 08:07:43 Loading addresses from DNS seeds (could take a while)
> 2014-04-29 08:07:43 net thread start
> 2014-04-29 08:07:43 upnp thread start
> 2014-04-29 08:07:43 opencon thread start
> 2014-04-29 08:07:43 addcon thread start
> 2014-04-29 08:07:43 dumpaddr thread start
> 2014-04-29 08:07:43 msghand thread start
> 2014-04-29 08:07:43 init message: Done loading
> 2014-04-29 08:07:43 GetMyExternalIP() received [213.239.218.20]
> 213.239.218.20:0
> 2014-04-29 08:07:43 GetMyExternalIP() returned 213.239.218.20
> 2014-04-29 08:07:43 AddLocal(213.239.218.20:8333,4)
> 2014-04-29 08:07:43 ext-ip thread exit
> 2014-04-29 08:07:44 receive version message: /Satoshi:0.8.6/: version
> 70001, blocks=298263, us=213.239.218.20:44169, them=166.78.243.104:8333,
> peer=166.78.243.104:8333
> 2014-04-29 08:07:44 Added time data, samples 2, offset +8 (+0 minutes)
> 2014-04-29 08:07:51 No valid UPnP IGDs found
> 2014-04-29 08:07:51 upnp thread exit
> 2014-04-29 08:07:53 connect() to 71.23.29.162:8333 failed after select():
> No route to host
> 2014-04-29 08:07:53 receive version message: /Satoshi:0.9.1/: version
> 70002, blocks=298263, us=213.239.218.20:46921, them=91.238.134.58:8333,
> peer=91.238.134.58:8333
> 2014-04-29 08:07:53 Added time data, samples 3, offset +0 (+0 minutes)
> 2014-04-29 08:07:54 106 addresses found from DNS seeds
> 2014-04-29 08:07:54 dnsseed thread exit
> 2014-04-29 08:08:16 receive version message: /Satoshi:0.8.6/: version
> 70001, blocks=298263, us=213.239.218.20:50533, them=98.218.92.212:8333,
> peer=98.218.92.212:8333
> 2014-04-29 08:08:16 Added time data, samples 4, offset +2 (+0 minutes)
> 2014-04-29 08:08:22 receive version message: /Satoshi:0.8.5/: version
> 70001, blocks=298263, us=213.239.218.20:35016, them=108.3.172.22:8333,
> peer=108.3.172.22:8333
> 2014-04-29 08:08:22 Added time data, samples 5, offset +3 (+0 minutes)
> 2014-04-29 08:08:22 nTimeOffset = +2  (+0 minutes)
> 2014-04-29 08:08:27 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=
> 178.18.90.41:52783
> 2014-04-29 08:08:27 Added time data, samples 6, offset +0 (+0 minutes)
> 2014-04-29 08:08:31 connect() to 24.136.254.2:8333 failed after select():
> No route to host
> 2014-04-29 08:08:37 connect() to 187.15.64.129:8333 failed after
> select(): Connection refused
> 2014-04-29 08:08:38 receive version message: /Satoshi:0.8.5/: version
> 70001, blocks=298263, us=213.239.218.20:37793, them=209.99.52.77:8333,
> peer=209.99.52.77:8333
> 2014-04-29 08:08:38 Added time data, samples 7, offset -1 (+0 minutes)
> 2014-04-29 08:08:38 nTimeOffset = +0  (+0 minutes)
> 2014-04-29 08:08:50 receive version message: /Satoshi:0.9.0/: version
> 70002, blocks=298263, us=213.239.218.20:54044, them=69.23.94.246:8333,
> peer=69.23.94.246:8333
> 2014-04-29 08:08:50 Added time data, samples 8, offset -15 (+0 minutes)
> 2014-04-29 08:08:50 receive version message: /Satoshi:0.8.6/: version
> 70001, blocks=298263, us=213.239.218.20:45277, them=84.126.227.120:8333,
> peer=84.126.227.120:8333
> 2014-04-29 08:08:50 Added time data, samples 9, offset -1 (+0 minutes)
> 2014-04-29 08:08:50 nTimeOffset = +0  (+0 minutes)
> 2014-04-29 08:08:51 receive version message: /Satoshi:0.8.6/: version
> 70001, blocks=298263, us=213.239.218.20:55627, them=91.66.153.44:8333,
> peer=91.66.153.44:8333
> 2014-04-29 08:08:51 Added time data, samples 10, offset -2 (+0 minutes)
> 2014-04-29 08:09:05 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=[2a01:4f8:a0:74c8::2]:8333, them=0.0.0.0:0,
> peer=[2a02:348:5e:5a29::1]:39788
> 2014-04-29 08:09:05 Added time data, samples 11, offset +0 (+0 minutes)
> 2014-04-29 08:09:05 nTimeOffset = +0  (+0 minutes)
> 2014-04-29 08:09:35 receive version message: Dain 0.0.1: version 70001,
> blocks=298263, us=213.239.218.20:8333, them=162.242.155.221:8333, peer=
> 162.242.155.221:53878
> 2014-04-29 08:09:35 Added time data, samples 12, offset +0 (+0 minutes)
> 2014-04-29 08:09:38 receive version message: /Snoopy:0.1/: version 60001,
> blocks=0, us=213.239.218.20:8333, them=192.33.90.253:8333, peer=
> 192.33.90.253:34143
> 2014-04-29 08:09:38 Added time data, samples 13, offset +5 (+0 minutes)
> 2014-04-29 08:09:38 nTimeOffset = +0  (+0 minutes)
> 2014-04-29 08:10:16 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=
> 192.3.11.20:49902
> 2014-04-29 08:10:16 Added time data, samples 14, offset +36 (+0 minutes)
> 2014-04-29 08:10:36 receive version message: /getaddr.bitnodes.io:0.1/:
> version 70001, blocks=298263, us=213.239.218.20:8333, them=0.0.0.0:0,
> peer=148.251.238.178:13436
> 2014-04-29 08:10:36 Added time data, samples 15, offset +0 (+0 minutes)
> 2014-04-29 08:10:36 nTimeOffset = +0  (+0 minutes)
> 2014-04-29 08:11:11 receive version message: /bitcoinseeder:0.01/: version
> 60000, blocks=230000, us=213.239.218.20:8333, them=0.0.0.0:0, peer=
> 108.18.18.4:46999
> 2014-04-29 08:11:11 Added time data, samples 16, offset +36 (+0 minutes)
> 2014-04-29 08:11:23 receive version message: /getaddr.bitnodes.io:0.1/:
> version 70001, blocks=298263, us=[2a01:4f8:a0:74c8::2]:8333, them=
> 0.0.0.0:0, peer=[2a01:4f8:202:81b1::2]:54634
> 2014-04-29 08:11:23 Added time data, samples 17, offset +0 (+0 minutes)
> 2014-04-29 08:11:23 nTimeOffset = +0  (+0 minutes)
>
>
>
> ------------------------------------------------------------------------------
> "Accelerate Dev Cycles with Automated Cross-Browser Testing - For FREE
> Instantly run your Selenium tests across 300+ browser/OS combos.  Get
> unparalleled scalability from the best Selenium testing platform available.
> Simple to use. Nothing to install. Get started now for free."
> http://p.sf.net/sfu/SauceLabs
> _______________________________________________
> Bitcoin-development mailing list
> Bitcoin-development@lists•sourceforge•net
> https://lists.sourceforge.net/lists/listinfo/bitcoin-development
>