Skip to content

Instantly share code, notes, and snippets.

Created November 29, 2017 21:46
Show Gist options
  • Save anonymous/553be68320920426d19c7fb770ed8e36 to your computer and use it in GitHub Desktop.
Save anonymous/553be68320920426d19c7fb770ed8e36 to your computer and use it in GitHub Desktop.
____________________ test_direct_payment[lightning_eclair] _____________________
bitcoind = <utils.BitcoinD object at 0x7fb768e47198>
node_factory = <test.NodeFactory object at 0x7fb742ae40f0>
impls = (<class 'lightningd.LightningNode'>, <class 'eclair.EclairNode'>)
 @pytest.mark.parametrize("impls", product(impls, repeat=2), ids=idfn)
 def test_direct_payment(bitcoind, node_factory, impls):
 node1 = node_factory.get_node(implementation=impls[0])
 node2 = node_factory.get_node(implementation=impls[1])
 capacity = 10**7
 
 node1.connect('localhost', node2.daemon.port, node2.id())
 
 wait_for(lambda: node1.peers(), interval=1)
 wait_for(lambda: node2.peers(), interval=1)
 
 node1.addfunds(bitcoind, 2*capacity)
 time.sleep(5)
 bitcoind.rpc.generate(10)
 time.sleep(5)
 
> node1.openchannel(node2.id(), 'localhost', node2.daemon.port, capacity)
test.py:265:
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
lightningd.py:87: in openchannel
 return self.rpc.fundchannel(node_id, satoshis)
.direnv/python-3.5.2/lib/python3.5/site-packages/lightning/lightning.py:44: in wrapper
 return self._call(name, args)
