1
   2
   3
   4
   5
   6
   7
   8
   9
  10
  11
  12
  13
  14
  15
  16
  17
  18
  19
  20
  21
  22
  23
  24
  25
  26
  27
  28
  29
  30
  31
  32
  33
  34
  35
  36
  37
  38
  39
  40
  41
  42
  43
  44
  45
  46
  47
  48
  49
  50
  51
  52
  53
  54
  55
  56
  57
  58
  59
  60
  61
  62
  63
  64
  65
  66
  67
  68
  69
  70
  71
  72
  73
  74
  75
  76
  77
  78
  79
  80
  81
  82
  83
  84
  85
  86
  87
  88
  89
  90
  91
  92
  93
  94
  95
  96
  97
  98
  99
 100
 101
 102
 103
 104
 105
 106
 107
 108
 109
 110
 111
 112
 113
 114
 115
 116
 117
 118
 119
 120
 121
 122
 123
 124
 125
 126
 127
 128
 129
 130
 131
 132
 133
 134
 135
 136
 137
 138
 139
 140
 141
 142
 143
 144
 145
 146
 147
 148
 149
 150
 151
 152
 153
 154
 155
 156
 157
 158
 159
 160
 161
 162
 163
 164
 165
 166
 167
 168
 169
 170
 171
 172
 173
 174
 175
 176
 177
 178
 179
 180
 181
 182
 183
 184
 185
 186
 187
 188
 189
 190
 191
 192
 193
 194
 195
 196
 197
 198
 199
 200
 201
 202
 203
 204
 205
 206
 207
 208
 209
 210
 211
 212
 213
 214
 215
 216
 217
 218
 219
 220
 221
 222
 223
 224
 225
 226
 227
 228
 229
 230
 231
 232
 233
 234
 235
 236
 237
 238
 239
 240
 241
 242
 243
 244
 245
 246
 247
 248
 249
 250
 251
 252
 253
 254
 255
 256
 257
 258
 259
 260
 261
 262
 263
 264
 265
 266
 267
 268
 269
 270
 271
 272
 273
 274
 275
 276
 277
 278
 279
 280
 281
 282
 283
 284
 285
 286
 287
 288
 289
 290
 291
 292
 293
 294
 295
 296
 297
 298
 299
 300
 301
 302
 303
 304
 305
 306
 307
 308
 309
 310
 311
 312
 313
 314
 315
 316
 317
 318
 319
 320
 321
 322
 323
 324
 325
 326
 327
 328
 329
 330
 331
 332
 333
 334
 335
 336
 337
 338
 339
 340
 341
 342
 343
 344
 345
 346
 347
 348
 349
 350
 351
 352
 353
 354
 355
 356
 357
 358
 359
 360
 361
 362
 363
 364
 365
 366
 367
 368
 369
 370
 371
 372
 373
 374
 375
 376
 377
 378
 379
 380
 381
 382
 383
 384
 385
 386
 387
 388
 389
 390
 391
 392
 393
 394
 395
 396
 397
 398
 399
 400
 401
 402
 403
 404
 405
 406
 407
 408
 409
 410
 411
 412
 413
 414
 415
 416
 417
 418
 419
 420
 421
 422
 423
 424
 425
 426
 427
 428
 429
 430
 431
 432
 433
 434
 435
 436
 437
 438
 439
 440
 441
 442
 443
 444
 445
 446
 447
 448
 449
 450
 451
 452
 453
 454
 455
 456
 457
 458
 459
 460
 461
 462
 463
 464
 465
 466
 467
 468
 469
 470
 471
 472
 473
 474
 475
 476
 477
 478
 479
 480
 481
 482
 483
 484
 485
 486
 487
 488
 489
 490
 491
 492
 493
 494
 495
 496
 497
 498
 499
 500
 501
 502
 503
 504
 505
 506
 507
 508
 509
 510
 511
 512
 513
 514
 515
 516
 517
 518
 519
 520
 521
 522
 523
 524
 525
 526
 527
 528
 529
 530
 531
 532
 533
 534
 535
 536
 537
 538
 539
 540
 541
 542
 543
 544
 545
 546
 547
 548
 549
 550
 551
 552
 553
 554
 555
 556
 557
 558
 559
 560
 561
 562
 563
 564
 565
 566
 567
 568
 569
 570
 571
 572
 573
 574
 575
 576
 577
 578
 579
 580
 581
 582
 583
 584
 585
 586
 587
 588
 589
 590
 591
 592
 593
 594
 595
 596
 597
 598
 599
 600
 601
 602
 603
 604
 605
 606
 607
 608
 609
 610
 611
 612
 613
 614
 615
 616
 617
 618
 619
 620
 621
 622
 623
 624
 625
 626
 627
 628
 629
 630
 631
 632
 633
 634
 635
 636
 637
 638
 639
 640
 641
 642
 643
 644
 645
 646
 647
 648
 649
 650
 651
 652
 653
 654
 655
 656
 657
 658
 659
 660
 661
 662
 663
 664
 665
 666
 667
 668
 669
 670
 671
 672
 673
 674
 675
 676
 677
 678
 679
 680
 681
 682
 683
 684
 685
 686
 687
 688
 689
 690
 691
 692
 693
 694
 695
 696
 697
 698
 699
 700
 701
 702
 703
 704
 705
 706
 707
 708
 709
 710
 711
 712
 713
 714
 715
 716
 717
 718
 719
 720
 721
 722
 723
 724
 725
 726
 727
 728
 729
 730
 731
 732
 733
 734
 735
 736
 737
 738
 739
 740
 741
 742
 743
 744
 745
 746
 747
 748
 749
 750
 751
 752
 753
 754
 755
 756
 757
 758
 759
 760
 761
 762
 763
 764
 765
 766
 767
 768
 769
 770
 771
 772
 773
 774
 775
 776
 777
 778
 779
 780
 781
 782
 783
 784
 785
 786
 787
 788
 789
 790
 791
 792
 793
 794
 795
 796
 797
 798
 799
 800
 801
 802
 803
 804
 805
 806
 807
 808
 809
 810
 811
 812
 813
 814
 815
 816
 817
 818
 819
 820
 821
 822
 823
 824
 825
 826
 827
 828
 829
 830
 831
 832
 833
 834
 835
 836
 837
 838
 839
 840
 841
 842
 843
 844
 845
 846
 847
 848
 849
 850
 851
 852
 853
 854
 855
 856
 857
 858
 859
 860
 861
 862
 863
 864
 865
 866
 867
 868
 869
 870
 871
 872
 873
 874
 875
 876
 877
 878
 879
 880
 881
 882
 883
 884
 885
 886
 887
 888
 889
 890
 891
 892
 893
 894
 895
 896
 897
 898
 899
 900
 901
 902
 903
 904
 905
 906
 907
 908
 909
 910
 911
 912
 913
 914
 915
 916
 917
 918
 919
 920
 921
 922
 923
 924
 925
 926
 927
 928
 929
 930
 931
 932
 933
 934
 935
 936
 937
 938
 939
 940
 941
 942
 943
 944
 945
 946
 947
 948
 949
 950
 951
 952
 953
 954
 955
 956
 957
 958
 959
 960
 961
 962
 963
 964
 965
 966
 967
 968
 969
 970
 971
 972
 973
 974
 975
 976
 977
 978
 979
 980
 981
 982
 983
 984
 985
 986
 987
 988
 989
 990
 991
 992
 993
 994
 995
 996
 997
 998
 999
1000
1001
1002
1003
1004
1005
1006
1007
1008
1009
1010
1011
1012
1013
1014
1015
1016
1017
1018
1019
1020
1021
1022
1023
1024
1025
1026
1027
1028
1029
1030
1031
1032
1033
1034
1035
1036
1037
1038
1039
1040
1041
1042
1043
1044
1045
1046
1047
1048
1049
1050
1051
1052
1053
1054
1055
1056
1057
1058
1059
1060
1061
1062
1063
1064
1065
1066
1067
1068
1069
1070
1071
1072
1073
1074
1075
1076
1077
2020-07-29 08:08:25.274 [WRN] LTND: open /tmp/lndtest-node937599969/data: no such file or directory
2020-07-29 08:08:25.274 [INF] LTND: Version: 0.10.99-beta commit=clock/v1.0.0-252-g61079d45ef66fa0ca3ed97040e4bd9497445c861, build=development, logging=default
2020-07-29 08:08:25.274 [INF] LTND: Active chain: Bitcoin (network=regtest)
2020-07-29 08:08:25.274 [INF] LTND: Opening the main database, this might take a few minutes...
2020-07-29 08:08:25.281 [INF] CHDB: Checking for schema update: latest_version=17, db_version=17
2020-07-29 08:08:25.281 [INF] LTND: Database now open (time_to_open=6.320383ms)!
2020-07-29 08:08:25.281 [INF] RPCS: Generating TLS certificates...
2020-07-29 08:08:25.289 [INF] RPCS: Done generating TLS certificates
2020-07-29 08:08:25.298 [INF] LTND: Primary chain is set to: bitcoin
2020-07-29 08:08:25.321 [INF] LNWL: Opened wallet
2020-07-29 08:08:25.322 [INF] LNWL: The wallet has been unlocked without a time limit
2020-07-29 08:08:25.364 [INF] LTND: LightningWallet opened
2020-07-29 08:08:25.364 [DBG] LNWL: Locating suitable block for birthday 2020-07-27 08:08:25 +0000 UTC between blocks 0-3278
2020-07-29 08:08:25.365 [DBG] LNWL: Checking candidate block: height=1639, hash=481f789843bd612c7369c89cd28f3e3ff4a41e01cb815422f2f4841ba2d5c728, timestamp=2020-07-29 07:57:00 +0000 UTC
2020-07-29 08:08:25.365 [DBG] LNWL: Checking candidate block: height=819, hash=0e1b4580a79a384e91dd09c353c531552f38134bca10f59553588af26c0dfa81, timestamp=2020-07-29 07:53:16 +0000 UTC
2020-07-29 08:08:25.366 [DBG] LNWL: Checking candidate block: height=409, hash=2089456bf99831716ca019dc642f3321173adf9ee7d664a49a7f1c1f7e9b70b5, timestamp=2020-07-29 07:51:40 +0000 UTC
2020-07-29 08:08:25.367 [DBG] LNWL: Checking candidate block: height=204, hash=38e278777bf32ae04dcedb74fc1ad59ada45012d9e8cfcd6a1897711e0bc1e29, timestamp=2020-07-29 07:51:06 +0000 UTC
2020-07-29 08:08:25.367 [DBG] LNWL: Checking candidate block: height=102, hash=1081b0250a16d8e306d84d12947fa32dd3f7c5dfca968f3a29add9196c3c3363, timestamp=2020-07-29 07:50:49 +0000 UTC
2020-07-29 08:08:25.368 [DBG] LNWL: Checking candidate block: height=51, hash=73acdbab9993bfd62b79a4eb4980909780a1002b440f50d4eac4189ca54dd42c, timestamp=2020-07-29 07:50:41 +0000 UTC
2020-07-29 08:08:25.368 [DBG] LNWL: Checking candidate block: height=25, hash=14f011cc5e3454aef91a989361ae6ac68ca3aa088c1a4ebf2c1622a3253342bc, timestamp=2020-07-29 07:50:36 +0000 UTC
2020-07-29 08:08:25.369 [DBG] LNWL: Checking candidate block: height=12, hash=5751e666a1ba5548e0a9798eb1367d1aabfd8b8823cd4d9865bbc84bc7bd225b, timestamp=2020-07-29 07:50:34 +0000 UTC
2020-07-29 08:08:25.369 [DBG] LNWL: Checking candidate block: height=6, hash=35e8550460176f376ef95bdcd1c495b9dbbd3118f92e1a6b5d1937988993316b, timestamp=2020-07-29 07:50:33 +0000 UTC
2020-07-29 08:08:25.370 [DBG] LNWL: Checking candidate block: height=3, hash=742d163d3c05a7f88efb98f0116988a9574035cdda2aee98f29220ac4899b4ce, timestamp=2020-07-29 07:50:32 +0000 UTC
2020-07-29 08:08:25.370 [DBG] LNWL: Checking candidate block: height=1, hash=1f68d1ec4b8735437885ecf3a40a601bcbfc0ca2f38ff55fdb2da0e16736ae05, timestamp=2020-07-29 07:50:31 +0000 UTC
2020-07-29 08:08:25.370 [DBG] LNWL: Checking candidate block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC
2020-07-29 08:08:25.370 [DBG] LNWL: Found birthday block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC
2020-07-29 08:08:25.371 [INF] HSWC: Restoring in-memory circuit state from disk
2020-07-29 08:08:25.371 [INF] HSWC: Payment circuits loaded: num_pending=0, num_open=0
2020-07-29 08:08:25.376 [INF] LNWL: Started rescan from block 0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (height 0) for 0 addresses
2020-07-29 08:08:25.376 [INF] LNWL: Catching up block hashes to height 3278, this might take a while
2020-07-29 08:08:25.377 [DBG] CRTR: Instantiating mission control with config: PenaltyHalfLife=1h0m0s, AprioriHopProbability=0.6, AprioriWeight=0.5
2020-07-29 08:08:25.378 [DBG] CRTR: Mission control state reconstruction started
2020-07-29 08:08:25.378 [DBG] CRTR: Mission control state reconstruction finished: n=0, time=8.618ยตs
2020-07-29 08:08:25.378 [DBG] SRVR: Instantiating payment session source with config: PaymentAttemptPenalty=100, MinRouteProbability=0.01
2020-07-29 08:08:25.390 [INF] SWPR: Migrating UTXO nursery finalized TXIDs
2020-07-29 08:08:25.391 [INF] LTND: Channel backup proxy channel notifier starting
2020-07-29 08:08:25.391 [INF] ATPL: Instantiating autopilot with active=false, max_channels=5, allocation=0.600000, min_chan_size=20000, max_chan_size=16777215, private=false, min_confs=1, conf_target=3
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: SignRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: WalletKitRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: AutopilotRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: ChainRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: InvoicesRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: RouterRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerRPC
2020-07-29 08:08:25.391 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerClientRPC
2020-07-29 08:08:25.391 [INF] SGNR: Making macaroons for Signer RPC Server at: /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/signer.macaroon
2020-07-29 08:08:25.392 [INF] RRPC: Making macaroons for Router RPC Server at: /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/router.macaroon
2020-07-29 08:08:25.393 [INF] NTFR: Baking macaroons for ChainNotifier RPC Server at: /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/chainnotifier.macaroon
2020-07-29 08:08:25.393 [INF] IRPC: Baking macaroons for invoices RPC Server at: /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/invoices.macaroon
2020-07-29 08:08:25.394 [INF] WLKT: Baking macaroons for WalletKit RPC Server at: /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/walletkit.macaroon
2020-07-29 08:08:25.395 [DBG] SGNR: Signer RPC server successfully register with root gRPC server
2020-07-29 08:08:25.395 [DBG] ARPC: Autopilot RPC server successfully register with root gRPC server
2020-07-29 08:08:25.395 [DBG] VRPC: Versioner RPC server successfully registered with root gRPC server
2020-07-29 08:08:25.395 [DBG] RPCS: WatchtowerClient RPC server successfully registered with  root gRPC server
2020-07-29 08:08:25.395 [DBG] RRPC: Router RPC server successfully register with root gRPC server
2020-07-29 08:08:25.395 [DBG] NTFR: ChainNotifier RPC server successfully register with root gRPC server
2020-07-29 08:08:25.395 [DBG] IRPC: Invoices RPC server successfully registered with root gRPC server
2020-07-29 08:08:25.395 [DBG] WLKT: WalletKit RPC server successfully registered with root gRPC server
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: SignRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: AutopilotRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: VersionRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: WatchtowerClientRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: RouterRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: ChainRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: InvoicesRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: WalletKitRPC
2020-07-29 08:08:25.395 [DBG] RPCS: Starting sub RPC server: WatchtowerRPC
2020-07-29 08:08:25.395 [DBG] SGNR: Signer REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] ARPC: Autopilot REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] VRPC: Versioner REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] RRPC: Router REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] NTFR: ChainNotifier REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] IRPC: Invoices REST server successfully registered with root REST server
2020-07-29 08:08:25.395 [DBG] WLKT: WalletKit REST server successfully registered with root REST server
2020-07-29 08:08:25.396 [INF] RPCS: RPC server listening on 127.0.0.1:20201
2020-07-29 08:08:25.397 [INF] RPCS: gRPC proxy started at 127.0.0.1:20202
2020-07-29 08:08:25.456 [INF] PRNF: PeerNotifier starting
2020-07-29 08:08:25.461 [INF] HSWC: Starting HTLC Switch
2020-07-29 08:08:25.461 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:25.461 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:25.461 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:25.461 [INF] DISC: Authenticated Gossiper is starting
2020-07-29 08:08:25.461 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:25.461 [INF] BRAR: Starting contract observer, watching for breaches.
2020-07-29 08:08:25.462 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:25.462 [DBG] DISC: New block: height=3278, hash=024cb15d3f92a69524e6e21de1a94a508276cff4b8721d813ee8022545691b7f
2020-07-29 08:08:25.463 [INF] CRTR: FilteredChainView starting
2020-07-29 08:08:25.517 [INF] CRTR: Filtering chain using 0 channels active
2020-07-29 08:08:25.517 [INF] CRTR: Prune tip for Channel Graph: height=3278, hash=024cb15d3f92a69524e6e21de1a94a508276cff4b8721d813ee8022545691b7f
2020-07-29 08:08:25.518 [DBG] INVC: Adding 0 pending invoices to the expiry watcher
2020-07-29 08:08:25.518 [INF] CHFT: Adding 0 channels to event store
2020-07-29 08:08:25.518 [INF] CHBU: Starting chanbackup.SubSwapper
2020-07-29 08:08:26.348 [DBG] CRTR: New graph topology client subscription, client 1
2020-07-29 08:08:26.690 [INF] LNWL: Done catching up block hashes
2020-07-29 08:08:26.690 [INF] LNWL: Finished rescan for 0 addresses (synced to block 024cb15d3f92a69524e6e21de1a94a508276cff4b8721d813ee8022545691b7f, height 3278)
2020-07-29 08:08:26.693 [INF] CHBU: Updating backup file at /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:26.694 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:26.694 [DBG] CHBU: SubSwapper's backupUpdater is active!
2020-07-29 08:08:26.694 [INF] BTCN: Server listening on 127.0.0.1:20200
2020-07-29 08:08:26.695 [INF] SRVR: Auto peer bootstrapping is disabled
2020-07-29 08:08:27.348 [DBG] CRTR: New graph topology client subscription, client 2
2020-07-29 08:08:29.453 [DBG] RPCS: [walletbalance] Total balance=0 BTC (confirmed=0 BTC, unconfirmed=0 BTC)
2020-07-29 08:08:29.458 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qd0je7vm4a6v7am2unkgkqqxz8y9u90mrvatj5g
2020-07-29 08:08:29.482 [DBG] RPCS: [listunspent] min=0 max=0, generated utxos: []
2020-07-29 08:08:29.503 [DBG] RPCS: [listunspent] min=0 max=0, generated utxos: []
2020-07-29 08:08:29.524 [DBG] RPCS: [listunspent] min=0 max=0, generated utxos: []
2020-07-29 08:08:29.526 [INF] LNWL: Inserting unconfirmed transaction 36537c9c3a825bb760787c62acc400f32774e54f6278b856822863fc5712178a
2020-07-29 08:08:29.527 [DBG] LNWL: Marked address bcrt1qd0je7vm4a6v7am2unkgkqqxz8y9u90mrvatj5g used
2020-07-29 08:08:29.545 [DBG] RPCS: [listunspent] min=0 max=0, generated utxos: [36537c9c3a825bb760787c62acc400f32774e54f6278b856822863fc5712178a:0]
2020-07-29 08:08:29.557 [INF] CRTR: Pruning channel graph using block 5b5e536555e0e2d40853253ca7efd62a274ca130605b6a02439b1ba54f9be922 (height=3279)
2020-07-29 08:08:29.559 [INF] LNWL: Marking unconfirmed transaction 36537c9c3a825bb760787c62acc400f32774e54f6278b856822863fc5712178a mined in block 3279
2020-07-29 08:08:29.559 [DBG] LNWL: Marked address bcrt1qd0je7vm4a6v7am2unkgkqqxz8y9u90mrvatj5g used
2020-07-29 08:08:29.560 [INF] CRTR: Block 5b5e536555e0e2d40853253ca7efd62a274ca130605b6a02439b1ba54f9be922 (height=3279) closed 0 channels
2020-07-29 08:08:29.561 [DBG] NTFN: Filtering 2 txns for 0 spend requests at height 3279
2020-07-29 08:08:29.561 [INF] NTFN: New block: height=3279, sha=5b5e536555e0e2d40853253ca7efd62a274ca130605b6a02439b1ba54f9be922
2020-07-29 08:08:29.562 [DBG] DISC: New block: height=3279, hash=5b5e536555e0e2d40853253ca7efd62a274ca130605b6a02439b1ba54f9be922
2020-07-29 08:08:29.562 [DBG] SWPR: New block: height=3279, sha=5b5e536555e0e2d40853253ca7efd62a274ca130605b6a02439b1ba54f9be922
2020-07-29 08:08:29.562 [INF] UTXN: Attempting to graduate height=3279: num_kids=0, num_babies=0
2020-07-29 08:08:29.564 [INF] CRTR: Pruning channel graph using block 6d590b1608a6f9baa44c56d9afd83a876aed0b02b296f503fb545a7e21e98c4e (height=3280)
2020-07-29 08:08:29.565 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3280
2020-07-29 08:08:29.565 [INF] NTFN: New block: height=3280, sha=6d590b1608a6f9baa44c56d9afd83a876aed0b02b296f503fb545a7e21e98c4e
2020-07-29 08:08:29.565 [DBG] SWPR: New block: height=3280, sha=6d590b1608a6f9baa44c56d9afd83a876aed0b02b296f503fb545a7e21e98c4e
2020-07-29 08:08:29.565 [INF] UTXN: Attempting to graduate height=3280: num_kids=0, num_babies=0
2020-07-29 08:08:29.565 [DBG] DISC: New block: height=3280, hash=6d590b1608a6f9baa44c56d9afd83a876aed0b02b296f503fb545a7e21e98c4e
2020-07-29 08:08:29.566 [INF] CRTR: Block 6d590b1608a6f9baa44c56d9afd83a876aed0b02b296f503fb545a7e21e98c4e (height=3280) closed 0 channels
2020-07-29 08:08:29.568 [INF] CRTR: Pruning channel graph using block 5208adbc1f1ce5779ec005e4cba8a6dce126c257d1479989ac7b73026b7cd8a7 (height=3281)
2020-07-29 08:08:29.570 [INF] CRTR: Block 5208adbc1f1ce5779ec005e4cba8a6dce126c257d1479989ac7b73026b7cd8a7 (height=3281) closed 0 channels
2020-07-29 08:08:29.570 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3281
2020-07-29 08:08:29.570 [INF] NTFN: New block: height=3281, sha=5208adbc1f1ce5779ec005e4cba8a6dce126c257d1479989ac7b73026b7cd8a7
2020-07-29 08:08:29.570 [DBG] DISC: New block: height=3281, hash=5208adbc1f1ce5779ec005e4cba8a6dce126c257d1479989ac7b73026b7cd8a7
2020-07-29 08:08:29.570 [DBG] SWPR: New block: height=3281, sha=5208adbc1f1ce5779ec005e4cba8a6dce126c257d1479989ac7b73026b7cd8a7
2020-07-29 08:08:29.570 [INF] UTXN: Attempting to graduate height=3281: num_kids=0, num_babies=0
2020-07-29 08:08:29.575 [INF] CRTR: Pruning channel graph using block 3527882b066f17b51004963720da53650711bc89030826a06d4a55039193ead7 (height=3282)
2020-07-29 08:08:29.576 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3282
2020-07-29 08:08:29.576 [INF] NTFN: New block: height=3282, sha=3527882b066f17b51004963720da53650711bc89030826a06d4a55039193ead7
2020-07-29 08:08:29.576 [DBG] DISC: New block: height=3282, hash=3527882b066f17b51004963720da53650711bc89030826a06d4a55039193ead7
2020-07-29 08:08:29.576 [DBG] SWPR: New block: height=3282, sha=3527882b066f17b51004963720da53650711bc89030826a06d4a55039193ead7
2020-07-29 08:08:29.576 [INF] UTXN: Attempting to graduate height=3282: num_kids=0, num_babies=0
2020-07-29 08:08:29.577 [INF] CRTR: Block 3527882b066f17b51004963720da53650711bc89030826a06d4a55039193ead7 (height=3282) closed 0 channels
2020-07-29 08:08:29.579 [INF] CRTR: Pruning channel graph using block 5828d470c7d428583a686a7b3cf507669a85c3f61ce2a0ea40f136aa3a6f461a (height=3283)
2020-07-29 08:08:29.581 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3283
2020-07-29 08:08:29.581 [INF] NTFN: New block: height=3283, sha=5828d470c7d428583a686a7b3cf507669a85c3f61ce2a0ea40f136aa3a6f461a
2020-07-29 08:08:29.581 [DBG] SWPR: New block: height=3283, sha=5828d470c7d428583a686a7b3cf507669a85c3f61ce2a0ea40f136aa3a6f461a
2020-07-29 08:08:29.581 [INF] UTXN: Attempting to graduate height=3283: num_kids=0, num_babies=0
2020-07-29 08:08:29.581 [DBG] DISC: New block: height=3283, hash=5828d470c7d428583a686a7b3cf507669a85c3f61ce2a0ea40f136aa3a6f461a
2020-07-29 08:08:29.582 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3284
2020-07-29 08:08:29.582 [INF] NTFN: New block: height=3284, sha=497c78f10e9ad0c7480ca9fc539742a4fb44033cfba395ca81201d96db8e72b1
2020-07-29 08:08:29.582 [DBG] DISC: New block: height=3284, hash=497c78f10e9ad0c7480ca9fc539742a4fb44033cfba395ca81201d96db8e72b1
2020-07-29 08:08:29.582 [DBG] SWPR: New block: height=3284, sha=497c78f10e9ad0c7480ca9fc539742a4fb44033cfba395ca81201d96db8e72b1
2020-07-29 08:08:29.582 [INF] UTXN: Attempting to graduate height=3284: num_kids=0, num_babies=0
2020-07-29 08:08:29.583 [INF] CRTR: Block 5828d470c7d428583a686a7b3cf507669a85c3f61ce2a0ea40f136aa3a6f461a (height=3283) closed 0 channels
2020-07-29 08:08:29.583 [INF] CRTR: Pruning channel graph using block 497c78f10e9ad0c7480ca9fc539742a4fb44033cfba395ca81201d96db8e72b1 (height=3284)
2020-07-29 08:08:29.584 [INF] CRTR: Block 497c78f10e9ad0c7480ca9fc539742a4fb44033cfba395ca81201d96db8e72b1 (height=3284) closed 0 channels
2020-07-29 08:08:29.601 [DBG] RPCS: [walletbalance] Total balance=1 BTC (confirmed=1 BTC, unconfirmed=0 BTC)
2020-07-29 08:08:29.623 [DBG] RPCS: [connectpeer] requested connection to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.623 [DBG] SRVR: Connecting to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.633 [INF] SRVR: Established connection to: 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.633 [INF] SRVR: Finalizing connection to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204, inbound=false
2020-07-29 08:08:29.634 [DBG] PRNF: PeerNotifier notifying peer: 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0 online
2020-07-29 08:08:29.634 [DBG] RPCS: Connected to peer: 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.634 [DBG] PEER: Sending Init to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.635 [DBG] PEER: Received Init from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.635 [DBG] PEER: Loaded 0 active channels from database with NodeKey(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0)
2020-07-29 08:08:29.635 [DBG] SRVR: Notifying that peer 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204 is online
2020-07-29 08:08:29.635 [INF] PEER: Negotiated chan series queries with 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0
2020-07-29 08:08:29.635 [INF] DISC: Creating new GossipSyncer for peer=02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0
2020-07-29 08:08:29.635 [DBG] DISC: Starting GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0)
2020-07-29 08:08:29.635 [DBG] DISC: Attempting initial historical sync with GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0)
2020-07-29 08:08:29.635 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): state=chansSynced, type=PassiveSync
2020-07-29 08:08:29.635 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): state=syncingChans, type=PassiveSync
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): requesting new chans from height=0 and 4294967295 blocks after
2020-07-29 08:08:29.636 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): state=waitingQueryRangeReply, type=PassiveSync
2020-07-29 08:08:29.635 [DBG] PEER: Received QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=4294967294) from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): filtering chan range: start_height=0, num_blocks=4294967295
2020-07-29 08:08:29.636 [DBG] PEER: Sending QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=4294967294) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): sending final chan range chunk, size=0
2020-07-29 08:08:29.636 [DBG] PEER: Sending ReplyChannelRange(start_height=0, end_height=4294967294, num_chans=0, encoding=0) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.636 [DBG] PEER: Received GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2020-07-29 08:08:29 +0000 UTC, stamp_range=4294967295) from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.636 [DBG] PEER: Received ReplyChannelRange(start_height=0, end_height=4294967294, num_chans=0, encoding=0) from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.636 [DBG] CHDB: ChanUpdatesInHorizon hit percentage: NaN (0/0)
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): applying new update horizon: start=2020-07-29 08:08:29 +0000 UTC, end=2156-09-04 14:36:44 +0000 UTC, backlog_size=0
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): buffering chan range reply of size=0
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): filtering through 0 chans
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): remote peer has no new chans
2020-07-29 08:08:29.636 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): state=chansSynced, type=PassiveSync
2020-07-29 08:08:29.636 [DBG] DISC: Initial historical sync completed
2020-07-29 08:08:29.636 [DBG] DISC: Attempting to transition 3 passive GossipSyncers to active
2020-07-29 08:08:29.636 [DBG] DISC: Transitioning passive GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0) to active
2020-07-29 08:08:29.636 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): transitioning from PassiveSync to ActiveSync
2020-07-29 08:08:29.636 [INF] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): applying gossipFilter(start=2020-07-29 08:08:29.636959006 +0000 UTC m=+4.390599023, end=2156-09-04 14:36:44.636959006 +0000 UTC m=+4294967299.390599023)
2020-07-29 08:08:29.636 [DBG] DISC: GossipSyncer(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): state=chansSynced, type=ActiveSync
2020-07-29 08:08:29.636 [DBG] PEER: Sending GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2020-07-29 08:08:29 +0000 UTC, stamp_range=4294967295) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.679 [DBG] RPCS: [listpeers] yielded [02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204] peers
2020-07-29 08:08:29.683 [DBG] RPCS: [openchannel] request to NodeKey(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0) allocation(us=16777216, them=0)
2020-07-29 08:08:29.683 [DBG] RPCS: [openchannel]: using fee of 12500 sat/kw for funding tx
2020-07-29 08:08:29.683 [INF] FNDG: Initiating fundingRequest(local_amt=0.16777216 BTC (subtract_fees=false), push_amt=0 mSAT, chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, peer=02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0, dust_limit=0.00000573 BTC, min_confs=1)
2020-07-29 08:08:29.683 [INF] CHFD: Performing funding tx coin selection using 12500 sat/kw as fee rate
2020-07-29 08:08:29.701 [INF] FNDG: Target commit tx sat/kw for pendingID(6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5): 12500
2020-07-29 08:08:29.701 [INF] FNDG: Starting funding workflow with 127.0.0.1:20204 for pending_id(6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5), committype=tweakless
2020-07-29 08:08:29.701 [DBG] PEER: Sending MsgOpenChannel(temp_chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5, chain=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, csv=4, amt=0.16777216 BTC, push_amt=0 mSAT, reserve=0.00167772 BTC, flags=1) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.704 [DBG] PEER: Received Error(chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5, err=channel too large) from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:29.704 [INF] FNDG: Cancelling funding reservation for node_key=02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0, chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5
2020-07-29 08:08:29.704 [ERR] FNDG: received funding error from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0: chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5, err=channel too large
2020-07-29 08:08:29.704 [ERR] RPCS: unable to open channel to NodeKey(02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0): received funding error from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0: chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5, err=channel too large
2020-07-29 08:08:29.704 [ERR] RPCS: [/lnrpc.Lightning/OpenChannel]: received funding error from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0: chan_id=6b001052f17f295b9b9838a1d97db69a0ad986471ad9380710b0e2a5254cd2f5, err=channel too large
2020-07-29 08:08:31.840 [DBG] RPCS: [connectpeer] requested connection to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.840 [DBG] SRVR: Connecting to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.845 [INF] SRVR: Established connection to: 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.845 [INF] SRVR: Finalizing connection to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208, inbound=false
2020-07-29 08:08:31.845 [DBG] PRNF: PeerNotifier notifying peer: 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 online
2020-07-29 08:08:31.845 [DBG] RPCS: Connected to peer: 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.845 [DBG] PEER: Sending Init to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.845 [DBG] PEER: Received Init from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.846 [DBG] PEER: Loaded 0 active channels from database with NodeKey(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999)
2020-07-29 08:08:31.846 [DBG] SRVR: Notifying that peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208 is online
2020-07-29 08:08:31.846 [INF] PEER: Negotiated chan series queries with 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:31.846 [INF] DISC: Creating new GossipSyncer for peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:31.846 [DBG] DISC: Starting GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999)
2020-07-29 08:08:31.846 [DBG] DISC: GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999): state=chansSynced, type=ActiveSync
2020-07-29 08:08:31.846 [INF] DISC: GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999): applying gossipFilter(start=2020-07-29 08:08:31.846162566 +0000 UTC m=+6.599802597, end=2156-09-04 14:36:46.846162566 +0000 UTC m=+4294967301.599802597)
2020-07-29 08:08:31.846 [DBG] PEER: Sending GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2020-07-29 08:08:31 +0000 UTC, stamp_range=4294967295) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.846 [DBG] PEER: Received QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=4294967294) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.846 [INF] DISC: GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999): filtering chan range: start_height=0, num_blocks=4294967295
2020-07-29 08:08:31.846 [INF] DISC: GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999): sending final chan range chunk, size=0
2020-07-29 08:08:31.846 [DBG] PEER: Sending ReplyChannelRange(start_height=0, end_height=4294967294, num_chans=0, encoding=0) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.847 [DBG] PEER: Received GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2020-07-29 08:08:31 +0000 UTC, stamp_range=4294967295) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.847 [DBG] CHDB: ChanUpdatesInHorizon hit percentage: NaN (0/0)
2020-07-29 08:08:31.847 [INF] DISC: GossipSyncer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999): applying new update horizon: start=2020-07-29 08:08:31 +0000 UTC, end=2156-09-04 14:36:46 +0000 UTC, backlog_size=0
2020-07-29 08:08:31.890 [DBG] RPCS: [listpeers] yielded [02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208] peers
2020-07-29 08:08:31.914 [DBG] RPCS: [openchannel] request to NodeKey(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999) allocation(us=16777216, them=0)
2020-07-29 08:08:31.914 [DBG] RPCS: [openchannel]: using fee of 12500 sat/kw for funding tx
2020-07-29 08:08:31.914 [INF] FNDG: Initiating fundingRequest(local_amt=0.16777216 BTC (subtract_fees=false), push_amt=0 mSAT, chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999, dust_limit=0.00000573 BTC, min_confs=1)
2020-07-29 08:08:31.914 [INF] CHFD: Performing funding tx coin selection using 12500 sat/kw as fee rate
2020-07-29 08:08:31.926 [INF] FNDG: Target commit tx sat/kw for pendingID(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984): 12500
2020-07-29 08:08:31.927 [INF] FNDG: Starting funding workflow with 127.0.0.1:20208 for pending_id(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984), committype=tweakless
2020-07-29 08:08:31.927 [DBG] PEER: Sending MsgOpenChannel(temp_chan_id=9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984, chain=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, csv=4, amt=0.16777216 BTC, push_amt=0 mSAT, reserve=0.00167772 BTC, flags=1) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.942 [DBG] PEER: Received MsgAcceptChannel(temp_chan_id=9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984, reserve=0.00167772 BTC, csv=4, num_confs=1) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.942 [INF] FNDG: Recv'd fundingResponse for pending_id(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984)
2020-07-29 08:08:31.943 [DBG] LNWL: Funding tx for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) generated: (*wire.MsgTx)(0xc000a9ec80)({
 Version: (int32) 2,
 TxIn: ([]*wire.TxIn) (len=1 cap=15) {
  (*wire.TxIn)(0xc0003d86c0)({
   PreviousOutPoint: (wire.OutPoint) 36537c9c3a825bb760787c62acc400f32774e54f6278b856822863fc5712178a:0,
   SignatureScript: ([]uint8) <nil>,
   Witness: (wire.TxWitness) (len=2 cap=2) {
    ([]uint8) (len=72 cap=144) {
     00000000  30 45 02 21 00 e9 1d ca  48 79 99 99 aa 47 7c 29  |0E.!....Hy...G|)|
     00000010  51 2f f7 e2 5d e6 a6 0d  75 b4 38 bf 38 82 a8 2e  |Q/..]...u.8.8...|
     00000020  f1 17 99 d3 97 02 20 30  84 4e b9 6e 52 00 fd a8  |...... 0.N.nR...|
     00000030  ba 50 41 2b 51 fc 46 c3  8e 23 5c 37 3d 64 e5 90  |.PA+Q.F..#\7=d..|
     00000040  52 2f 85 bb 2c 12 e5 01                           |R/..,...|
    },
    ([]uint8) (len=33 cap=33) {
     00000000  03 39 3c 76 b9 31 23 65  24 e9 a5 15 31 5c 2c f1  |.9<v.1#e$...1\,.|
     00000010  53 40 91 27 d2 63 7f c7  1a 2f 7b 8c 4b 96 dd f2  |S@.'.c.../{.K...|
     00000020  2f                                                |/|
    }
   },
   Sequence: (uint32) 0
  })
 },
 TxOut: ([]*wire.TxOut) (len=2 cap=15) {
  (*wire.TxOut)(0xc000ada7a0)({
   Value: (int64) 16777216,
   PkScript: ([]uint8) (len=34 cap=500) {
    00000000  00 20 6e 14 25 91 5f 8c  54 74 45 70 47 86 49 ea  |. n.%._.TtEpG.I.|
    00000010  f7 70 1c 8e 1e 75 3d b9  85 3f c0 ea 97 28 bf 20  |.p...u=..?...(. |
    00000020  41 9f                                             |A.|
   }
  }),
  (*wire.TxOut)(0xc000392000)({
   Value: (int64) 83215147,
   PkScript: ([]uint8) (len=22 cap=500) {
    00000000  00 14 15 ef 38 70 0a 69  79 db 16 ea 5f 0f a5 72  |....8p.iy..._..r|
    00000010  a6 79 c8 be c7 f7                                 |.y....|
   }
  })
 },
 LockTime: (uint32) 0
})

2020-07-29 08:08:31.944 [DBG] LNWL: Local commit tx for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): (*wire.MsgTx)(0xc000a9f640)({
 Version: (int32) 2,
 TxIn: ([]*wire.TxIn) (len=1 cap=15) {
  (*wire.TxIn)(0xc0003d8b40)({
   PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
   SignatureScript: ([]uint8) <nil>,
   Witness: (wire.TxWitness) <nil>,
   Sequence: (uint32) 2153152406
  })
 },
 TxOut: ([]*wire.TxOut) (len=1 cap=15) {
  (*wire.TxOut)(0xc000adba20)({
   Value: (int64) 16768166,
   PkScript: ([]uint8) (len=34 cap=500) {
    00000000  00 20 17 3d f2 95 a7 ad  fa 79 8b 28 b5 bf 21 cc  |. .=.....y.(..!.|
    00000010  dd 5c 5b b1 27 b7 45 9d  3e 57 06 f6 90 23 2a 67  |.\[.'.E.>W...#*g|
    00000020  d5 a5                                             |..|
   }
  })
 },
 LockTime: (uint32) 551270682
})

2020-07-29 08:08:31.944 [DBG] LNWL: Remote commit tx for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): (*wire.MsgTx)(0xc000a9f680)({
 Version: (int32) 2,
 TxIn: ([]*wire.TxIn) (len=1 cap=15) {
  (*wire.TxIn)(0xc0003d8ba0)({
   PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
   SignatureScript: ([]uint8) <nil>,
   Witness: (wire.TxWitness) <nil>,
   Sequence: (uint32) 2153152406
  })
 },
 TxOut: ([]*wire.TxOut) (len=1 cap=15) {
  (*wire.TxOut)(0xc000adba40)({
   Value: (int64) 16768166,
   PkScript: ([]uint8) (len=22 cap=500) {
    00000000  00 14 31 d5 c6 64 67 83  c3 c9 8b 1b 2c 8a 38 d7  |..1..dg.....,.8.|
    00000010  0d 90 7f b4 99 5e                                 |.....^|
   }
  })
 },
 LockTime: (uint32) 551270682
})

2020-07-29 08:08:31.945 [INF] FNDG: pendingChan(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984): remote party proposes num_confs=1, csv_delay=4
2020-07-29 08:08:31.946 [DBG] FNDG: Remote party accepted commitment constraints: (channeldb.ChannelConstraints) {
 DustLimit: (btcutil.Amount) 0.00000573 BTC,
 ChanReserve: (btcutil.Amount) 0.00167772 BTC,
 MaxPendingAmount: (lnwire.MilliSatoshi) 16609444000 mSAT,
 MinHTLC: (lnwire.MilliSatoshi) 1 mSAT,
 MaxAcceptedHtlcs: (uint16) 483,
 CsvDelay: (uint16) 4
}

2020-07-29 08:08:31.946 [DBG] FNDG: Creating chan barrier for ChanID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:31.946 [INF] FNDG: Generated ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) for pending_id(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984)
2020-07-29 08:08:31.946 [DBG] PEER: Sending MsgFundingCreated(temp_chan_id=9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984, chan_point=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.951 [DBG] PEER: Received MsgFundingSigned(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:31.954 [INF] FNDG: Broadcasting funding tx for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): 020000000001018a171257fc63288256b878624fe57427f300c4ac627c7860b75b823a9c7c53360000000000000000000200000001000000002200206e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f2bc3f5040000000016001415ef38700a6979db16ea5f0fa572a679c8bec7f702483045022100e91dca48799999aa477c29512ff7e25de6a60d75b438bf3882a82ef11799d397022030844eb96e5200fda8ba50412b51fc46c38e235c373d64e590522f85bb2c12e5012103393c76b931236524e9a515315c2cf153409127d2637fc71a2f7b8c4b96ddf22f00000000
2020-07-29 08:08:31.954 [INF] LNWL: Inserting unconfirmed transaction 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332
2020-07-29 08:08:31.954 [DBG] LNWL: Marked address bcrt1qzhhnsuq2d9uak9h2tu862u4x08yta3lhdsgjq7 used
2020-07-29 08:08:31.958 [INF] CNCT: Creating new ChannelArbitrator for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:31.958 [DBG] CNCT: New ChainEventSubscription(id=0) for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:31.958 [DBG] CNCT: Starting ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0), htlc_set=(map[contractcourt.HtlcSetKey]contractcourt.htlcSet) (len=2) {
 (contractcourt.HtlcSetKey) LocalHtlcSet: (contractcourt.htlcSet) {
  incomingHTLCs: (map[uint64]channeldb.HTLC) {
  },
  outgoingHTLCs: (map[uint64]channeldb.HTLC) {
  }
 },
 (contractcourt.HtlcSetKey) RemoteHtlcSet: (contractcourt.htlcSet) {
  incomingHTLCs: (map[uint64]channeldb.HTLC) {
  },
  outgoingHTLCs: (map[uint64]channeldb.HTLC) {
  }
 }
}

2020-07-29 08:08:31.958 [INF] NTFN: New block epoch subscription
2020-07-29 08:08:31.958 [DBG] LNWL: Marked address bcrt1qzhhnsuq2d9uak9h2tu862u4x08yta3lhdsgjq7 used
2020-07-29 08:08:31.959 [INF] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting state=StateDefault, trigger=chainTrigger, triggerHeight=3284
2020-07-29 08:08:31.959 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3284) examining active HTLC's
2020-07-29 08:08:31.959 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3284, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:31.959 [DBG] CNCT: Starting chain watcher for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:31.959 [INF] NTFN: New spend subscription: spend_id=1, outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f, height_hint=3284
2020-07-29 08:08:31.959 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3284) examining active HTLC's
2020-07-29 08:08:31.959 [INF] NTFN: Dispatching historical spend rescan for outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f, start=3284, end=3284
2020-07-29 08:08:31.959 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3284, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:31.960 [DBG] LNWL: Marked address bcrt1qzhhnsuq2d9uak9h2tu862u4x08yta3lhdsgjq7 used
2020-07-29 08:08:31.971 [DBG] NTFN: Updated spend hint to height=3284 for unconfirmed spend request outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f
2020-07-29 08:08:31.971 [INF] FNDG: Finalizing pending_id(9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984) over ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0), waiting for channel open on-chain
2020-07-29 08:08:31.971 [INF] NTFN: New confirmation subscription: conf_id=1, txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332, num_confs=1 height_hint=3284
2020-07-29 08:08:31.971 [DBG] NTFN: Dispatching historical confirmation rescan for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332
2020-07-29 08:08:31.971 [INF] FNDG: Waiting for funding tx (9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332) to reach 1 confirmations
2020-07-29 08:08:31.971 [INF] CNCT: Close observer for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) active
2020-07-29 08:08:31.971 [DBG] CHBU: Adding channel 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0 to backup state
2020-07-29 08:08:31.972 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=0, num_new_chans=1
2020-07-29 08:08:31.972 [DBG] NTFN: Confirmation details for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332 not found during historical dispatch, waiting to dispatch at tip
2020-07-29 08:08:31.974 [INF] CHBU: Updating backup file at /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:31.976 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:32.081 [INF] LNWL: Marking unconfirmed transaction 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332 mined in block 3285
2020-07-29 08:08:32.081 [DBG] LNWL: Marked address bcrt1qzhhnsuq2d9uak9h2tu862u4x08yta3lhdsgjq7 used
2020-07-29 08:08:32.082 [INF] CRTR: Pruning channel graph using block 49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4 (height=3285)
2020-07-29 08:08:32.088 [DBG] LNWL: Marked address bcrt1qzhhnsuq2d9uak9h2tu862u4x08yta3lhdsgjq7 used
2020-07-29 08:08:32.090 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3285
2020-07-29 08:08:32.090 [DBG] NTFN: Found initial confirmation of txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332: height=3285, hash=49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4
2020-07-29 08:08:32.101 [INF] CRTR: Block 49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4 (height=3285) closed 0 channels
2020-07-29 08:08:32.101 [INF] CRTR: Pruning channel graph using block 2201838db9c0b9fbc561df208b40ea46ead82c1a63df3574aa320afc2511760b (height=3286)
2020-07-29 08:08:32.104 [INF] CRTR: Block 2201838db9c0b9fbc561df208b40ea46ead82c1a63df3574aa320afc2511760b (height=3286) closed 0 channels
2020-07-29 08:08:32.110 [INF] CRTR: Pruning channel graph using block 1575ef21420e9ad1b09c504433c141b6f9df04165cca6cda3ed176aea2e54a0a (height=3287)
2020-07-29 08:08:32.112 [INF] CRTR: Block 1575ef21420e9ad1b09c504433c141b6f9df04165cca6cda3ed176aea2e54a0a (height=3287) closed 0 channels
2020-07-29 08:08:32.112 [INF] CRTR: Pruning channel graph using block 44da3d4ed43cb8eb37f9dcfa2b9f1edb1722a533d62a97c42290faadfdc8670c (height=3288)
2020-07-29 08:08:32.114 [INF] CRTR: Block 44da3d4ed43cb8eb37f9dcfa2b9f1edb1722a533d62a97c42290faadfdc8670c (height=3288) closed 0 channels
2020-07-29 08:08:32.114 [INF] CRTR: Pruning channel graph using block 40e4d5b0c0ac9ccfca682b632432adeb979525af2c77788756ec16b35a4c4610 (height=3289)
2020-07-29 08:08:32.115 [INF] CRTR: Block 40e4d5b0c0ac9ccfca682b632432adeb979525af2c77788756ec16b35a4c4610 (height=3289) closed 0 channels
2020-07-29 08:08:32.115 [INF] CRTR: Pruning channel graph using block 03086596c0729299c34ae5b260ca524e9081f56dd5c79b09480e47fbc271a056 (height=3290)
2020-07-29 08:08:32.117 [INF] CRTR: Block 03086596c0729299c34ae5b260ca524e9081f56dd5c79b09480e47fbc271a056 (height=3290) closed 0 channels
2020-07-29 08:08:32.122 [INF] NTFN: New block: height=3285, sha=49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4
2020-07-29 08:08:32.122 [INF] NTFN: Dispatching 1 confirmation notification for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332
2020-07-29 08:08:32.122 [DBG] SWPR: New block: height=3285, sha=49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4
2020-07-29 08:08:32.122 [INF] UTXN: Attempting to graduate height=3285: num_kids=0, num_babies=0
2020-07-29 08:08:32.122 [DBG] DISC: New block: height=3285, hash=49e63186bc6d0ffe574f4ba97c14fce2da12627aab2ca6ed093676ce517113b4
2020-07-29 08:08:32.122 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3285) examining active HTLC's
2020-07-29 08:08:32.122 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3285, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.122 [INF] FNDG: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) is now active: ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:32.122 [DBG] FNDG: ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) is now fully confirmed! (shortChanID=3285:1:0)
2020-07-29 08:08:32.124 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting local commitment: (*lnwallet.commitment)(0xc0001592c0)({
 height: (uint64) 0,
 isOurs: (bool) true,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000a9f640)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=15) {
   (*wire.TxIn)(0xc0003d8b40)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) <nil>,
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=15) {
   (*wire.TxOut)(0xc000adba20)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=34 cap=500) {
     00000000  00 20 17 3d f2 95 a7 ad  fa 79 8b 28 b5 bf 21 cc  |. .=.....y.(..!.|
     00000010  dd 5c 5b b1 27 b7 45 9d  3e 57 06 f6 90 23 2a 67  |.\[.'.E.>W...#*g|
     00000020  d5 a5                                             |..|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) (len=71 cap=71) {
  00000000  30 45 02 21 00 d4 25 8f  fd 43 97 14 fa 39 97 f1  |0E.!..%..C...9..|
  00000010  fa 3e 57 43 cc df 62 e3  1e c2 d9 9f e2 ef 84 72  |.>WC..b........r|
  00000020  03 df bf 08 82 02 20 04  68 90 22 35 a7 6b 10 b1  |...... .h."5.k..|
  00000030  6a 47 90 f1 a2 91 98 3a  62 05 c2 d2 36 6a 99 2a  |jG.....:b...6j.*|
  00000040  c1 f3 29 02 18 64 bc                              |..)..d.|
 },
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.126 [DBG] PEER: Received FundingLocked(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, next_point=022a4bda76c67ed744cd87b513b16e65967528acf481029d213669d4c2ef878841) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.126 [DBG] FNDG: Received FundingLocked for ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) from peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.127 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting remote commitment: (*lnwallet.commitment)(0xc000159380)({
 height: (uint64) 0,
 isOurs: (bool) false,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000a9f680)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=15) {
   (*wire.TxIn)(0xc0003d8ba0)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) <nil>,
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=15) {
   (*wire.TxOut)(0xc000adba40)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=22 cap=500) {
     00000000  00 14 31 d5 c6 64 67 83  c3 c9 8b 1b 2c 8a 38 d7  |..1..dg.....,.8.|
     00000010  0d 90 7f b4 99 5e                                 |.....^|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) <nil>,
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.127 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): Restoring 0 dangling remote updates
2020-07-29 08:08:32.127 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3286
2020-07-29 08:08:32.134 [ERR] FNDG: unable to report short chan id: link 3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398 not found
2020-07-29 08:08:32.134 [DBG] CHFT: Channel 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0 recording event: peer_online
2020-07-29 08:08:32.134 [DBG] CHBU: Adding channel 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0 to backup state
2020-07-29 08:08:32.134 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=1
2020-07-29 08:08:32.137 [WRN] CHBU: Replacing disk backup for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) w/ newer version
2020-07-29 08:08:32.138 [INF] CHBU: Updating backup file at /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:32.140 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:32.139 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting local commitment: (*lnwallet.commitment)(0xc00030d980)({
 height: (uint64) 0,
 isOurs: (bool) true,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000a9f640)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=15) {
   (*wire.TxIn)(0xc0003d8b40)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) <nil>,
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=15) {
   (*wire.TxOut)(0xc000adba20)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=34 cap=500) {
     00000000  00 20 17 3d f2 95 a7 ad  fa 79 8b 28 b5 bf 21 cc  |. .=.....y.(..!.|
     00000010  dd 5c 5b b1 27 b7 45 9d  3e 57 06 f6 90 23 2a 67  |.\[.'.E.>W...#*g|
     00000020  d5 a5                                             |..|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) (len=71 cap=71) {
  00000000  30 45 02 21 00 d4 25 8f  fd 43 97 14 fa 39 97 f1  |0E.!..%..C...9..|
  00000010  fa 3e 57 43 cc df 62 e3  1e c2 d9 9f e2 ef 84 72  |.>WC..b........r|
  00000020  03 df bf 08 82 02 20 04  68 90 22 35 a7 6b 10 b1  |...... .h."5.k..|
  00000030  6a 47 90 f1 a2 91 98 3a  62 05 c2 d2 36 6a 99 2a  |jG.....:b...6j.*|
  00000040  c1 f3 29 02 18 64 bc                              |..)..d.|
 },
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.141 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting local commitment: (*lnwallet.commitment)(0xc000159500)({
 height: (uint64) 0,
 isOurs: (bool) true,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000cc6440)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=1) {
   (*wire.TxIn)(0xc00097d080)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) {
    },
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=1) {
   (*wire.TxOut)(0xc000cbf760)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=34 cap=34) {
     00000000  00 20 17 3d f2 95 a7 ad  fa 79 8b 28 b5 bf 21 cc  |. .=.....y.(..!.|
     00000010  dd 5c 5b b1 27 b7 45 9d  3e 57 06 f6 90 23 2a 67  |.\[.'.E.>W...#*g|
     00000020  d5 a5                                             |..|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) (len=71 cap=71) {
  00000000  30 45 02 21 00 d4 25 8f  fd 43 97 14 fa 39 97 f1  |0E.!..%..C...9..|
  00000010  fa 3e 57 43 cc df 62 e3  1e c2 d9 9f e2 ef 84 72  |.>WC..b........r|
  00000020  03 df bf 08 82 02 20 04  68 90 22 35 a7 6b 10 b1  |...... .h."5.k..|
  00000030  6a 47 90 f1 a2 91 98 3a  62 05 c2 d2 36 6a 99 2a  |jG.....:b...6j.*|
  00000040  c1 f3 29 02 18 64 bc                              |..)..d.|
 },
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.142 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting remote commitment: (*lnwallet.commitment)(0xc0001595c0)({
 height: (uint64) 0,
 isOurs: (bool) false,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000cc6480)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=1) {
   (*wire.TxIn)(0xc00097d0e0)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) {
    },
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=1) {
   (*wire.TxOut)(0xc000cbf7a0)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=22 cap=22) {
     00000000  00 14 31 d5 c6 64 67 83  c3 c9 8b 1b 2c 8a 38 d7  |..1..dg.....,.8.|
     00000010  0d 90 7f b4 99 5e                                 |.....^|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) {
 },
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.143 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): Restoring 0 dangling remote updates
2020-07-29 08:08:32.143 [INF] PEER: New channel active ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) with NodeKey(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999)
2020-07-29 08:08:32.143 [DBG] CNCT: New ChainEventSubscription(id=1) for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:32.143 [INF] HSWC: Removing channel link with ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:32.143 [INF] HSWC: ChannelLink(3285:1:0): starting
2020-07-29 08:08:32.143 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): starting remote commitment: (*lnwallet.commitment)(0xc00030da40)({
 height: (uint64) 0,
 isOurs: (bool) false,
 ourMessageIndex: (uint64) 0,
 theirMessageIndex: (uint64) 0,
 ourHtlcIndex: (uint64) 0,
 theirHtlcIndex: (uint64) 0,
 txn: (*wire.MsgTx)(0xc000a9f680)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=15) {
   (*wire.TxIn)(0xc0003d8ba0)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) <nil>,
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=15) {
   (*wire.TxOut)(0xc000adba40)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=22 cap=500) {
     00000000  00 14 31 d5 c6 64 67 83  c3 c9 8b 1b 2c 8a 38 d7  |..1..dg.....,.8.|
     00000010  0d 90 7f b4 99 5e                                 |.....^|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 sig: ([]uint8) <nil>,
 ourBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 theirBalance: (lnwire.MilliSatoshi) 0 mSAT,
 fee: (btcutil.Amount) 0.0000905 BTC,
 feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw,
 dustLimit: (btcutil.Amount) 0.00000573 BTC,
 outgoingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCs: ([]lnwallet.PaymentDescriptor) <nil>,
 outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>,
 incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) <nil>
})

2020-07-29 08:08:32.143 [DBG] LNWL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): Restoring 0 dangling remote updates
2020-07-29 08:08:32.143 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0 has opening state 0
2020-07-29 08:08:32.143 [DBG] SRVR: Notifying that peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 is online
2020-07-29 08:08:32.143 [INF] FNDG: Peer(039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999) is online, sending FundingLocked for ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:32.143 [DBG] PEER: Sending FundingLocked(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, next_point=02ab0a4332356caf6f20ea9f01a3caa8013d2b1503bd357c437a532ad5f95661b6) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.144 [INF] NTFN: New block: height=3286, sha=2201838db9c0b9fbc561df208b40ea46ead82c1a63df3574aa320afc2511760b
2020-07-29 08:08:32.144 [INF] HSWC: Trimming open circuits for chan_id=3285:1:0, start_htlc_id=0
2020-07-29 08:08:32.144 [INF] HSWC: Adding live link chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, short_chan_id=3285:1:0
2020-07-29 08:08:32.144 [INF] CNCT: Attempting to update ContractSignals for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:32.144 [INF] HSWC: ChannelLink(3285:1:0): HTLC manager started, bandwidth=16598244000 mSAT
2020-07-29 08:08:32.144 [DBG] HSWC: ChannelLink(3285:1:0): loaded 0 fwd pks
2020-07-29 08:08:32.144 [DBG] SWPR: New block: height=3286, sha=2201838db9c0b9fbc561df208b40ea46ead82c1a63df3574aa320afc2511760b
2020-07-29 08:08:32.144 [DBG] DISC: New block: height=3286, hash=2201838db9c0b9fbc561df208b40ea46ead82c1a63df3574aa320afc2511760b
2020-07-29 08:08:32.144 [INF] UTXN: Attempting to graduate height=3286: num_kids=0, num_babies=0
2020-07-29 08:08:32.144 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3286) examining active HTLC's
2020-07-29 08:08:32.144 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3286, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.145 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3287
2020-07-29 08:08:32.145 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0: successfully sent FundingLocked
2020-07-29 08:08:32.145 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0 has opening state 1
2020-07-29 08:08:32.149 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000001, update_time=2020-07-29 08:08:32 +0000 UTC) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.150 [DBG] DISC: Got ChannelUpdate for edge not found in graph(shortChanID=3611895697309696), saving for reprocessing later
2020-07-29 08:08:32.153 [DBG] DISC: Reprocessing ChannelUpdate for shortChanID=3611895697309696
2020-07-29 08:08:32.155 [ERR] RPCS: [/lnrpc.Lightning/SubscribeChannelGraph]: rpc error: code = Internal desc = transport: transport: the stream is done or WriteHeader was already called
2020-07-29 08:08:32.156 [DBG] DISC: Requesting online notification for peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.156 [DBG] SRVR: Notifying that peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 is online
2020-07-29 08:08:32.156 [DBG] DISC: Peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 is now online, proceeding to send pending messages
2020-07-29 08:08:32.156 [DBG] DISC: Requesting offline notification for peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.156 [DBG] DISC: Successfully sent ChannelUpdate message for channel=3285:1:0 with peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 upon reconnection
2020-07-29 08:08:32.156 [INF] NTFN: New block: height=3287, sha=1575ef21420e9ad1b09c504433c141b6f9df04165cca6cda3ed176aea2e54a0a
2020-07-29 08:08:32.156 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000000, update_time=2020-07-29 08:08:32 +0000 UTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.156 [DBG] SWPR: New block: height=3287, sha=1575ef21420e9ad1b09c504433c141b6f9df04165cca6cda3ed176aea2e54a0a
2020-07-29 08:08:32.156 [INF] UTXN: Attempting to graduate height=3287: num_kids=0, num_babies=0
2020-07-29 08:08:32.156 [DBG] DISC: New block: height=3287, hash=1575ef21420e9ad1b09c504433c141b6f9df04165cca6cda3ed176aea2e54a0a
2020-07-29 08:08:32.156 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3287) examining active HTLC's
2020-07-29 08:08:32.156 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3287, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.157 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3288
2020-07-29 08:08:32.159 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0: successfully added to router graph
2020-07-29 08:08:32.159 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0 has opening state 2
2020-07-29 08:08:32.159 [DBG] FNDG: Will announce channel 3611895697309696 after ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) has gotten 6 confirmations
2020-07-29 08:08:32.159 [DBG] NTFN: Using height hint 3285 retrieved from cache for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332 instead of 3284
2020-07-29 08:08:32.159 [INF] NTFN: New confirmation subscription: conf_id=2, txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332, num_confs=6 height_hint=3285
2020-07-29 08:08:32.165 [DBG] PEER: Received AnnounceSignatures(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, short_chan_id=3611895697309696) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.165 [INF] DISC: Received new remote channel announcement for 3285:1:0
2020-07-29 08:08:32.166 [INF] DISC: 1/2 of channel ann proof received for short_chan_id=3611895697309696, waiting for other half
2020-07-29 08:08:32.169 [INF] NTFN: New block: height=3288, sha=44da3d4ed43cb8eb37f9dcfa2b9f1edb1722a533d62a97c42290faadfdc8670c
2020-07-29 08:08:32.169 [INF] UTXN: Attempting to graduate height=3288: num_kids=0, num_babies=0
2020-07-29 08:08:32.169 [DBG] DISC: New block: height=3288, hash=44da3d4ed43cb8eb37f9dcfa2b9f1edb1722a533d62a97c42290faadfdc8670c
2020-07-29 08:08:32.169 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3288) examining active HTLC's
2020-07-29 08:08:32.169 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3288, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.169 [DBG] NTFN: Attempting to dispatch confirmation for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332 on registration since rescan has finished
2020-07-29 08:08:32.169 [DBG] NTFN: Queueing 6 confirmation notification for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332 at tip 
2020-07-29 08:08:32.169 [DBG] SWPR: New block: height=3288, sha=44da3d4ed43cb8eb37f9dcfa2b9f1edb1722a533d62a97c42290faadfdc8670c
2020-07-29 08:08:32.169 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3289
2020-07-29 08:08:32.181 [DBG] RPCS: [listchannels] fetched 1 channels from DB
2020-07-29 08:08:32.181 [INF] NTFN: New block: height=3289, sha=40e4d5b0c0ac9ccfca682b632432adeb979525af2c77788756ec16b35a4c4610
2020-07-29 08:08:32.181 [DBG] SWPR: New block: height=3289, sha=40e4d5b0c0ac9ccfca682b632432adeb979525af2c77788756ec16b35a4c4610
2020-07-29 08:08:32.181 [DBG] DISC: New block: height=3289, hash=40e4d5b0c0ac9ccfca682b632432adeb979525af2c77788756ec16b35a4c4610
2020-07-29 08:08:32.181 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3289) examining active HTLC's
2020-07-29 08:08:32.181 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3289, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.181 [INF] UTXN: Attempting to graduate height=3289: num_kids=0, num_babies=0
2020-07-29 08:08:32.181 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3290
2020-07-29 08:08:32.193 [INF] NTFN: New block: height=3290, sha=03086596c0729299c34ae5b260ca524e9081f56dd5c79b09480e47fbc271a056
2020-07-29 08:08:32.193 [INF] NTFN: Dispatching 6 confirmation notification for txid=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332
2020-07-29 08:08:32.193 [INF] FNDG: Announcing ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0), short_chan_id=3285:1:0
2020-07-29 08:08:32.193 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3290) examining active HTLC's
2020-07-29 08:08:32.193 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3290, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.193 [INF] UTXN: Attempting to graduate height=3290: num_kids=0, num_babies=0
2020-07-29 08:08:32.193 [DBG] SWPR: New block: height=3290, sha=03086596c0729299c34ae5b260ca524e9081f56dd5c79b09480e47fbc271a056
2020-07-29 08:08:32.193 [DBG] DISC: New block: height=3290, hash=03086596c0729299c34ae5b260ca524e9081f56dd5c79b09480e47fbc271a056
2020-07-29 08:08:32.196 [INF] DISC: Received new local channel announcement for 3285:1:0
2020-07-29 08:08:32.203 [DBG] CRTR: New graph topology client subscription, client 3
2020-07-29 08:08:32.204 [DBG] RPCS: [listchannels] fetched 1 channels from DB
2020-07-29 08:08:32.207 [DBG] DISC: Successfully sent AnnounceSignatures message for channel=3285:1:0 with peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.207 [DBG] PEER: Sending AnnounceSignatures(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, short_chan_id=3611895697309696) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.211 [INF] DISC: Fully valid channel proof for short_chan_id=3611895697309696 constructed, adding to next ann batch
2020-07-29 08:08:32.211 [DBG] DISC: Unable to fetch node announcement for 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999: node does not have node announcement
2020-07-29 08:08:32.212 [INF] DISC: Broadcasting 4 new announcements in 1 sub batches
2020-07-29 08:08:32.212 [DBG] PEER: Sending ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.212 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000000, update_time=2020-07-29 08:08:32 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.214 [DBG] FNDG: Channel with ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0), short_chan_id=3285:1:0 announced
2020-07-29 08:08:32.214 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.214 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.214 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.214 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.214 [DBG] PEER: Sending ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.215 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000000, update_time=2020-07-29 08:08:32 +0000 UTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.215 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000001, update_time=2020-07-29 08:08:32 +0000 UTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.215 [DBG] FNDG: Channel(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398) with ShortChanID 3285:1:0: successfully announced
2020-07-29 08:08:32.215 [DBG] FNDG: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) with chan_id=9090059de4e79af640e81bb1c466fefec7c6b8407b38622e5a97ff32aed2e984 not found in opening database, assuming already announced to the network
2020-07-29 08:08:32.216 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000001, update_time=2020-07-29 08:08:32 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.225 [DBG] RPCS: [listchannels] fetched 1 channels from DB
2020-07-29 08:08:32.238 [DBG] PEER: Received NodeAnnouncement(node=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999, update_time=2020-07-29 08:08:32 +0000 UTC) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.247 [DBG] RPCS: Target sat/kw for closing transaction: 12500
2020-07-29 08:08:32.247 [DBG] HSWC: Requesting local channel close: peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208, chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398
2020-07-29 08:08:32.247 [INF] PEER: Local close channel request delivered to peer: [3 157 228 197 211 107 76 134 48 148 137 248 142 8 28 119 75 20 222 91 180 15 226 27 10 223 47 56 98 175 32 9 153]
2020-07-29 08:08:32.249 [INF] PEER: Delivery addr for channel close: bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75
2020-07-29 08:08:32.249 [INF] CHCL: Ideal fee for closure of ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) is: 9050 sat
2020-07-29 08:08:32.249 [INF] CHCL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): initiating shutdown
2020-07-29 08:08:32.250 [INF] NANN: Announcing channel(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) disabled [requested]
2020-07-29 08:08:32.253 [INF] HSWC: Removing channel link with ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:32.253 [INF] HSWC: ChannelLink(3285:1:0): stopping
2020-07-29 08:08:32.253 [INF] HSWC: ChannelLink(3285:1:0): exited
2020-07-29 08:08:32.255 [INF] CHCL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): sending shutdown message
2020-07-29 08:08:32.255 [DBG] PEER: Sending Shutdown(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, script=0014c2f65ab7c09f2683aeea2efd38105d018b7bfe55) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.262 [INF] DISC: Broadcasting 3 new announcements in 1 sub batches
2020-07-29 08:08:32.262 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000010, update_time=2020-07-29 08:08:33 +0000 UTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.262 [DBG] PEER: Sending NodeAnnouncement(node=02ae2832bda769f06c752417120d7f53d542fc32d4744e88f7f42f118f9d57d465, update_time=2020-07-29 08:08:32 +0000 UTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.262 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000010, update_time=2020-07-29 08:08:33 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.262 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.262 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.262 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.262 [DBG] PEER: Sending NodeAnnouncement(node=02ae2832bda769f06c752417120d7f53d542fc32d4744e88f7f42f118f9d57d465, update_time=2020-07-29 08:08:32 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.263 [DBG] PEER: Sending NodeAnnouncement(node=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999, update_time=2020-07-29 08:08:32 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.265 [DBG] PEER: Received Shutdown(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, script=0014386db62bb98ab90efe3410c5e07e9a0c1df64659) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.265 [INF] CHCL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): shutdown response received, entering fee negotiation
2020-07-29 08:08:32.267 [INF] CHCL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): proposing fee of 9050 sat to close chan
2020-07-29 08:08:32.267 [DBG] PEER: Sending ClosingSigned(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, fee_sat=0.0000905 BTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.274 [INF] LNWL: Inserting unconfirmed transaction 2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083
2020-07-29 08:08:32.274 [DBG] LNWL: Marked address bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75 used
2020-07-29 08:08:32.275 [DBG] PEER: Received ClosingSigned(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, fee_sat=0.0000905 BTC) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.275 [INF] CHCL: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) fee of 0.0000905 BTC accepted, ending negotiation
2020-07-29 08:08:32.276 [DBG] LNWL: Marked address bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75 used
2020-07-29 08:08:32.277 [INF] CHCL: Broadcasting cooperative close tx: (*wire.MsgTx)(0xc000e0c280)({
 Version: (int32) 2,
 TxIn: ([]*wire.TxIn) (len=1 cap=15) {
  (*wire.TxIn)(0xc000e02540)({
   PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
   SignatureScript: ([]uint8) <nil>,
   Witness: (wire.TxWitness) (len=4 cap=4) {
    ([]uint8) <nil>,
    ([]uint8) (len=71 cap=144) {
     00000000  30 44 02 20 56 60 62 59  17 06 e2 43 e5 ae 08 4d  |0D. V`bY...C...M|
     00000010  26 04 39 42 16 72 c9 08  c1 db 33 0c 42 77 66 74  |&.9B.r....3.Bwft|
     00000020  e6 d3 da 54 02 20 0d a0  f8 c3 87 43 49 fa 2f 3d  |...T. .....CI./=|
     00000030  64 f6 25 45 6d d4 aa 1f  f7 84 6a f5 ca 31 5c 87  |d.%Em.....j..1\.|
     00000040  98 98 f0 4c 78 d0 01                              |...Lx..|
    },
    ([]uint8) (len=72 cap=144) {
     00000000  30 45 02 21 00 d1 3b bb  d5 77 d2 61 09 bc 99 09  |0E.!..;..w.a....|
     00000010  01 b6 10 10 59 c9 50 55  0a a1 ec 87 4b 25 aa f2  |....Y.PU....K%..|
     00000020  80 7d 23 3d f1 02 20 7e  07 5e 03 bf 56 31 b2 67  |.}#=.. ~.^..V1.g|
     00000030  07 ed 93 2c 34 03 49 96  4a 52 a5 52 53 b7 21 0c  |...,4.I.JR.RS.!.|
     00000040  92 2b 05 07 69 4b 12 01                           |.+..iK..|
    },
    ([]uint8) (len=71 cap=500) {
     00000000  52 21 03 06 53 8d c1 70  14 47 cd 74 0d 0a e5 48  |R!..S..p.G.t...H|
     00000010  a4 a8 47 23 3f f5 e8 2c  c5 fc 57 1e e3 c4 06 43  |..G#?..,..W....C|
     00000020  59 05 57 21 03 d3 66 70  67 7d 8d e9 1c fe 95 a5  |Y.W!..fpg}......|
     00000030  93 f5 f3 de 46 d4 b1 18  46 6c 27 11 8a a5 ee b0  |....F...Fl'.....|
     00000040  89 da 0a 83 bc 52 ae                              |.....R.|
    }
   },
   Sequence: (uint32) 4294967295
  })
 },
 TxOut: ([]*wire.TxOut) (len=1 cap=15) {
  (*wire.TxOut)(0xc000e0a3c0)({
   Value: (int64) 16768166,
   PkScript: ([]uint8) (len=22 cap=500) {
    00000000  00 14 c2 f6 5a b7 c0 9f  26 83 ae ea 2e fd 38 10  |....Z...&.....8.|
    00000010  5d 01 8b 7b fe 55                                 |]..{.U|
   }
  })
 },
 LockTime: (uint32) 0
})

2020-07-29 08:08:32.278 [DBG] LNWL: Marked address bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75 used
2020-07-29 08:08:32.280 [INF] HSWC: Removing channel link with ChannelID(3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398)
2020-07-29 08:08:32.280 [DBG] PEER: Sending ClosingSigned(chan_id=3273e5023af73cba0d13f7c6440f04c398563001d6b499e99b45fa54e1bd1398, fee_sat=0.0000905 BTC) to 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.280 [INF] PEER: Waiting for confirmation of cooperative close of ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) with txid: 2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083
2020-07-29 08:08:32.280 [INF] NTFN: New confirmation subscription: conf_id=3, txid=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083, num_confs=1 height_hint=3290
2020-07-29 08:08:32.280 [DBG] NTFN: Dispatching historical confirmation rescan for txid=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083
2020-07-29 08:08:32.280 [DBG] NTFN: Confirmation details for txid=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083 not found during historical dispatch, waiting to dispatch at tip
2020-07-29 08:08:32.288 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000011, update_time=2020-07-29 08:08:33 +0000 UTC) from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.312 [INF] DISC: Broadcasting 1 new announcements in 1 sub batches
2020-07-29 08:08:32.312 [DBG] SRVR: Broadcasting 1 messages
2020-07-29 08:08:32.312 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=3611895697309696, mflags=00000001, cflags=00000011, update_time=2020-07-29 08:08:33 +0000 UTC) to 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.325 [DBG] RPCS: [listchannels] fetched 0 channels from DB
2020-07-29 08:08:32.326 [DBG] RPCS: [pendingchannels]
2020-07-29 08:08:32.387 [INF] LNWL: Marking unconfirmed transaction 2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083 mined in block 3291
2020-07-29 08:08:32.389 [INF] CRTR: Pruning channel graph using block 42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee (height=3291)
2020-07-29 08:08:32.389 [INF] CHDB: Pruned unconnected node 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 from channel graph
2020-07-29 08:08:32.389 [INF] CHDB: Pruned 1 unconnected nodes from the channel graph
2020-07-29 08:08:32.390 [DBG] LNWL: Marked address bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75 used
2020-07-29 08:08:32.390 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3291
2020-07-29 08:08:32.390 [DBG] NTFN: Found spend of outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f: spend_tx=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083, block_height=3291
2020-07-29 08:08:32.390 [DBG] NTFN: Spend request outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f spent at tip=3291
2020-07-29 08:08:32.390 [DBG] NTFN: Found initial confirmation of txid=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083: height=3291, hash=42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee
2020-07-29 08:08:32.391 [INF] CRTR: Block 42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee (height=3291) closed 1 channels
2020-07-29 08:08:32.391 [DBG] LNWL: Marked address bcrt1qctm94d7qnung8th29m7nsyzaqx9hhlj4c9sp75 used
2020-07-29 08:08:32.413 [INF] NTFN: New block: height=3291, sha=42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee
2020-07-29 08:08:32.413 [INF] NTFN: Dispatching 1 confirmation notification for txid=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083
2020-07-29 08:08:32.413 [INF] NTFN: Dispatching confirmed spend notification for outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f at current height=3291: 2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083[0] spending 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0 at height=3291
2020-07-29 08:08:32.413 [DBG] NTFN: Found spend of outpoint=9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0, script=0 6e1425915f8c54744570478649eaf7701c8e1e753db9853fc0ea9728bf20419f: spend_tx=2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083, block_height=3291
2020-07-29 08:08:32.413 [DBG] SWPR: New block: height=3291, sha=42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee
2020-07-29 08:08:32.413 [INF] UTXN: Attempting to graduate height=3291: num_kids=0, num_babies=0
2020-07-29 08:08:32.413 [DBG] DISC: New block: height=3291, hash=42ed4852c153c5e3f7981beb22cb3a701b5d14d56733f05a1a0a59f98bafe1ee
2020-07-29 08:08:32.413 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3291) examining active HTLC's
2020-07-29 08:08:32.413 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3291, in_htlc_count=0, out_htlc_count=0
2020-07-29 08:08:32.413 [INF] PEER: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) is now closed at height 3291
2020-07-29 08:08:32.413 [INF] RPCS: [closechannel] close completed: txid(2d307fc2052bedba56d208018083080882c54bc15921ec7a171b02a38d634083)
2020-07-29 08:08:32.413 [DBG] CNCT: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): local_commit_type=2, local_commit=(*channeldb.ChannelCommitment)(0xc000b0e170)({
 CommitHeight: (uint64) 0,
 LocalLogIndex: (uint64) 0,
 LocalHtlcIndex: (uint64) 0,
 RemoteLogIndex: (uint64) 0,
 RemoteHtlcIndex: (uint64) 0,
 LocalBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 RemoteBalance: (lnwire.MilliSatoshi) 0 mSAT,
 CommitFee: (btcutil.Amount) 0.0000905 BTC,
 FeePerKw: (btcutil.Amount) 0.000125 BTC,
 CommitTx: (*wire.MsgTx)(0xc000f8c2c0)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=1) {
   (*wire.TxIn)(0xc000e03a40)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) {
    },
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=1) {
   (*wire.TxOut)(0xc000f8e420)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=34 cap=34) {
     00000000  00 20 17 3d f2 95 a7 ad  fa 79 8b 28 b5 bf 21 cc  |. .=.....y.(..!.|
     00000010  dd 5c 5b b1 27 b7 45 9d  3e 57 06 f6 90 23 2a 67  |.\[.'.E.>W...#*g|
     00000020  d5 a5                                             |..|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 CommitSig: ([]uint8) (len=71 cap=71) {
  00000000  30 45 02 21 00 d4 25 8f  fd 43 97 14 fa 39 97 f1  |0E.!..%..C...9..|
  00000010  fa 3e 57 43 cc df 62 e3  1e c2 d9 9f e2 ef 84 72  |.>WC..b........r|
  00000020  03 df bf 08 82 02 20 04  68 90 22 35 a7 6b 10 b1  |...... .h."5.k..|
  00000030  6a 47 90 f1 a2 91 98 3a  62 05 c2 d2 36 6a 99 2a  |jG.....:b...6j.*|
  00000040  c1 f3 29 02 18 64 bc                              |..)..d.|
 },
 Htlcs: ([]channeldb.HTLC) <nil>
})

2020-07-29 08:08:32.414 [DBG] CNCT: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): remote_commit_type=2, remote_commit=(*channeldb.ChannelCommitment)(0xc000b0e1f0)({
 CommitHeight: (uint64) 0,
 LocalLogIndex: (uint64) 0,
 LocalHtlcIndex: (uint64) 0,
 RemoteLogIndex: (uint64) 0,
 RemoteHtlcIndex: (uint64) 0,
 LocalBalance: (lnwire.MilliSatoshi) 16768166000 mSAT,
 RemoteBalance: (lnwire.MilliSatoshi) 0 mSAT,
 CommitFee: (btcutil.Amount) 0.0000905 BTC,
 FeePerKw: (btcutil.Amount) 0.000125 BTC,
 CommitTx: (*wire.MsgTx)(0xc000f8c300)({
  Version: (int32) 2,
  TxIn: ([]*wire.TxIn) (len=1 cap=1) {
   (*wire.TxIn)(0xc000e03aa0)({
    PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
    SignatureScript: ([]uint8) {
    },
    Witness: (wire.TxWitness) <nil>,
    Sequence: (uint32) 2153152406
   })
  },
  TxOut: ([]*wire.TxOut) (len=1 cap=1) {
   (*wire.TxOut)(0xc000f8e460)({
    Value: (int64) 16768166,
    PkScript: ([]uint8) (len=22 cap=22) {
     00000000  00 14 31 d5 c6 64 67 83  c3 c9 8b 1b 2c 8a 38 d7  |..1..dg.....,.8.|
     00000010  0d 90 7f b4 99 5e                                 |.....^|
    }
   })
  },
  LockTime: (uint32) 551270682
 }),
 CommitSig: ([]uint8) {
 },
 Htlcs: ([]channeldb.HTLC) <nil>
})

2020-07-29 08:08:32.415 [INF] CNCT: Cooperative closure for ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): (*wire.MsgTx)(0xc000dc9ec0)({
 Version: (int32) 2,
 TxIn: ([]*wire.TxIn) (len=1 cap=1) {
  (*wire.TxIn)(0xc000e83560)({
   PreviousOutPoint: (wire.OutPoint) 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0,
   SignatureScript: ([]uint8) {
   },
   Witness: (wire.TxWitness) (len=4 cap=4) {
    ([]uint8) {
    },
    ([]uint8) (len=71 cap=71) {
     00000000  30 44 02 20 56 60 62 59  17 06 e2 43 e5 ae 08 4d  |0D. V`bY...C...M|
     00000010  26 04 39 42 16 72 c9 08  c1 db 33 0c 42 77 66 74  |&.9B.r....3.Bwft|
     00000020  e6 d3 da 54 02 20 0d a0  f8 c3 87 43 49 fa 2f 3d  |...T. .....CI./=|
     00000030  64 f6 25 45 6d d4 aa 1f  f7 84 6a f5 ca 31 5c 87  |d.%Em.....j..1\.|
     00000040  98 98 f0 4c 78 d0 01                              |...Lx..|
    },
    ([]uint8) (len=72 cap=72) {
     00000000  30 45 02 21 00 d1 3b bb  d5 77 d2 61 09 bc 99 09  |0E.!..;..w.a....|
     00000010  01 b6 10 10 59 c9 50 55  0a a1 ec 87 4b 25 aa f2  |....Y.PU....K%..|
     00000020  80 7d 23 3d f1 02 20 7e  07 5e 03 bf 56 31 b2 67  |.}#=.. ~.^..V1.g|
     00000030  07 ed 93 2c 34 03 49 96  4a 52 a5 52 53 b7 21 0c  |...,4.I.JR.RS.!.|
     00000040  92 2b 05 07 69 4b 12 01                           |.+..iK..|
    },
    ([]uint8) (len=71 cap=71) {
     00000000  52 21 03 06 53 8d c1 70  14 47 cd 74 0d 0a e5 48  |R!..S..p.G.t...H|
     00000010  a4 a8 47 23 3f f5 e8 2c  c5 fc 57 1e e3 c4 06 43  |..G#?..,..W....C|
     00000020  59 05 57 21 03 d3 66 70  67 7d 8d e9 1c fe 95 a5  |Y.W!..fpg}......|
     00000030  93 f5 f3 de 46 d4 b1 18  46 6c 27 11 8a a5 ee b0  |....F...Fl'.....|
     00000040  89 da 0a 83 bc 52 ae                              |.....R.|
    }
   },
   Sequence: (uint32) 4294967295
  })
 },
 TxOut: ([]*wire.TxOut) (len=1 cap=1) {
  (*wire.TxOut)(0xc000ed9f40)({
   Value: (int64) 16768166,
   PkScript: ([]uint8) (len=22 cap=22) {
    00000000  00 14 c2 f6 5a b7 c0 9f  26 83 ae ea 2e fd 38 10  |....Z...&.....8.|
    00000010  5d 01 8b 7b fe 55                                 |]..{.U|
   }
  })
 },
 LockTime: (uint32) 0
})

2020-07-29 08:08:32.415 [INF] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) marking channel cooperatively closed
2020-07-29 08:08:32.417 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): new block (height=3291) examining active HTLC's
2020-07-29 08:08:32.417 [DBG] CNCT: ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0): checking commit chain actions at height=3291, in_htlc_count=0, out_htlc_count=0
yeee: *bdb.db
2020-07-29 08:08:32.417 [DBG] CHBU: Removing channel 9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0 from backup state
2020-07-29 08:08:32.417 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=0
2020-07-29 08:08:32.420 [INF] CHBU: Updating backup file at /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:32.422 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node937599969/data/chain/bitcoin/regtest/channel.backup
2020-07-29 08:08:32.428 [INF] CNCT: ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) has been fully resolved on-chain at height=3291
2020-07-29 08:08:32.428 [INF] CNCT: Marking ChannelPoint(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0) fully resolved
2020-07-29 08:08:32.429 [INF] CHDB: Pruning link node 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 with zero open channels from database
2020-07-29 08:08:32.430 [DBG] CNCT: Stopping ChannelArbitrator(9813bde154fa459be999b4d601305698c3040f44c6f7130dba3cf73a02e57332:0)
2020-07-29 08:08:32.434 [DBG] RPCS: [pendingchannels]
2020-07-29 08:08:32.438 [INF] PEER: unable to read message from 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208: EOF
2020-07-29 08:08:32.438 [INF] PEER: disconnecting 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208, reason: read handler closed
2020-07-29 08:08:32.539 [DBG] SRVR: Peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208 has been disconnected
2020-07-29 08:08:32.539 [DBG] FNDG: Cancelling all reservations for peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.539 [DBG] FNDG: No active reservations for node: 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.539 [INF] DISC: Removing GossipSyncer for peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.539 [DBG] SRVR: Notifying that peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208 is offline
2020-07-29 08:08:32.539 [DBG] SRVR: removing peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208
2020-07-29 08:08:32.539 [DBG] PRNF: PeerNotifier notifying peer: 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999 offline
2020-07-29 08:08:32.539 [DBG] SRVR: Scheduling connection re-establishment to persistent peer 039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999@127.0.0.1:20208 in 1s
2020-07-29 08:08:32.539 [DBG] DISC: Requesting online notification for peer=039de4c5d36b4c86309489f88e081c774b14de5bb40fe21b0adf2f3862af200999
2020-07-29 08:08:32.543 [INF] PEER: unable to read message from 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204: EOF
2020-07-29 08:08:32.543 [INF] PEER: disconnecting 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204, reason: read handler closed
2020-07-29 08:08:32.643 [DBG] SRVR: Peer 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204 has been disconnected
2020-07-29 08:08:32.643 [DBG] FNDG: Cancelling all reservations for peer 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0
2020-07-29 08:08:32.643 [DBG] FNDG: No active reservations for node: 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0
2020-07-29 08:08:32.643 [INF] DISC: Removing GossipSyncer for peer=02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0
2020-07-29 08:08:32.643 [DBG] SRVR: Notifying that peer 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204 is offline
2020-07-29 08:08:32.643 [DBG] SRVR: removing peer 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0@127.0.0.1:20204
2020-07-29 08:08:32.644 [DBG] PRNF: PeerNotifier notifying peer: 02cda6890622ab65f456a5f88340664d9e22d1e8a7766cad3479730c88dbb4b8e0 offline
2020-07-29 08:08:32.646 [INF] LTND: Received shutdown request.
2020-07-29 08:08:32.646 [INF] LTND: Shutting down...
2020-07-29 08:08:32.646 [INF] LTND: Gracefully shutting down.
2020-07-29 08:08:32.647 [INF] CRTR: FilteredChainView stopping
2020-07-29 08:08:32.647 [INF] HSWC: HTLC Switch shutting down
2020-07-29 08:08:32.647 [INF] HSWC: Block epoch canceled, decaying hash log shutting down
2020-07-29 08:08:32.649 [INF] UTXN: UTXO nursery shutting down
2020-07-29 08:08:32.649 [INF] BRAR: Breach arbiter shutting down
2020-07-29 08:08:32.649 [INF] DISC: Authenticated Gossiper is stopping
2020-07-29 08:08:32.649 [INF] CNCT: Stopping ChainArbitrator
2020-07-29 08:08:32.649 [DBG] SWPR: Sweeper shutting down
2020-07-29 08:08:32.649 [DBG] SWPR: Sweeper shut down
2020-07-29 08:08:32.649 [INF] PRNF: Stopping PeerNotifier
2020-07-29 08:08:32.649 [INF] FNDG: Funding manager shutting down
2020-07-29 08:08:32.649 [INF] CHBU: Stopping chanbackup.SubSwapper
2020-07-29 08:08:32.649 [INF] CHFT: Stopping event store
2020-07-29 08:08:32.650 [INF] RPCS: Stopping RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping SignRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping AutopilotRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping VersionRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping WatchtowerClientRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping RouterRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping ChainRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping InvoicesRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping WalletKitRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] RPCS: Stopping WatchtowerRPC Sub-RPC Server
2020-07-29 08:08:32.650 [INF] LTND: Shutdown complete