lightningd.py:63: in rpc_call
 r = orig_call(method, args)
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
self = <lightning.lightning.LightningRpc object at 0x7fb742ae4208>
method = 'fundchannel'
args = ('0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 10000000)
 def _call(self, method, args):
 logging.debug("Calling %s with arguments %r", method, args)
 
 sock = socket.socket(socket.AF_UNIX, socket.SOCK_STREAM)
 sock.connect(self.socket_path)
 self._writeobj(sock, {
 "method": method,
 "params": args,
 "id": 0
 })
 resp = self._readobj(sock)
 sock.close()
 
 logging.debug("Received response for %s call: %r", method, resp)
 if 'error' in resp:
> raise ValueError("RPC call failed: {}".format(resp['error']))
E ValueError: RPC call failed: Peer died
.direnv/python-3.5.2/lib/python3.5/site-packages/lightning/lightning.py:62: ValueError
----------------------------- Captured stdout call -----------------------------
DEBUG:root:Starting 'bin/lightningd --bitcoin-datadir=/tmp/lightning-il5fkavy/bitcoind --lightning-dir=/tmp/lightning-il5fkavy/test_direct_payment[lightning_eclair]/node-1/ --port=16331 --network=regtest --dev-broadcast-interval=1000 --network=regtest --locktime-blocks=6 --log-level=debug --bitcoind-poll=1s'
DEBUG:root:Waiting for 'Creating IPv6 listener on port' in the logs
DEBUG:proc:lightningd(27432): Trying to guess public addresses...
DEBUG:proc:lightningd(27432): Address 192.168.0.3:16331 is not routable
DEBUG:proc:lightningd(27432): Failed to connect 10 socket: Network is unreachable
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightningd
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_channeld
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_closingd
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_gossipd
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_hsmd
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_onchaind
DEBUG:proc:lightningd(27432): testing /home/cdecker/dev/lightning-integration/bin/lightning_openingd
DEBUG:proc:lightningd(27432): HSM TRACE: Control: type WIRE_HSMCTL_INIT len 3
DEBUG:proc:lightningd(27432): Adding block eae8ffd8fba6e4560d7bd8a11b71c904eb7b9b3c39e7ce9518b8115c096f4875
DEBUG:proc:lightningd(27432): Adding block 4db81e9a3466d8d677f53a71e707553519d1b15e4e8c0be8b306556c0de3c163
DEBUG:proc:lightningd(27432): Adding block 37d460bb80c726bf02912e5b7de08874c19b3ba10f56d67f96fddcb18d776478
DEBUG:proc:lightningd(27432): Adding block 5a02444ba810de7239fd8895ef5318b14e7a3ae685403557c14a2f696204b94d
DEBUG:proc:lightningd(27432): Adding block d5992a3556962e6cc64709f3f797049d57010b1a6030ac7a400e8e7455346f40
DEBUG:proc:lightningd(27432): Adding block b481b5caa1fd93644e338865fb87ecd598f562785edde55c7bd5b78bf8105f60
DEBUG:proc:lightningd(27432): Adding block e5c0e400414f713a9063dd578dd65b27f203723c4f20ff50380623941f9e9a0e
DEBUG:proc:lightningd(27432): Adding block ecdbbf76532b884a139c70e5681058c2e00fbdd21dff65d3be921ba0e6bb4b77
DEBUG:proc:lightningd(27432): Adding block ffad2606ab8f0a460c06e9c8200087594f317bc97783d23d4a4d3a0b6126cf60
DEBUG:proc:lightningd(27432): Adding block fd2ca341bdd0bcf6915c4fdac2bb6b8b3bfc82213ce05a2aa60007c1c50c6a0a
DEBUG:proc:lightningd(27432): Adding block bb4c0e42aca271123b78766a36bc8ae44e10c229f95e2a357ccb51d7bfae5d5e
DEBUG:proc:lightningd(27432): Adding block e7b2d0f4d366a617245429525b7040b8a3abf2c152b81404c390ab21ab2c0122
DEBUG:proc:lightningd(27432): Adding block cd71a613bf226cb7ace06c0e5940dcc801fc8d5c242532b87a5858ac8b56e17c
DEBUG:proc:lightningd(27432): Adding block cdc0a9045ab8b5696cd051c0f1fd3867fd74b84f5cdfaa072383ebc592522b32
DEBUG:proc:lightningd(27432): Adding block 78edaeef977a8e2e23cb8783af548ec2bbfb5de367a52f49f60fbf7ddf1c6f67
DEBUG:proc:lightningd(27432): Adding block d8280fbd523d452b180cd7070b04566339e3930cc9f618e267ee287149c22642
DEBUG:proc:lightningd(27432): Adding block 00f4cdb096a73f4486d1c0aedbb9d10504bc895c7d879cb2423f46aa94862e18
DEBUG:proc:lightningd(27432): Adding block 6dc9fb3118ad0e0a1abb6a64f27550157b5f113ab21a1f4227130f77e03b7d0b
DEBUG:proc:lightningd(27432): Adding block 6028573e7018e95c25b43021a6ca7a74f02f342defd0ed72a6205a7998d23407
DEBUG:proc:lightningd(27432): Adding block cbb04c9e28b1ec0fd107e822f18b08bb7b04eb4e1fabd44051a79b67ba5da406
DEBUG:proc:lightningd(27432): Adding block 590bb73a8f5fb24db5841eb4b9398ed71007a7bbe768a0067db9b7527d364024
DEBUG:proc:lightningd(27432): Adding block 9f7e46b2244a9de844366f599e90ec078c18b2d93c4360fe9dbdc51b5421cd31
DEBUG:proc:lightningd(27432): Adding block 17f58286a4fc11c374538f30f08e387abe64a8b0cd2a29a4e0321519af9c3f28
DEBUG:proc:lightningd(27432): Adding block 0daa3238c6c28c324232908121b147e082afa87fb866e955dbedce19641cf415
DEBUG:proc:lightningd(27432): Adding block f906d9a97f459dbbe81a0b57805f4f355b1a87dbb00e946a0b24243861b67c4d
DEBUG:proc:lightningd(27432): Adding block 1fa07982d4ece493bca11fb0c4fe302e0d7e626bb7638c8db5590d2d80e1e11f
DEBUG:proc:lightningd(27432): Adding block 64f6c0b379dedaafbcecd2d43fae975a373821d2463114636503d8a6b92cee72
DEBUG:proc:lightningd(27432): Adding block 826dee59b869370dde328308801fcb45f677c5b5f0992ce98a0aa3bac8a3c609
DEBUG:proc:lightningd(27432): Adding block fa91837ffd8ba8c616c66745fa9625b2fd0c04dd86fbdc216607737bea674b5d
DEBUG:proc:lightningd(27432): Adding block 2d2e1fc99a14c61c6e9436d5c6efb0033f752708a2605e737f8fcb83a4af494f
DEBUG:proc:lightningd(27432): Adding block 21a6614f88122158273fbed5c25784cf62572eab20f15da31a9537b002c5981c
DEBUG:proc:lightningd(27432): Adding block b2a3920d2344abb0ea5f8072c80cf2d2719ddc21430d414e905996c7ad88dc64
DEBUG:proc:lightningd(27432): Adding block a90530162afcc520bbb68301a41ca80c3e8749818e855f8e1202135610ee4935
DEBUG:proc:lightningd(27432): Adding block 1f2aff78008b55f4b3a4cfb12b8d9c7e7be3e37b042c3cb9061bfd97b571ed6c
DEBUG:proc:lightningd(27432): Adding block 247fcdbbd6677fae14538aa91ccf2dc8af572a7b16ad73b5a174cb249de6f703
DEBUG:proc:lightningd(27432): Adding block 3d280ed99c3200eedfc8ebef8cd29f5846684cc1193fca47fa5a0e5d8bd50157
DEBUG:proc:lightningd(27432): Adding block 9da85233279c5633d60e81355c20345c8bbdf3951f0ee62756633f0c4a1b9e12
DEBUG:proc:lightningd(27432): Adding block 353b34d38dbb9ab03419905d8b013b8fa1b585d03f2d8c91412f2b277d3c6d62
DEBUG:proc:lightningd(27432): Adding block d390b88dd43c2f3a66dff3c3e0689844e2721a3519829214091fec1540b8080c
DEBUG:proc:lightningd(27432): Adding block bcfaf0a867f3438f101b4ffca03a326ca9bd3bbfc3ab4013f2d62cbc02f45436
DEBUG:proc:lightningd(27432): Adding block 5d3c04ce0977ee73132dfaafba3789dec146b6d9da1b24250e50dd2ba7872f00
DEBUG:proc:lightningd(27432): Adding block 5ed0d1a62996ffce726188ad06bd10de93ba3d602117c587d25bd4163bd2a82c
DEBUG:proc:lightningd(27432): Adding block b1ff202c312f06cb7525581eddd95945b3a8731950ff7db173ccb02c8750d33a
DEBUG:proc:lightningd(27432): Adding block cd78e245b6e9720a683d2b08891df877c6e561185225c06ef11e04a978592049
DEBUG:proc:lightningd(27432): Adding block 0904b2223f63a04d23cc8eda0bdc608d738ba3a00e10e9d75d38b50520233068
DEBUG:proc:lightningd(27432): Adding block 69e2bf83bb0b3615dba66ac3c02cc3e0357895f2b5b05a09a40c7d410d100a12
DEBUG:proc:lightningd(27432): Adding block 56c82d6b0aec97b24e3a0cafbe7a874df9068a2b844510e345d6ea4dfa59607a
DEBUG:proc:lightningd(27432): Adding block 02fc71a9703b5e08f4bfb85159634b262954c355edc4d0c65c48befa73600953
DEBUG:proc:lightningd(27432): Adding block f9dc8b6a63ec625f69eda39697b4eaec95b686ebd87a8b1929343998fb374363
DEBUG:proc:lightningd(27432): Adding block bd5b0f9aebec751f440d0c277c58c401b38ea49f77932584b4fbe4e9297f2807
DEBUG:proc:lightningd(27432): Adding block d10e050ef7f5bb68ececa3cf488303bd99b34286c29b0615ccf5e6cd381bdb56
DEBUG:proc:lightningd(27432): Adding block 3922ca148cb52c09e8d1594478f30b1a5294c386ca9394ef0327c3896b075c64
DEBUG:proc:lightningd(27432): Adding block 1f67095775ee8e4af4514866a13bb7fb6857dd833466962846e359bb221d0613
DEBUG:proc:lightningd(27432): Adding block 5537a2a174a4ca5dd90b0f4c6d55c02f610741068a1a864f1833e8b87bbb317a
DEBUG:proc:lightningd(27432): Adding block 2fdd799a296bb85e75c1d089cebfa9084b05aef1d8daf0282ac4af07ca48c819
DEBUG:proc:lightningd(27432): Adding block 0536a3846bd205e99c0971c2917e3cc4f01bcdb0121f357faf83d72ead5f4246
DEBUG:proc:lightningd(27432): Adding block 33fa5ad0209a04acac42262156d52a3ee963aad55c0a053d5ffa031e0bbd9964
DEBUG:proc:lightningd(27432): Adding block 007ee2593e572fcd2d19284524064d91ad26079bde40efecb1a21581379a2278
DEBUG:proc:lightningd(27432): Adding block 1494f90340805dce259765c45be3ecd81ceadb3a7c2b662082385c50bc422136
DEBUG:proc:lightningd(27432): Adding block af59600b5ec5552fee28469d4c30ddb2da1124738eac953c2c93bd4f4afd8978
DEBUG:proc:lightningd(27432): Adding block 46c6fbf86c17048d1895785517b981ee293adfc7cd24d77f9bd118dfe6c06a1e
DEBUG:proc:lightningd(27432): Adding block da0f8c928300c039070433aa2f5b6adc23590cab736fa2156a46869ea4e5dd3a
DEBUG:proc:lightningd(27432): Adding block f6ba26c4d0c6ad08c164bf1707aa72c47581a0ceb3bb2bcfa92ccedbc7140c5b
DEBUG:proc:lightningd(27432): Adding block 25380257779532f973c60ba9d4caf57c37201f4c2f1b5d17f686fd0ffa107b66
DEBUG:proc:lightningd(27432): Adding block 9a78ba5efd030946455a2a96c02c2d3b1ad138e2d9202ce0dada1e01c410cf3e
DEBUG:proc:lightningd(27432): Adding block 340395375a1a25fcb16cd9b57ba433ea02b44a432880499f5373795b898d1931
DEBUG:proc:lightningd(27432): Adding block 757e65f629ac43aa8766111b8618894f125b91c7ab228922f741d004cc064332
DEBUG:proc:lightningd(27432): Adding block 7f08e9d54a7b2c8a56f0f0bb1dad43cdeba22d9ec2aa28ce22cf83d351860637
DEBUG:proc:lightningd(27432): Adding block 22d2c96c956c44d16903db536e26bb02bd0dfe863e69c66cf62ead38c6513c0b
DEBUG:proc:lightningd(27432): Adding block 48e4794af20a6136932b9dd137c1b1b208cf3186e5376eaae5f70d7a802ffe2f
DEBUG:proc:lightningd(27432): Adding block 3de6d90c71b314af4c958292eb79e76b7e0404d65bf49a1e397bf8f2c199a913
DEBUG:proc:lightningd(27432): Adding block aade901708c9d764005446e48badff7954eff075e6e3c04a07560bc6f613580e
DEBUG:proc:lightningd(27432): Adding block 0f08d80b4a472fd17e707c60146498c1943f131e3dd8b41d411f59435204687f
DEBUG:proc:lightningd(27432): Adding block be8d78c7de1c350b167c0b8b80ab14cb8a301f13dbc89cf05073d752fa89084d
DEBUG:proc:lightningd(27432): Adding block 8ef366b21924d5b18ec64ea8e137caf21a56af8f525b3f1a81d4b577c9b1794f
DEBUG:proc:lightningd(27432): Adding block c5995b972eccd60da4a1fe06d8edc3ab4223ae68f3617e2f4c56d59d7ad83b73
DEBUG:proc:lightningd(27432): Adding block aadeb68983f84d1b86d4d5138aec2c75900ec5a4f70412599a08b992a921b81f
DEBUG:proc:lightningd(27432): Adding block 74fa49a52824c23542c980364e0772cb0037933c4979f18eb52b6ffd3e4f571e
DEBUG:proc:lightningd(27432): Adding block 9f1be1728f1def1c75be2b8eeeabca7413fadc755c744cca0e52f0f9c8602430
DEBUG:proc:lightningd(27432): Adding block 01e931db0a648ff3f587534ed519631b7fb7e8b4e112517ad3814ed90d39564f
DEBUG:proc:lightningd(27432): Adding block d7a25c3d50f52737401e3250eb3baf10e55b75aefb491731ac0bb0d72add372b
DEBUG:proc:lightningd(27432): Adding block 4a7f78a1aef65ddd3f9d058588996625b77c2ab6a18fd4fa931f50c9e8363317
DEBUG:proc:lightningd(27432): Adding block 4fa6fb9fbd0aa5452bf2fc002780dd9caf9f5e8ce920779724ae063ff78af02b
DEBUG:proc:lightningd(27432): Adding block 4e749df5bbcb6fecf469fe3a21dc343e84a2767e74963ee400980fa606be0c32
DEBUG:proc:lightningd(27432): Adding block 9c0aaf609e4bde59c110204b65df627fc37aec20e0b84098c4bc33ed71432d22
DEBUG:proc:lightningd(27432): Adding block a7500935df20aa69a5babc79efcb9d24f1f666279c68e8c7aa80086f02685375
DEBUG:proc:lightningd(27432): Adding block 9942e051a3f147a3e838c002bb2a1070fc5bef58766652d3f00c443cfdc7b55b
DEBUG:proc:lightningd(27432): Adding block 46702198ec7218ca189d77bea8967cfded540d6479b589749e6619b22b625508
DEBUG:proc:lightningd(27432): Adding block 7240d01c1e93899aae1aa2fe7a3d539233c20e602717b72c8902847e17b5e119
DEBUG:proc:lightningd(27432): Adding block 6c00989fe1b40c2028135460589d1be05839341110a1edc1a29de3f01a3ddd37
DEBUG:proc:lightningd(27432): Adding block ee4845a4ca3142c1b38970ab0de83020ec495611dd48ca4eabbfd8be628a6220
DEBUG:proc:lightningd(27432): Adding block 071a629699c8c1a4cf0afa230c76b9c9eaa6fa0e726d4432e1a0c7f6e3707046
DEBUG:proc:lightningd(27432): Adding block 8074d483d8eabf8ce034e5c38562f57642c3d98262d8b800ccf35afaa4cdda4f
DEBUG:proc:lightningd(27432): Adding block 79f456b650bed876281052d908972a06aecdb5ad1b2ae3507fa494efb8d0c35f
DEBUG:proc:lightningd(27432): Adding block 7d6f22cfd147738c5f32b01f7322329a6a60bdd66f481ae0aa53336aad65cc30
DEBUG:proc:lightningd(27432): Adding block 7ee53887c9b6228688faaee5522b682250cee34c4596c63fac83d3e120c70162
DEBUG:proc:lightningd(27432): Adding block fc3f8c2bd8c89193c291971b93e26f399e1ed738952e9cbf38d4c2f2814ca907
DEBUG:proc:lightningd(27432): Adding block de584656276709b099d04206c77020d8d1805f15ef9ec0388983d90ef129607d
DEBUG:proc:lightningd(27432): Adding block 52a55ac1748ad8ed7af17f927d6a0b7baaa4a5fab1740bf44e0e4c94e71ebb3e
DEBUG:proc:lightningd(27432): Adding block 2e6665b25e022ae25de53827d959113d1fead791a898ae918a9fa87ca92d7919
DEBUG:proc:lightningd(27432): Adding block 3ae2e1db175333111f3fba88c04c99fd8c573622862d207458077d1b72117771
DEBUG:proc:lightningd(27432): Loaded 0 invoices from DB
DEBUG:proc:lightningd(27432): HSM TRACE: Control: type WIRE_HSMCTL_HSMFD_ECDH len 2
DEBUG:proc:lightning_gossipd(27553): pid 27553, msgfd 15
DEBUG:proc:lightningd(27432): Loaded 0 channels from DB
DEBUG:proc:lightningd(27432): Listening on 'lightning-rpc'
DEBUG:proc:lightningd(27432): Hello world from 025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 aka ODDTRAWL #025597 (version v0.5.2-2016-11-21-1199-gcfde208)!
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIPCTL_INIT len 78
DEBUG:proc:lightning_gossipd(27553): TRACE: Creating IPv6 listener on port 16331
DEBUG:root:Found 'Creating IPv6 listener on port' in logs
INFO:root:LightningD started
DEBUG:proc:lightning_gossipd(27553): TRACE: Failed to bind on 2 socket: Address already in use
DEBUG:proc:lightningd(27432): Immediate feerate 5022 (was 0)
DEBUG:proc:lightningd(27432): Normal feerate 5022 (was 0)
DEBUG:proc:lightningd(27432): Slow feerate 5022 (was 0)
DEBUG:root:Starting '/usr/lib/jvm/java-8-openjdk-amd64/bin/java -Declair.datadir=/tmp/lightning-il5fkavy/test_direct_payment[lightning_eclair]/node-2/ -Declair.printToConsole=true -jar bin/eclair.jar'
DEBUG:root:Waiting for 'connected to tcp://127.0.0.1:29000' in the logs
DEBUG:eclair(16332):17:22:11,374 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
DEBUG:eclair(16332):17:22:11,374 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
DEBUG:eclair(16332):17:22:11,374 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/cdecker/.capsule/apps/eclair-node-0.2-SNAPSHOT-2d5d68b/eclair-node_2.11-0.2-SNAPSHOT.jar!/logback.xml]
DEBUG:eclair(16332):17:22:11,383 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@5d37d31a - URL [jar:file:/home/cdecker/.capsule/apps/eclair-node-0.2-SNAPSHOT-2d5d68b/eclair-node_2.11-0.2-SNAPSHOT.jar!/logback.xml] is not of type file
DEBUG:eclair(16332):17:22:11,418 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
DEBUG:eclair(16332):17:22:11,421 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CONSOLE]
DEBUG:eclair(16332):17:22:11,428 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
DEBUG:eclair(16332):17:22:11,446 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
DEBUG:eclair(16332):17:22:11,448 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
DEBUG:eclair(16332):17:22:11,449 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
DEBUG:eclair(16332):17:22:11,449 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [/tmp/lightning-il5fkavy/test_direct_payment[lightning_eclair]/node-2//eclair.log]
DEBUG:eclair(16332):17:22:11,451 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [fr.acinq.eclair.channel] to DEBUG
DEBUG:eclair(16332):17:22:11,451 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [fr.acinq.eclair.channel.Register] to DEBUG
DEBUG:eclair(16332):17:22:11,451 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [fr.acinq.eclair.router] to INFO
DEBUG:eclair(16332):17:22:11,639 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
DEBUG:eclair(16332):17:22:11,639 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CONSOLE]
DEBUG:eclair(16332):17:22:11,639 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
DEBUG:eclair(16332):17:22:11,640 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CONSOLE] to Logger[ROOT]
DEBUG:eclair(16332):17:22:11,641 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
DEBUG:eclair(16332):17:22:11,641 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to Logger[ROOT]
DEBUG:eclair(16332):17:22:11,641 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
DEBUG:eclair(16332):17:22:11,642 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@4b7ec8b9 - Registering current configuration as safe fallback point
DEBUG:eclair(16332):2017-11-29 17:22:11,643 INFO akka.event.slf4j.Slf4jLogger - Slf4jLogger started
DEBUG:eclair(16332):2017-11-29 17:22:11,659 INFO fr.acinq.eclair.Setup - hello!
DEBUG:eclair(16332):2017-11-29 17:22:11,659 INFO fr.acinq.eclair.Setup - version=0.2-SNAPSHOT commit=2d5d68bf3f57363075d04e23447b9c19924d9f8a
DEBUG:eclair(16332):2017-11-29 17:22:11,729 INFO org.bitcoin.Secp256k1Context - couldn't find secp256k1 library, defaulting to spongycastle
DEBUG:eclair(16332):2017-11-29 17:22:12,400 INFO fr.acinq.eclair.Setup - nodeid=0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb alias=eclair
DEBUG:eclair(16332):2017-11-29 17:22:12,401 INFO fr.acinq.eclair.Setup - using chain=regtest chainHash=06226e46111a0b59caaf126043eb5bbf28c34f3a5e332a1fc7b2b73cf188910f
DEBUG:eclair(16332):2017-11-29 17:22:12,402 INFO fr.acinq.eclair.Setup - initializing secure random generator
DEBUG:eclair(16332):2017-11-29 17:22:13,889 INFO fr.acinq.eclair.Setup - initial feeratesPerByte=FeeratesPerByte(210,180,150,110,50,20)
DEBUG:eclair(16332):2017-11-29 17:22:13,891 INFO fr.acinq.eclair.Setup - current feeratesPerByte=FeeratesPerByte(210,180,150,110,50,20)
DEBUG:bitcoind:2017-11-29 16:22:13 keypool added 1 keys (0 internal), size=2000 (1000 internal)
DEBUG:eclair(16332):2017-11-29 17:22:13,932 INFO fr.acinq.eclair.router.Router akka://default/user/$f/router - loading network announcements from db...
DEBUG:eclair(16332):2017-11-29 17:22:13,934 INFO fr.acinq.eclair.router.Router akka://default/user/$f/router - starting state machine
DEBUG:eclair(16332):2017-11-29 17:22:13,941 INFO fr.acinq.eclair.router.Router akka://default/user/$f/router - current status channels=0 nodes=0 updates=0
DEBUG:bitcoind:2017-11-29 16:22:13 keypool reserve 217
DEBUG:bitcoind:2017-11-29 16:22:13 keypool keep 217
DEBUG:eclair(16332):2017-11-29 17:22:13,967 INFO fr.acinq.eclair.io.Server akka://default/user/$i/server - bound on /0:0:0:0:0:0:0:0:16332
DEBUG:eclair(16332):2017-11-29 17:22:14,009 INFO fr.acinq.eclair.Setup - initial wallet address=2MtmEbSKbPqU2or7C9Z4coXMzbqcMsu6x3w
DEBUG:eclair(16332):2017-11-29 17:22:15,006 INFO f.a.e.b.bitcoind.zmq.ZMQActor akka://default/user/$a/zmq - connected to tcp://127.0.0.1:29000
DEBUG:root:Found 'connected to tcp://127.0.0.1:29000' in logs
DEBUG:root:Waiting for 'initial wallet address=([a-zA-Z0-9]+)' in the logs
DEBUG:root:Found 'initial wallet address=([a-zA-Z0-9]+)' in logs
INFO:eclair(16332):Eclair started (pid: 27556)
INFO:root:Calling getinfo with params=[]
DEBUG:urllib3.connectionpool:Starting new HTTP connection (1): localhost
DEBUG:urllib3.connectionpool:http://localhost:26332 "POST / HTTP/1.1" 200 286
DEBUG:root:Method getinfo returned {'result': {'chainHash': '06226e46111a0b59caaf126043eb5bbf28c34f3a5e332a1fc7b2b73cf188910f', 'nodeId': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'alias': 'eclair', 'blockHeight': 745, 'port': 16332}, 'id': 'scala-client'}
DEBUG:lightning-node(16331):Calling connect with arguments ('0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'localhost:16332')
DEBUG:root:Calling connect with arguments ('0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'localhost:16332')
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIPCTL_PEER_ADDRHINT len 42
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIPCTL_REACH_PEER len 35
DEBUG:proc:lightning_gossipd(27553): TRACE: Connected out for 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb
DEBUG:proc:lightning_gossipd(27553): TRACE: Initiator: Act 1
DEBUG:proc:lightning_gossipd(27553): TRACE: Initiator: Act 2
DEBUG:eclair(16332):2017-11-29 17:22:15,202 INFO fr.acinq.eclair.io.Server akka://default/user/$i/server - connected to /127.0.0.1:40750
DEBUG:proc:lightning_gossipd(27553): TRACE: Initiator: Act 3
DEBUG:eclair(16332):2017-11-29 17:22:15,257 INFO fr.acinq.eclair.io.Server akka://default/user/$i/server - handshake completed with 025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58
DEBUG:eclair(16332):2017-11-29 17:22:15,268 INFO fr.acinq.eclair.io.Peer akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 - registering as a listener to Actor[akka://default/user/$i/server/$a#-1423862289]
DEBUG:eclair(16332):2017-11-29 17:22:15,290 INFO fr.acinq.eclair.io.Peer akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 - 025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 has features: initialRoutingSync=true
DEBUG:proc:lightning_gossipd(27553): UPDATE WIRE_GOSSIP_PEER_CONNECTED
DEBUG:proc:lightning_gossipd(27553): UPDATE WIRE_GOSSIP_PEER_CONNECTED
DEBUG:proc:lightningd(27432):jcon fd 14: Success
DEBUG:proc:lightningd(27432):jcon fd 14: Closing (Bad file descriptor)
DEBUG:proc:lightning_gossipd(27553): TRACE: Forgetting remote peer 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIPCTL_HANDLE_PEER len 193
DEBUG:proc:lightning_gossipd(27553): TRACE: handle_peer 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb: new peer
DEBUG:root:Received response for connect call: {'result': {'id': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb'}, 'jsonrpc': '2.0', 'id': 0}
DEBUG:lightning-node(16331):Call returned {'id': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb'}
DEBUG:lightning-node(16331):Calling getpeers with arguments ()
DEBUG:root:Calling getpeers with arguments ()
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIP_GETPEERS_REQUEST len 2
DEBUG:proc:lightning_gossipd(27553): REPLY WIRE_GOSSIP_GETPEERS_REPLY with 0 fds
DEBUG:proc:lightningd(27432):jcon fd 14: Success
DEBUG:proc:lightningd(27432):jcon fd 14: Closing (Bad file descriptor)
DEBUG:root:Received response for getpeers call: {'result': {'peers': [{'peerid': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'owner': 'lightning_gossipd', 'netaddr': ['127.0.0.1:16332'], 'connected': True, 'state': 'GOSSIPING'}]}, 'jsonrpc': '2.0', 'id': 0}
DEBUG:lightning-node(16331):Call returned {'peers': [{'peerid': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'owner': 'lightning_gossipd', 'netaddr': ['127.0.0.1:16332'], 'connected': True, 'state': 'GOSSIPING'}]}
INFO:root:Calling peers with params=[]
DEBUG:urllib3.connectionpool:http://localhost:26332 "POST / HTTP/1.1" 200 114
DEBUG:root:Method peers returned {'result': ['025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58'], 'id': 'scala-client'}
DEBUG:lightning-node(16331):Calling newaddr with arguments ()
DEBUG:root:Calling newaddr with arguments ()
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightningd(27432):jcon fd 14: Success
DEBUG:root:Received response for newaddr call: {'result': {'address': '2Mx6LEchFNy8gnpnQv6UXD5EvesfrmBxZcz'}, 'jsonrpc': '2.0', 'id': 0}
DEBUG:lightning-node(16331):Call returned {'address': '2Mx6LEchFNy8gnpnQv6UXD5EvesfrmBxZcz'}
{"method": "sendtoaddress", "params": ["2Mx6LEchFNy8gnpnQv6UXD5EvesfrmBxZcz", 0.2], "id": 1, "version": "1.1"}
DEBUG:proc:lightningd(27432):jcon fd 14: Closing (No such file or directory)
DEBUG:bitcoind:2017-11-29 16:22:15 keypool added 1 keys (0 internal), size=2000 (1000 internal)
DEBUG:bitcoind:2017-11-29 16:22:15 keypool reserve 1049
DEBUG:bitcoind:2017-11-29 16:22:15 Fee Calculation: Fee:5203 Bytes:259 Needed:5203 Tgt:6 (requested 6) Reason:"Conservative Double Target longer horizon" Decay 0.99520: Estimation: (19613.1 - 1e+99) 100.00% 27.1/(27.1 0 mem 0.0 out) Fail: (0 - 19613.1) -nan% 0.0/(0.0 0 mem 0.0 out)
DEBUG:bitcoind:2017-11-29 16:22:15 CommitTransaction:
DEBUG:bitcoind:CTransaction(hash=670c4d148b, ver=2, vin.size=2, vout.size=2, nLockTime=745)
DEBUG:bitcoind: CTxIn(COutPoint(02cb5a431e, 0), scriptSig=160014991ccd148271ab1217, nSequence=4294967294)
DEBUG:bitcoind: CTxIn(COutPoint(ca0dbc1870, 0), scriptSig=160014004c4eb51b506994da, nSequence=4294967294)
DEBUG:bitcoind: CScriptWitness(304502210082277810f82da6895ae33cea8352b29b290057794f4597a981906545b31942a202207b71b49bad1a37e7ecf21e3224168c7e6a17d4327fffd4d3b35d079e1e0dcdaf01, 03c389b619c4b5e2423adf82b72da1e7e67ad0b1ac19b5e31bdfbe436ca0d6110c)
DEBUG:bitcoind: CScriptWitness(304402204f16ca9ccf06f0ba20f75ad951ec57e458d9b93ee081cf27e0dec149ba06dd4702203082bd7fd65e64cf6681ab770cd0ae50924247bc594325a0067f54843a81f20701, 027fd52ca71542b3c679d239e84311e0fbbdc4d822b4a6e87ff3ac7a6de3b06239)
DEBUG:bitcoind: CTxOut(nValue=0.09960749, scriptPubKey=76a914af21792a3a5f20f5815c0e8d)
DEBUG:bitcoind: CTxOut(nValue=0.20000000, scriptPubKey=a914352a199f3e545ab733f85ddd4a)
DEBUG:bitcoind:2017-11-29 16:22:15 keypool keep 1049
DEBUG:bitcoind:2017-11-29 16:22:15 AddToWallet 670c4d148b4dc971cc7ce68ccdb24327dc2ee31c992a3a7cdc7e1755bb10f7b5 new
DEBUG:bitcoind:2017-11-29 16:22:15 AddToWallet 670c4d148b4dc971cc7ce68ccdb24327dc2ee31c992a3a7cdc7e1755bb10f7b5
DEBUG:bitcoind:2017-11-29 16:22:15 Relaying wtx 670c4d148b4dc971cc7ce68ccdb24327dc2ee31c992a3a7cdc7e1755bb10f7b5{"method": "getrawtransaction", "params": ["670c4d148b4dc971cc7ce68ccdb24327dc2ee31c992a3a7cdc7e1755bb10f7b5"], "id": 1, "version": "1.1"}
DEBUG:lightning-node(16331):Calling addfunds with arguments ('0200000000010233df77e6c8c1c65f4c357855704e9fb2d7bc611d747f8f2867bdfe1e435acb020000000017160014991ccd148271ab121798acbb8db7976876bd206cfeffffff59a7e7f23703ee05301937daec7e8aeb48982593e68618a869af437018bc0dca0000000017160014004c4eb51b506994da7f37d894a3a427abdcb9e9feffffff022dfd9700000000001976a914af21792a3a5f20f5815c0e8d12fc93125913ef9188ac002d31010000000017a914352a199f3e545ab733f85ddd4a5d49ea0ba12c06870248304502210082277810f82da6895ae33cea8352b29b290057794f4597a981906545b31942a202207b71b49bad1a37e7ecf21e3224168c7e6a17d4327fffd4d3b35d079e1e0dcdaf012103c389b619c4b5e2423adf82b72da1e7e67ad0b1ac19b5e31bdfbe436ca0d6110c0247304402204f16ca9ccf06f0ba20f75ad951ec57e458d9b93ee081cf27e0dec149ba06dd4702203082bd7fd65e64cf6681ab770cd0ae50924247bc594325a0067f54843a81f2070121027fd52ca71542b3c679d239e84311e0fbbdc4d822b4a6e87ff3ac7a6de3b06239e9020000',)
DEBUG:root:Calling addfunds with arguments ('0200000000010233df77e6c8c1c65f4c357855704e9fb2d7bc611d747f8f2867bdfe1e435acb020000000017160014991ccd148271ab121798acbb8db7976876bd206cfeffffff59a7e7f23703ee05301937daec7e8aeb48982593e68618a869af437018bc0dca0000000017160014004c4eb51b506994da7f37d894a3a427abdcb9e9feffffff022dfd9700000000001976a914af21792a3a5f20f5815c0e8d12fc93125913ef9188ac002d31010000000017a914352a199f3e545ab733f85ddd4a5d49ea0ba12c06870248304502210082277810f82da6895ae33cea8352b29b290057794f4597a981906545b31942a202207b71b49bad1a37e7ecf21e3224168c7e6a17d4327fffd4d3b35d079e1e0dcdaf012103c389b619c4b5e2423adf82b72da1e7e67ad0b1ac19b5e31bdfbe436ca0d6110c0247304402204f16ca9ccf06f0ba20f75ad951ec57e458d9b93ee081cf27e0dec149ba06dd4702203082bd7fd65e64cf6681ab770cd0ae50924247bc594325a0067f54843a81f2070121027fd52ca71542b3c679d239e84311e0fbbdc4d822b4a6e87ff3ac7a6de3b06239e9020000',)
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightningd(27432): Owning output 1 20000000 (P2SH) txid b5f710bb55177edc7c3a2a991ce32edc2743b2cd8ce67ccc71c94d8b144d0c67
DEBUG:proc:lightningd(27432):jcon fd 14: Success
DEBUG:root:Received response for addfunds call: {'result': {'satoshis': 20000000, 'outputs': 1}, 'jsonrpc': '2.0', 'id': 0}
DEBUG:lightning-node(16331):Call returned {'satoshis': 20000000, 'outputs': 1}
DEBUG:proc:lightningd(27432):jcon fd 14: Closing (No such file or directory)
{"method": "generate", "params": [10], "id": 1, "version": "1.1"}
DEBUG:bitcoind:2017-11-29 16:22:20 keypool added 1 keys (1 internal), size=2000 (1000 internal)
DEBUG:bitcoind:2017-11-29 16:22:20 keypool reserve 218
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 684 block weight: 1977 txs: 1 fees: 5203 sigops 406
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=464916099df715c6d7b3bf6113be6e818e936e4a031faa1d589f9abddaeacfff height=746 version=0x20000000 log2_work=10.544964 tx=843 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(840txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet db4f969906c3630406eaee79cbc936b53130080c39468ec2a501dfb53dd0d1a1 new
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet 670c4d148b4dc971cc7ce68ccdb24327dc2ee31c992a3a7cdc7e1755bb10f7b5 update
DEBUG:bitcoind:2017-11-29 16:22:20 keypool keep 218
DEBUG:proc:2017-11-29 17:22:20.451 [INF] BMGR: Processed 5 blocks in the last 18.25s (6 transactions, height 746, 2017-11-29 17:22:20 +0100 CET)
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=41a89c25c89a0d11496b4b49ecf7c5b95446d3baacf653030460aee3b3eb4927 height=747 version=0x20000000 log2_work=10.546894 tx=844 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(841txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet b592eebd1485f56396debfccafe96253fadefb6e52068752c2cf1c52dad5199c new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=56e5e09cfc9750eb0461a50b9a0075a5ad4af0e3a7bf2b8f4fe8e4ad69dc31d1 height=748 version=0x20000000 log2_work=10.548822 tx=845 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(842txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet 4f023e57cabb7dd83414877f0402d9f078b34bea18fe53db09531cda7ce44c32 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=6b7fffa9cdc5e3701ec00ee87b6706a87fe0322021b024f1480ac567e14ae51a height=749 version=0x20000000 log2_work=10.550747 tx=846 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(843txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet f758f7f0d51c22788da0306ddfcb0da1df90c9c1debad5b2890423c7d7a2bbd5 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=32072e02dc0b34b87b9804d261ee5eef74ca4ed2571da9447a07d438d204221d height=750 version=0x20000000 log2_work=10.552669 tx=847 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(844txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet c6e1f432283a1fc9b824309fa13d4c016199409fa81c1e5daa720a50b802d572 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=1b7a0913b4d049d1827576b679973026ff8f1d6383ab4a1e78481800ddb7d4f7 height=751 version=0x20000000 log2_work=10.554589 tx=848 date='2017-11-29 16:22:20' progress=1.000000 cache=0.2MiB(845txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet f68f62ee8b6f34fcef404726ee05d690560666d23f2e484178bf891aa727c813 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=31af930c65fad0ba49b64d69b8695f7edc60918ff7783b24ef36231e284c476d height=752 version=0x20000000 log2_work=10.556506 tx=849 date='2017-11-29 16:22:21' progress=1.000000 cache=0.2MiB(846txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet 976a70eecc7f294e7f6518033d1b6de7d2432bca571500f35c9791139bf8a37a new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=6dcbde28dd5308ca54b7c03a69dfe430b401a265c9d25e82f9e874fd64347a4c height=753 version=0x20000000 log2_work=10.558421 tx=850 date='2017-11-29 16:22:21' progress=1.000000 cache=0.2MiB(847txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet ca96905577a8a48cb4869af388f7d8e2b28de461f23b58495707adcdfbda7163 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=71b21231a378753f8e6b9c5f106bfc534910691a95d7f2ebc7be1bf04611fa40 height=754 version=0x20000000 log2_work=10.560333 tx=851 date='2017-11-29 16:22:21' progress=1.000000 cache=0.2MiB(848txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet 63474cdc8beb934b33f21c42db05bd19f70486ac4d2c918cc22cd4c0fb3c2e76 new
DEBUG:bitcoind:2017-11-29 16:22:20 CreateNewBlock(): total size: 263 block weight: 944 txs: 0 fees: 0 sigops 400
DEBUG:bitcoind:2017-11-29 16:22:20 UpdateTip: new best=1e811e90cd3e0f2eb233404f062a32d4260fb9aa70afb5c13e8b072a1dc2a42c height=755 version=0x20000000 log2_work=10.562242 tx=852 date='2017-11-29 16:22:21' progress=1.000000 cache=0.2MiB(849txo)
DEBUG:bitcoind:2017-11-29 16:22:20 AddToWallet b71ba02e4118c89ca1aef7411d5bbbadd3cd0ad61330ec5f5775e180e2875e6a new
DEBUG:proc:2017-11-29 17:22:20.618 [INF] CHAN: Adding orphan block 1e811e90cd3e0f2eb233404f062a32d4260fb9aa70afb5c13e8b072a1dc2a42c with parent 71b21231a378753f8e6b9c5f106bfc534910691a95d7f2ebc7be1bf04611fa40
DEBUG:proc:lightningd(27432): Adding block 2ca4c21d2a078b3ec1b5af70aab90f26d4322a064f4033b22e0f3ecd901e811e
DEBUG:proc:lightningd(27432): Adding block 40fa1146f01bbec7ebf2d7951a69104953fc6b105f9c6b8e3f7578a33112b271
DEBUG:proc:lightningd(27432): Adding block 4c7a3464fd74e8f9825ed2c965a201b430e4df693ac0b754ca0853dd28decb6d
DEBUG:proc:lightningd(27432): Adding block 6d474c281e2336ef243b78f78f9160dc7e5f69b8694db649bad0fa650c93af31
DEBUG:proc:lightningd(27432): Adding block f7d4b7dd001848781e4aab83631d8fff26309779b6767582d149d0b413097a1b
DEBUG:proc:lightningd(27432): Adding block 1d2204d238d4077a44a91d57d24eca74ef5eee61d204987bb8340bdc022e0732
DEBUG:proc:lightningd(27432): Adding block 1ae54ae167c50a48f124b0212032e07fa806677be80ec01e70e3c5cda9ff7f6b
DEBUG:proc:lightningd(27432): Adding block d131dc69ade4e84f8f2bbfa7e3f04aada575009a0ba56104eb5097fc9ce0e556
DEBUG:proc:lightningd(27432): Adding block 2749ebb3e3ae60040353f6acbad34654b9c5f7ec494b6b49110d9ac8259ca841
DEBUG:proc:lightningd(27432): Adding block ffcfeadabd9a9f581daa1f034a6e938e816ebe1361bfb3d7c615f79d09164946
DEBUG:proc:lightningd(27432): Immediate feerate 5022 (was 5022)
DEBUG:proc:lightningd(27432): Normal feerate 5022 (was 5022)
DEBUG:proc:lightningd(27432): Slow feerate 5022 (was 5022)
INFO:root:Calling getinfo with params=[]
DEBUG:urllib3.connectionpool:http://localhost:26332 "POST / HTTP/1.1" 200 286
DEBUG:root:Method getinfo returned {'result': {'chainHash': '06226e46111a0b59caaf126043eb5bbf28c34f3a5e332a1fc7b2b73cf188910f', 'nodeId': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'alias': 'eclair', 'blockHeight': 755, 'port': 16332}, 'id': 'scala-client'}
DEBUG:lightning-node(16331):Calling getpeers with arguments ()
DEBUG:root:Calling getpeers with arguments ()
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIP_GETPEERS_REQUEST len 2
DEBUG:proc:lightning_gossipd(27553): REPLY WIRE_GOSSIP_GETPEERS_REPLY with 0 fds
DEBUG:proc:lightningd(27432):jcon fd 14: Success
DEBUG:proc:lightningd(27432):jcon fd 14: Closing (Bad file descriptor)
DEBUG:root:Received response for getpeers call: {'result': {'peers': [{'peerid': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'owner': 'lightning_gossipd', 'netaddr': ['127.0.0.1:16332'], 'connected': True, 'state': 'GOSSIPING'}]}, 'jsonrpc': '2.0', 'id': 0}
DEBUG:lightning-node(16331):Call returned {'peers': [{'peerid': '0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 'owner': 'lightning_gossipd', 'netaddr': ['127.0.0.1:16332'], 'connected': True, 'state': 'GOSSIPING'}]}
DEBUG:lightning-node(16331):Calling fundchannel with arguments ('0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 10000000)
DEBUG:root:Calling fundchannel with arguments ('0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb', 10000000)
DEBUG:proc:lightningd(27432): Connected json input
DEBUG:proc:lightning_gossipd(27553): TRACE: req: type WIRE_GOSSIPCTL_RELEASE_PEER len 35
DEBUG:proc:lightning_gossipd(27553): REPLY WIRE_GOSSIPCTL_RELEASE_PEER_REPLY with 2 fds
DEBUG:proc:lightningd(27432): peer 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb: state: UNINITIALIZED -> OPENINGD
DEBUG:proc:lightning_openingd(28147): pid 28147, msgfd 19
DEBUG:proc:lightning_openingd(28147): TRACE: First per_commit_point = 03cee11a81bca5c0db7ab54930658decec0c23a21c9cfb07ebf721d7eee5607287
DEBUG:eclair(16332):2017-11-29 17:22:25,651 INFO fr.acinq.eclair.io.Peer akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 - accepting a new channel to 025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58
DEBUG:bitcoind:2017-11-29 16:22:25 keypool added 1 keys (0 internal), size=2000 (1000 internal)
DEBUG:bitcoind:2017-11-29 16:22:25 keypool reserve 219
DEBUG:bitcoind:2017-11-29 16:22:25 keypool keep 219
DEBUG:eclair(16332):2017-11-29 17:22:25,901 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a - setting repeating timer 'TickRefreshChannelUpdate'/1 day: TickRefreshChannelUpdate
DEBUG:eclair(16332):2017-11-29 17:22:25,923 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 0000000000000000000000000000000000000000000000000000000000000000 - processing Event(INPUT_INIT_FUNDEE(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,LocalParams(0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb,542,100000000000,100000,1000000,144,30,84bb07e11ebe0466df39154de467af24afb0fb3ed723338d77a74efe01cfb24e01,056f2980bbf1710c1eade074a89a1152261908e4e15f23e915812a47ec6ac3a6,09dc38f7c633e68580967d65bb8819d6e1f5c9f49bbafbcef5e4398eeb7848f2,9a7368bc4a4581c62777220c21a9430ef1a0abaae9d46227ec8b3b75a3e5cc91,771d94905dbbbe199748ab7fe509fdbf54944553ed7572771a2f1e53855f5584,a9147d479456cf75e54a31aeeaeaa9e34de9f3eb08c487,bbcd0b0446e13952848d83f197242aa7a8c59201a33d384a7d859a6fbdf64c90,false,,08),Actor[akka://default/user/$i/server/$a#-1423862289],Init(,08)),Nothing) from Actor[akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58#-305577984] in state WAIT_FOR_INIT_INTERNAL
DEBUG:eclair(16332):2017-11-29 17:22:25,924 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 0000000000000000000000000000000000000000000000000000000000000000 - transition WAIT_FOR_INIT_INTERNAL -> WAIT_FOR_OPEN_CHANNEL
DEBUG:eclair(16332):2017-11-29 17:22:25,925 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - processing Event(OpenChannel(06226e46111a0b59caaf126043eb5bbf28c34f3a5e332a1fc7b2b73cf188910f,1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,10000000,0,546,18446744073709551615,100000,0,5022,6,483,0221c84139878426125ebae5794c3da642da936ae072b7ca551e1be7ca5611d588,028c77584ba29ea52b5dda2dddf444e405e433c04248c3f34bfb542bdebea1b9e4,0222ba0724ede112bd1878b04a3c3b548111ef85879fc3751ca792757f3959e916,02c0c737a4b517bba5e2644029f498a87cadb97552f8e106a5fc99ac5b80c99b79,02eb85800d81dd27a04a084ea57e2ec577a177c6218744ca7bbf186a5c3066aeb9,03cee11a81bca5c0db7ab54930658decec0c23a21c9cfb07ebf721d7eee5607287,1),DATA_WAIT_FOR_OPEN_CHANNEL(INPUT_INIT_FUNDEE(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,LocalParams(0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb,542,100000000000,100000,1000000,144,30,84bb07e11ebe0466df39154de467af24afb0fb3ed723338d77a74efe01cfb24e01,056f2980bbf1710c1eade074a89a1152261908e4e15f23e915812a47ec6ac3a6,09dc38f7c633e68580967d65bb8819d6e1f5c9f49bbafbcef5e4398eeb7848f2,9a7368bc4a4581c62777220c21a9430ef1a0abaae9d46227ec8b3b75a3e5cc91,771d94905dbbbe199748ab7fe509fdbf54944553ed7572771a2f1e53855f5584,a9147d479456cf75e54a31aeeaeaa9e34de9f3eb08c487,bbcd0b0446e13952848d83f197242aa7a8c59201a33d384a7d859a6fbdf64c90,false,,08),Actor[akka://default/user/$i/server/$a#-1423862289],Init(,08)))) from Actor[akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58#-305577984] in state WAIT_FOR_OPEN_CHANNEL
DEBUG:eclair(16332):2017-11-29 17:22:25,926 WARN fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - local/remote feerates are too different: remoteFeeratePerKw=5022 localFeeratePerKw=53760
DEBUG:eclair(16332):2017-11-29 17:22:25,927 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - transition WAIT_FOR_OPEN_CHANNEL -> CLOSED
DEBUG:proc:lightning_openingd(28147): TRACE: Read decrypt 00111125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a04102790700586c6f63616c2f72656d6f74652066656572617465732061726520746f6f20646966666572656e743a2072656d6f7465466565726174655065724b773d35303232206c6f63616c466565726174655065724b773d3533373630
DEBUG:proc:lightning_openingd(28147): STATUS_FAIL_PEER_BAD: Parsing accept_channel 00111125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a04102790700586c6f63616c2f72656d6f74652066656572617465732061726520746f6f20646966666572656e743a2072656d6f7465466565726174655065724b773d35303232206c6f63616c466565726174655065724b773d3533373630
DEBUG:proc:lightningd(27432): peer 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb: Peer permanent failure in OPENINGD: Parsing accept_channel 00111125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a04102790700586c6f63616c2f72656d6f74652066656572617465732061726520746f6f20646966666572656e743a2072656d6f7465466565726174655065724b773d35303232206c6f63616c466565726174655065724b773d3533373630
DEBUG:proc:lightningd(27432):jcon fd 14: Failing: Peer died
DEBUG:eclair(16332):2017-11-29 17:22:25,934 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - processing Event(Error(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,50617273696e67206163636570745f6368616e6e656c20303031313131323563643666666434666131313031646435336135656334336536643433666630653864623039316234636264643938373439346130343130323739303730303538366336663633363136633266373236353664366637343635323036363635363537323631373436353733323036313732363532303734366636663230363436393636363636353732363536653734336132303732363536643666373436353436363536353732363137343635353036353732346237373364333533303332333232303663366636333631366334363635363537323631373436353530363537323462373733643335333333373336333000),DATA_WAIT_FOR_OPEN_CHANNEL(INPUT_INIT_FUNDEE(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,LocalParams(0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb,542,100000000000,100000,1000000,144,30,84bb07e11ebe0466df39154de467af24afb0fb3ed723338d77a74efe01cfb24e01,056f2980bbf1710c1eade074a89a1152261908e4e15f23e915812a47ec6ac3a6,09dc38f7c633e68580967d65bb8819d6e1f5c9f49bbafbcef5e4398eeb7848f2,9a7368bc4a4581c62777220c21a9430ef1a0abaae9d46227ec8b3b75a3e5cc91,771d94905dbbbe199748ab7fe509fdbf54944553ed7572771a2f1e53855f5584,a9147d479456cf75e54a31aeeaeaa9e34de9f3eb08c487,bbcd0b0446e13952848d83f197242aa7a8c59201a33d384a7d859a6fbdf64c90,false,,08),Actor[akka://default/user/$i/server/$a#-1423862289],Init(,08)))) from Actor[akka://default/user/$i/server/$a#-1423862289] in state CLOSED
DEBUG:eclair(16332):2017-11-29 17:22:25,936 WARN fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - unhandled event Error(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,50617273696e67206163636570745f6368616e6e656c20303031313131323563643666666434666131313031646435336135656334336536643433666630653864623039316234636264643938373439346130343130323739303730303538366336663633363136633266373236353664366637343635323036363635363537323631373436353733323036313732363532303734366636663230363436393636363636353732363536653734336132303732363536643666373436353436363536353732363137343635353036353732346237373364333533303332333232303663366636333631366334363635363537323631373436353530363537323462373733643335333333373336333000) in state CLOSED
DEBUG:eclair(16332):2017-11-29 17:22:25,937 WARN f.a.eclair.crypto.TransportHandler akka://default/user/$i/server/$a - connection closed
DEBUG:eclair(16332):2017-11-29 17:22:25,949 WARN fr.acinq.eclair.io.Peer akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58 - lost connection to 025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58
DEBUG:eclair(16332):2017-11-29 17:22:25,951 DEBUG fr.acinq.eclair.channel.Channel akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58/$a 1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907 - processing Event(INPUT_DISCONNECTED,DATA_WAIT_FOR_OPEN_CHANNEL(INPUT_INIT_FUNDEE(1125cd6ffd4fa1101dd53a5ec43e6d43ff0e8db091b4cbdd987494a041027907,LocalParams(0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb,542,100000000000,100000,1000000,144,30,84bb07e11ebe0466df39154de467af24afb0fb3ed723338d77a74efe01cfb24e01,056f2980bbf1710c1eade074a89a1152261908e4e15f23e915812a47ec6ac3a6,09dc38f7c633e68580967d65bb8819d6e1f5c9f49bbafbcef5e4398eeb7848f2,9a7368bc4a4581c62777220c21a9430ef1a0abaae9d46227ec8b3b75a3e5cc91,771d94905dbbbe199748ab7fe509fdbf54944553ed7572771a2f1e53855f5584,a9147d479456cf75e54a31aeeaeaa9e34de9f3eb08c487,bbcd0b0446e13952848d83f197242aa7a8c59201a33d384a7d859a6fbdf64c90,false,,08),Actor[akka://default/user/$i/server/$a#-1423862289],Init(,08)))) from Actor[akka://default/user/$g/switchboard/peer-025597ac42f95417f9d4481be40068fcc777910e0bed33ab9e7a347d38110dbe58#-305577984] in state CLOSED
DEBUG:proc:lightning_gossipd(27553): TRACE: Forgetting remote peer 0370607a88400c908964360148f09bc7084b2f6862b2dfbfd66f789b2cc9b9cafb
DEBUG:root:Received response for fundchannel call: {'jsonrpc': '2.0', 'error': 'Peer died', 'id': 0}
--------------------------- Captured stdout teardown ---------------------------
INFO:root:LightningD stopped
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment