Git Product home page Git Product logo

Comments (21)

gabridome avatar gabridome commented on July 28, 2024 2

After having changed the port. It works pretty much perfectly!!!

Thank you so much! and thanks to @greenaddress too for the new PR.

from electrs.

romanz avatar romanz commented on July 28, 2024

@gabridome could you please attach the full log of the error (using https://asciinema.org if possible)?

from electrs.

romanz avatar romanz commented on July 28, 2024

I'll also add a flag for logging Electrum client requests, for debugging this issue.

from electrs.

gabridome avatar gabridome commented on July 28, 2024

Maybe it could be useful to know that I'm running Electrum 3.2 and that it now subscribes to raw block headers (I don't know if this is related https://github.com/spesmilo/electrum/pull/4402/files).

I attach the log file because I prefer not to share the cookie details (asciinema doesn't allow to edit the recording).


~/electrs$ cargo run --release -- -vvv --timestamp --db-dir ./db --cookie=xxxxxxxxxxxxxx:yyyyyyyyyyyyyyyyyyyyyy > electrs.log  2>&1 &

~/electrs$ cat electrs.log

    Finished release [optimized] target(s) in 3.36s
     Running `target/release/electrs -vvv --timestamp --db-dir ./db '--cookie='`
Config { log: StdErrLog { verbosity: Debug, quiet: false, timestamp: Millisecond, modules: [], writer: "stderr", color_choice: Auto }, network_type: Mainnet, db_path: "./db/mainnet", daemon_dir: "/home/bitcoin/.bitcoin", cookie: "xxxxxxxxxxxxxx:yyyyyyyyyyyyyyyyyyyyyy", rpc_addr: V4(127.0.0.1:50001), monitoring_addr: V4(127.0.0.1:42024) }
2018-07-13T10:03:44.453+02:00 - DEBUG - Server listening on 127.0.0.1:42024
2018-07-13T10:03:44.480+02:00 - DEBUG - BlockchainInfo { chain: "main", blocks: 531732, headers: 531732, bestblockhash: "000000000000000000238a949225330bb00f838705da7e1cbec6e17d715182a1", size_on_disk: 236373184673, pruned: false }
2018-07-13T10:03:44.480+02:00 - DEBUG - opening "./db/mainnet" with StoreOptions { bulk_import: true }
2018-07-13T10:03:44.496+02:00 - DEBUG - Running accept thread
2018-07-13T10:04:21.080+02:00 - DEBUG - opening "./db/mainnet" with StoreOptions { bulk_import: false }
2018-07-13T10:04:35.288+02:00 - DEBUG - applying 456000 new headers from height 0
2018-07-13T10:04:35.676+02:00 - DEBUG - downloading new block headers (456000 already indexed) from 000000000000000000238a949225330bb00f838705da7e1cbec6e17d715182a1
2018-07-13T10:04:54.746+02:00 - INFO - best=000000000000000000238a949225330bb00f838705da7e1cbec6e17d715182a1 height=531732 @ 2018-07-13T07:54:06Z (75733 left to index)
thread 'fetcher' panicked at 'failed sending blocks to be indexed: "SendError(..)"', libcore/result.rs:945:5
note: Run with `RUST_BACKTRACE=1` for a backtrace.
2018-07-13T11:16:57.471+02:00 - ERROR - server failed: Error: RPC failed: [{"method":"getblock","params":["000000000000000000e75aa57b9f2eab7e0f50fe81753270d5a51d46c0a38143",false]},{"method":"getblock","params":["000000000000000000f920e40cdbdc89d6fc25a1ea5e0d87e11da7b5fa58c98d",false]},{"method":"getblock","params":["000000000000000000d98bd582654279b71edbc22a8c17a5deb733b739c19fb8",false]},{"method":"getblock","params":["000000000000000001282fa5803cc332552a23d65adcc114fe5bc6802beb9793",false]},{"method":"getblock","params":["0000000000000000003760b441f30cc3209065412accd501858d891c5461e1f8",false]},{"method":"getblock","params":["000000000000000001200b24d43d92315ec62b922618f50c44ad9b3ffb9c5ddd",false]},{"method":"getblock","params":["000000000000000001685d0edeae5441a02930178d8f2eae32a76828341d9f83",false]},{"method":"getblock","params":["000000000000000000a7417019e15a2570c7e6af023e7bf2a4e026e9b32ee8d0",false]},{"method":"getblock","params":["0000000000000000013e7ffa420802109d2fa274489018344fc686c3395ae717",false]},{"method":"getblock","params":["000000000000000001200736fcb73c3d02dcbc2994751a1e90f08974076bf61e",false]},{"method":"getblock","params":["00000000000000000145b13d0b6f7a213545a11e24c7140fa2347cc60cc7f932",false]},{"method":"getblock","params":["00000000000000000123dce6ac4f955af6c2f0c9f2ab4585405e823b89a8d528",false]},{"method":"getblock","params":["000000000000000000b4c2988ce57f6d164716d4e4f2d812e3f1330a5cc39084",false]},{"method":"getblock","params":["000000000000000000033611654edd5c0d4c3d81ab10ae993cab46f8bea9cc04",false]},{"method":"getblock","params":["0000000000000000003386cccf8456e57741e483e131aebc1476efcc95094a54",false]},{"method":"getblock","params":["00000000000000000045221939d923ca7872b4237c7c45886a445d9573a2c3fc",false]},{"method":"getblock","params":["0000000000000000004421bd0a6d849c54f0d29a433ff121353aa8684f7c3fc5",false]},{"method":"getblock","params":["0000000000000000003d89a2e737706305b408313163fabb8d0b9c099e9c2b1c",false]},{"method":"getblock","params":["0000000000000000015a2a28d367d16f6482df0aad3da5538eb4deabe5dbc952",false]},{"method":"getblock","params":["0000000000000000011878b129384abfc4e04d3c8b50534219772b324bbee85a",false]},{"method":"getblock","params":["00000000000000000033ea141ca13f5b067fd83acdcea3c977d9bcc69d0d8c38",false]},{"method":"getblock","params":["000000000000000000e9c0de9c696b7d7801ebb49879107d7b54888ce53f78d0",false]},{"method":"getblock","params":["00000000000000000059a78c30e5c6b1a2b999868fee6676ec75da2f2437b54c",false]},{"method":"getblock","params":["000000000000000000ccdcc2247bae0f4ad0fbe125c9dd5f46f96f77dc891ae9",false]},{"method":"getblock","params":["00000000000000000002749089df7b6ee80f5cd5a41c8e64316c1a7e067273fe",false]},{"method":"getblock","params":["0000000000000000011094e2e3f61b7e298aa53d8d05ca6bdd17d4eb55c61f23",false]},{"method":"getblock","params":["000000000000000000a4ac36d1240f6cfa293f04485fe32adb9d707e3450fd3b",false]},{"method":"getblock","params":["0000000000000000010154e31aa0ef1cd2ceb17c818c676e5d1f185ae4047d1d",false]},{"method":"getblock","params":["000000000000000000288fd707ce7761662274f3aef87a0c129c39a839e19ee1",false]},{"method":"getblock","params":["00000000000000000128c2921028ca019542781faa25e1d8acf511c817636574",false]},{"method":"getblock","params":["0000000000000000001846c581195191d25456461b64222fda692c18749e14e1",false]},{"method":"getblock","params":["000000000000000000601b3ecf7ace8805708d8e7f1f10c3c0514cc062bdf7a5",false]},{"method":"getblock","params":["000000000000000000ae36d1ffd7e8f898382fcaa17d7dae8075b330cc5ff614",false]},{"method":"getblock","params":["00000000000000000061231f8728268e206ed16935de8ca43cf2acdbce3b8eae",false]},{"method":"getblock","params":["0000000000000000006fad920832bb017abfb6462ea60650619be255218a1e14",false]},{"method":"getblock","params":["0000000000000000007fd7d76e50426edcd34494eda7318565f1570c76631baa",false]},{"method":"getblock","params":["0000000000000000008dbda38a29ec6403510357c4a0dcdde0b2cb9112f099c5",false]},{"method":"getblock","params":["000000000000000000592686e302fe2241848e739b0be817b7c9fe663e4e3f63",false]},{"method":"getblock","params":["000000000000000000e14e810b11e13cfecfdfd34f37e6b3c1534fd30c334cd7",false]},{"method":"getblock","params":["00000000000000000037a07e724eba7bea5499c8b5dd045ddd3ae778c5309475",false]},{"method":"getblock","params":["000000000000000000c1882b97de4af1e67bd649782e7590d2c682badba1c1ac",false]},{"method":"getblock","params":["0000000000000000015d3d64d4cb567a89eab5d6bc15bc559b5272c17403f76a",false]},{"method":"getblock","params":["000000000000000000ccb94f7ecc9bbfe43cc2e1ee66e425bf1f74f6517f2d02",false]},{"method":"getblock","params":["000000000000000000a54fb25886168143ed0aef8174e25ddcebd48769cd9b5d",false]},{"method":"getblock","params":["000000000000000000751ba48150b62552640fb1e0eb197f3a3e69e6f5a9d2df",false]},{"method":"getblock","params":["00000000000000000052e8d0976e7af2792aa4046d79d07dff5e630234247957",false]},{"method":"getblock","params":["0000000000000000005d7a721ca27b114f1c1153f2350e144bc7db533446e808",false]},{"method":"getblock","params":["00000000000000000134fa27c2b8c059b868388e6708a176197910c6961d250d",false]},{"method":"getblock","params":["0000000000000000006b9de38c333eb294c42d70ea9d7730924f72d27d86d0d7",false]},{"method":"getblock","params":["0000000000000000015349f14b3ca48350b7e5598729277cd785bbd785960de9",false]},{"method":"getblock","params":["0000000000000000017d11f4d443ad90115e80efc2e644bde48a4d0dc83dd62c",false]},{"method":"getblock","params":["000000000000000000a827901b8f119e1dc14a8ecf367996b0d0d922c68287c2",false]},{"method":"getblock","params":["000000000000000000b8c4dce8ee6956f2137ef34d3d46633ada38583626bb81",false]},{"method":"getblock","params":["00000000000000000049a53deb5be627ad3384fbaa98c9cf1d1ac0d2c91b8483",false]},{"method":"getblock","params":["00000000000000000108e1c72eb245bd5d96ccd178dc3d3800e003657fa6a0bf",false]},{"method":"getblock","params":["0000000000000000006488b41c1593cc022e249e8ca89dd2dc35babe6a234254",false]},{"method":"getblock","params":["000000000000000000f570118271be4a5c8e2991ebb7504b9fb7d792da25ce4c",false]},{"method":"getblock","params":["000000000000000000a84534ca386364917b3fba3f0c1b0c22cc7c5f998b5671",false]},{"method":"getblock","params":["000000000000000000212062813cecacd3596697e6276cccf58049163f2fdb86",false]},{"method":"getblock","params":["000000000000000000ebee93107d5d13efc7e2f6f68844ff379db8361efa026a",false]},{"method":"getblock","params":["0000000000000000006738d26d61dfa2020379104d55d5e77a3b5ae90fe34787",false]},{"method":"getblock","params":["000000000000000000f5fe5eac7fd595af972191439f607ba74c1047fbe3ae43",false]},{"method":"getblock","params":["000000000000000000b827cf78c5b75336d1a128f794adc78e84d2c017b7b2be",false]},{"method":"getblock","params":["00000000000000000030a269e5c0250e4632f9d2ec0fffdf45db3584b3bd574d",false]},{"method":"getblock","params":["000000000000000000fd309d4f09b2ef5d3e8561dbcf105bb3b3c997cea9f35c",false]},{"method":"getblock","params":["0000000000000000015f21956d30a1948fd634fc10923effb016bcf110f13695",false]},{"method":"getblock","params":["000000000000000000d893dc8ecb2701d2a48831b50cdab4974862a5303797c5",false]},{"method":"getblock","params":["000000000000000000a2a0d684d040b7c56ec8365f0dc689ef1e0aef758837ae",false]},{"method":"getblock","params":["0000000000000000001a0c51fb9e3198cc28afc8c80f91de2d8ff52f34ab7a86",false]},{"method":"getblock","params":["00000000000000000030374aea05dd03908c5ed0cd64a97f1b4b1f9c3133b674",false]},{"method":"getblock","params":["0000000000000000007f0b26fe8f0aa0f5c5d575710781561c8afbef9aa55862",false]},{"method":"getblock","params":["000000000000000000925475dadfd79722827f99c410f678ed44d7338f262cb3",false]},{"method":"getblock","params":["00000000000000000180209a9abf4d987c88a7620f4567a197f107cbf294e5c6",false]},{"method":"getblock","params":["000000000000000001602a0f954abc2f49a83e8694d60dcf278472485b43befc",false]},{"method":"getblock","params":["0000000000000000008d89bf09e2c226d82cc76d0e2558282fa749371c98a0d0",false]},{"method":"getblock","params":["000000000000000000ec033915d6765887b8c0917d1a2b582ca8a66e452d5cb7",false]},{"method":"getblock","params":["000000000000000000449c6c30c6471f97615395abf911420d962f6de6cb1a8b",false]},{"method":"getblock","params":["0000000000000000004094e7976dfb8fa95b5b81cac18c971af6449f9cd18162",false]},{"method":"getblock","params":["00000000000000000008abc86fa8b6edee00ad26f43e47d9bde22c467b9a576f",false]},{"method":"getblock","params":["0000000000000000010838ea2a43c47adf2089938ad7c1d5425aaa6f3d0faa5e",false]},{"method":"getblock","params":["0000000000000000008f6debb9c06bcb4c6c98ecd026e0a764a795dd8d05f59b",false]},{"method":"getblock","params":["0000000000000000008fc8e54677e294bd3c6763d03cac28e37f19679ab951b2",false]},{"method":"getblock","params":["000000000000000000b3ca83f007088fdf3f0aae7e3f75b77abde8666fa8d2bb",false]},{"method":"getblock","params":["000000000000000000767b261f7bcf8728a2c00ea6a89a1e1891df5d7ec214c2",false]},{"method":"getblock","params":["0000000000000000018922b354c545da2ed2e8dcd0b806986a53d41be76fe6e9",false]},{"method":"getblock","params":["000000000000000000b6bd19b5ac329ecff8c20a77dbece7ad20a4f4319f5ca8",false]},{"method":"getblock","params":["00000000000000000056720a8ed842f188508139286123c7001b38abb31ed6df",false]},{"method":"getblock","params":["0000000000000000014d7372095a88d6cfaef5c61d9dbce8e89262cda8daa9b5",false]},{"method":"getblock","params":["0000000000000000011b4388c963e00878d3a213f82614ce47ce91ba188bc1bb",false]},{"method":"getblock","params":["0000000000000000007196127aa9ae5a3f65b9bdf5b03ef0fcc2d90d8b323541",false]},{"method":"getblock","params":["0000000000000000015e439f601a21bb0dae5e57ce171dcf9e85574e8fb5a37b",false]},{"method":"getblock","params":["00000000000000000036a66f2b90c8c8f5d97189f89aefa740e7d172ea258f88",false]},{"method":"getblock","params":["00000000000000000147bed4a529873d6a1d6bdddcebb1d5bd8f059a28461644",false]},{"method":"getblock","params":["0000000000000000002d50c9f7f5ca6b2525e23ff5786d6e536d1234f66aac32",false]},{"method":"getblock","params":["0000000000000000008ae8abb2222ae44778cf6cfc6f74b5dfcb38462abb11b5",false]},{"method":"getblock","params":["0000000000000000016ce1b7e44fa5b4b3cee7658139bb77811c3d6081b71e55",false]},{"method":"getblock","params":["0000000000000000003c76481f152c778e127bdab56cad7d66e275981a75f9e9",false]},{"method":"getblock","params":["0000000000000000008970767ffd9714f356054130cd4f5e0a05328415bfe70c",false]},{"method":"getblock","params":["0000000000000000002a0df1fd38a1d6c160a54eeb5958a8db599a9c826c76d6",false]},{"method":"getblock","params":["00000000000000000090cb458ac482029c4881ba35143bb8d59af0f5d8e5acf9",false]}]
Caused by: no status

from electrs.

romanz avatar romanz commented on July 28, 2024

Thanks!
From the error message, it seems that the bitcoind connection is closed, causing blocks' download to fail.

from electrs.

romanz avatar romanz commented on July 28, 2024

I think that it is safe to restart the server in this case, so it would make progress.
Could you please run it again, now with RUST_BACKTRACE=1 (in case there will be more panics) and with higher log verbosity (-vvvv)?

from electrs.

romanz avatar romanz commented on July 28, 2024

Maybe it could be useful to know that I'm running Electrum 3.2

I've tested the server with the latest Electrum version (3.2.2, from spesmilo/electrum@f8ee203) and it seems to work correctly.
Do you still get the "stream did not contain valid UTF-8" error?

from electrs.

romanz avatar romanz commented on July 28, 2024

P.S.
I'd also suggest using the latest version of electrs; since #15, the initial indexing should take <2h - so please try to run it over a new DB directory, using --db-dir ./new-db

from electrs.

gabridome avatar gabridome commented on July 28, 2024

here the relevant details of last crash:

2018-07-15T02:46:33.130+02:00 - TRACE - indexed "/home/bitcoin/.bitcoin/blocks/blk01314.dat": 1296111 rows
2018-07-15T02:46:42.980+02:00 - TRACE - indexed "/home/bitcoin/.bitcoin/blocks/blk01315.dat": 1303393 rows
2018-07-15T02:46:48.364+02:00 - DEBUG - no more blocks to index
2018-07-15T02:46:48.364+02:00 - TRACE - indexed "/home/bitcoin/.bitcoin/blocks/blk01316.dat": 1417299 rows
2018-07-15T02:46:52.997+02:00 - DEBUG - skipping block 0000000000000000000af3a3ab4a4f27989112869117b279f26c216a95753cae
2018-07-15T02:46:52.998+02:00 - DEBUG - skipping block 000000000000000000178159c09e4ae685789a3781532164c64c95b5c54e4ef5
2018-07-15T02:46:52.999+02:00 - DEBUG - skipping block 000000000000000000152010586d590290b50de430d34eddff2d1e3e378c63a3
2018-07-15T02:46:53.001+02:00 - DEBUG - skipping block 000000000000000000108023b38ce720d2519ff6baac4d8de8f994f4674e3e2f
2018-07-15T02:46:53.002+02:00 - DEBUG - skipping block 00000000000000000033c43a9dd05842eba2da7559cad11f1a6031709f82c91e
2018-07-15T02:46:53.004+02:00 - DEBUG - skipping block 000000000000000000341d06be33e8f61efd3f9b4d4b94aa279ba625932c6ff9
2018-07-15T02:46:53.006+02:00 - DEBUG - skipping block 0000000000000000002a7b8031f428df318fa569264aabba58f7ff9c75dd2451
2018-07-15T02:46:53.008+02:00 - DEBUG - skipping block 00000000000000000028a8d939fce369f57f34bb699720977ea97beb6c04d20d
2018-07-15T02:46:53.009+02:00 - DEBUG - skipping block 0000000000000000000491711949d918304c9ae31dc173b2c82f2dec619df0fa
2018-07-15T02:46:53.011+02:00 - DEBUG - skipping block 00000000000000000013c211dd6e6d94108e27c6bc19d7ddbfd0948a080b576c
2018-07-15T02:46:53.013+02:00 - DEBUG - skipping block 00000000000000000009c56000cafb0d96cc68f97e7b83554292bc32a57a6cb0
2018-07-15T02:46:53.013+02:00 - DEBUG - skipping block 0000000000000000003119187a7b815ef10f6847ec437a3875512f945a283bba
2018-07-15T02:46:53.016+02:00 - DEBUG - skipping block 0000000000000000000a8eea5c0fb56092606c6189ef56ea4d2ac1b98c2fe72f
2018-07-15T02:46:53.017+02:00 - DEBUG - skipping block 000000000000000000075aca039f2c691639db8a7f9b71b8aeda08badf98e2de
2018-07-15T02:46:53.019+02:00 - DEBUG - skipping block 0000000000000000002213d0fb9cb66240869d952f98843558894447562c9bab
2018-07-15T02:46:53.021+02:00 - DEBUG - skipping block 00000000000000000032e854553157a22c9fbacfbfb071864b93df63c2ccd409
2018-07-15T02:46:53.021+02:00 - DEBUG - skipping block 000000000000000000241d9895c1025be792a6904ee3478f7c1fa76059f2e8a0
2018-07-15T02:46:54.681+02:00 - DEBUG - no more blocks to index
2018-07-15T02:46:54.681+02:00 - TRACE - indexed "/home/bitcoin/.bitcoin/blocks/blk01317.dat": 982483 rows
2018-07-15T02:46:55.952+02:00 - DEBUG - last indexed block: best=0000000000000000001ee65a358378e88de81f3303c3ed8922923da76ac9528c height=531938 @ 2018-07-14T21:28:19Z
2018-07-15T02:46:56.147+02:00 - INFO - starting full compaction
2018-07-15T04:59:06.801+02:00 - INFO - finished full compaction
2018-07-15T05:00:51.041+02:00 - DEBUG - applying 531939 new headers from height 0
2018-07-15T05:00:51.604+02:00 - DEBUG - downloading new block headers (531939 already indexed) from 0000000000000000002c18161bd065cdf9aea4e20e200ee1d11b3d563bdcadb5
2018-07-15T05:00:51.606+02:00 - TRACE - downloaded 0000000000000000002c18161bd065cdf9aea4e20e200ee1d11b3d563bdcadb5 block header
2018-07-15T05:00:51.607+02:00 - TRACE - downloaded 0000000000000000002a00b22bc3001a5c17e2dfbd6dbe6c9a81635dc68b4d71 block header
2018-07-15T05:00:51.607+02:00 - TRACE - downloaded 00000000000000000018782ad6b3cd8d080a72b58e139344a4de9a5ff6797f74 block header
2018-07-15T05:00:51.608+02:00 - TRACE - downloaded 000000000000000000097874682de791bdecd8add33919da4be4b366b1424729 block header
2018-07-15T05:00:51.608+02:00 - TRACE - downloaded 000000000000000000273528f9fce9f2dab9ec572dc904be42062eca94cb5a43 block header
2018-07-15T05:00:51.609+02:00 - TRACE - downloaded 0000000000000000000f06f57b6a780210b7f8956716b437af40ad1392eab90e block header
2018-07-15T05:00:51.610+02:00 - TRACE - downloaded 00000000000000000019bdea6860b21f5acb1bd12b5d3d3d0bafd337629ec316 block header
2018-07-15T05:00:51.610+02:00 - TRACE - downloaded 0000000000000000000f2f2132d3bccfabbd11d5c42d04379842a46a5ca7633a block header
2018-07-15T05:00:51.610+02:00 - TRACE - downloaded 00000000000000000002236fdfdbbe473122bd5ddef892a747f0b3d50db1052f block header
2018-07-15T05:00:51.611+02:00 - TRACE - downloaded 000000000000000000241d9895c1025be792a6904ee3478f7c1fa76059f2e8a0 block header
2018-07-15T05:00:51.612+02:00 - TRACE - downloaded 00000000000000000032e854553157a22c9fbacfbfb071864b93df63c2ccd409 block header
2018-07-15T05:00:51.612+02:00 - TRACE - downloaded 0000000000000000002213d0fb9cb66240869d952f98843558894447562c9bab block header
2018-07-15T05:00:51.613+02:00 - TRACE - downloaded 000000000000000000075aca039f2c691639db8a7f9b71b8aeda08badf98e2de block header
2018-07-15T05:00:51.613+02:00 - TRACE - downloaded 0000000000000000000a8eea5c0fb56092606c6189ef56ea4d2ac1b98c2fe72f block header
2018-07-15T05:00:51.614+02:00 - TRACE - downloaded 0000000000000000003119187a7b815ef10f6847ec437a3875512f945a283bba block header
2018-07-15T05:00:51.614+02:00 - TRACE - downloaded 00000000000000000009c56000cafb0d96cc68f97e7b83554292bc32a57a6cb0 block header
2018-07-15T05:00:51.614+02:00 - TRACE - downloaded 00000000000000000013c211dd6e6d94108e27c6bc19d7ddbfd0948a080b576c block header
2018-07-15T05:00:51.615+02:00 - TRACE - downloaded 0000000000000000000491711949d918304c9ae31dc173b2c82f2dec619df0fa block header
2018-07-15T05:00:51.615+02:00 - TRACE - downloaded 00000000000000000028a8d939fce369f57f34bb699720977ea97beb6c04d20d block header
2018-07-15T05:00:51.615+02:00 - TRACE - downloaded 0000000000000000002a7b8031f428df318fa569264aabba58f7ff9c75dd2451 block header
2018-07-15T05:00:51.616+02:00 - TRACE - downloaded 000000000000000000341d06be33e8f61efd3f9b4d4b94aa279ba625932c6ff9 block header
2018-07-15T05:00:51.616+02:00 - TRACE - downloaded 00000000000000000033c43a9dd05842eba2da7559cad11f1a6031709f82c91e block header
2018-07-15T05:00:51.616+02:00 - TRACE - downloaded 000000000000000000108023b38ce720d2519ff6baac4d8de8f994f4674e3e2f block header
2018-07-15T05:00:51.617+02:00 - TRACE - downloaded 000000000000000000152010586d590290b50de430d34eddff2d1e3e378c63a3 block header
2018-07-15T05:00:51.617+02:00 - TRACE - downloaded 000000000000000000178159c09e4ae685789a3781532164c64c95b5c54e4ef5 block header
2018-07-15T05:00:51.617+02:00 - TRACE - downloaded 0000000000000000000af3a3ab4a4f27989112869117b279f26c216a95753cae block header
2018-07-15T05:00:51.618+02:00 - INFO - best=0000000000000000002c18161bd065cdf9aea4e20e200ee1d11b3d563bdcadb5 height=531964 @ 2018-07-15T02:40:00Z (26 left to index)
2018-07-15T05:00:59.503+02:00 - DEBUG - applying 26 new headers from height 531939
2018-07-15T05:00:59.534+02:00 - TRACE - closing DB
2018-07-15T05:01:00.224+02:00 - ERROR - server failed: Error: failed to update mempool from daemon
Caused by: RPC failed: {"method":"getrawmempool","params":[false]}
Caused by: disconnected from daemon
stack backtrace:
   0:     0x55a58500f96c - backtrace::backtrace::trace::hd402417859783b40
   1:     0x55a58500efc2 - backtrace::capture::Backtrace::new_unresolved::hce1354e135c2f28e
   2:     0x55a58500e897 - error_chain::backtrace::imp::InternalBacktrace::new::habdd565038f6f85c
   3:     0x55a58500ec04 - <error_chain::State as core::default::Default>::default::hee976682d00eb04c
   4:     0x55a584fe29d5 - <core::option::Option<T> as electrs::errors::ResultExt<T>>::chain_err::he86d5244c2fb9016
   5:     0x55a584f439f7 - electrs::daemon::Daemon::call_jsonrpc::he1590ae21e77a3d8
   6:     0x55a584f4452b - electrs::daemon::Daemon::request::h2a3f07a1273cf39c
   7:     0x55a584f46d77 - electrs::daemon::Daemon::getmempooltxids::h586de0322bbacc1c
   8:     0x55a584f8c592 - electrs::mempool::Tracker::update::h9ba4bdd928b3816f
   9:     0x55a584f5687b - electrs::query::Query::update_mempool::h5eb8efaaf290c970
  10:     0x55a584f3e696 - electrs::main::hb7893ebc8a38666e
  11:     0x55a584f398c2 - std::rt::lang_start::{{closure}}::h825937f5b6ee0646
  12:     0x55a585440902 - std::rt::lang_start_internal::{{closure}}::h342eaeec3a520255
                        at libstd/rt.rs:59
                         - std::panicking::try::do_call::h8b090b6144a018fb
                        at libstd/panicking.rs:310
  13:     0x55a58545e869 - __rust_maybe_catch_panic
                        at libpanic_unwind/lib.rs:105
  14:     0x55a585447df5 - std::panicking::try::h11349d7f0dce3b3c
                        at libstd/panicking.rs:289
                         - std::panic::catch_unwind::hfbb0f172d1ed4df2
                        at libstd/panic.rs:374
                         - std::rt::lang_start_internal::h6c73689767a9401e
                        at libstd/rt.rs:58
  15:     0x55a584f3ede3 - main
  16:     0x7fb3828e882f - __libc_start_main
  17:     0x55a584f37888 - _start
  18:                0x0 - <unknown>

After the restart:

    Finished release [optimized] target(s) in 4.24s
     Running `target/release/electrs -vvvv --timestamp --db-dir ./new-db '--cookie=vahth1IX:aiphau1EEk6lah5o'`
Config { log: StdErrLog { verbosity: Trace, quiet: false, timestamp: Millisecond, modules: [], writer: "stderr", color_choice: Auto }, network_type: Mainnet, db_path: "./new-db/mainnet", daemon_dir: "/home/bitcoin/.bitcoin", cookie: "vahth1IX:aiphau1EEk6lah5o", rpc_addr: V4(127.0.0.1:50001), monitoring_addr: V4(127.0.0.1:42024) }
2018-07-15T07:28:25.782+02:00 - DEBUG - Server listening on 127.0.0.1:42024
2018-07-15T07:28:25.786+02:00 - DEBUG - BlockchainInfo { chain: "main", blocks: 531982, headers: 531982, bestblockhash: "0000000000000000001e01d834dc72ce35be96727cd40bb08a7c186a7ab04ef0", size_on_disk: 236696120949, pruned: false }
2018-07-15T07:28:25.790+02:00 - DEBUG - Running accept thread
2018-07-15T07:28:25.797+02:00 - DEBUG - NetworkInfo { version: 160100, subversion: "/Satoshi:0.16.1/" }
2018-07-15T07:28:25.797+02:00 - DEBUG - opening DB at "./new-db/mainnet"
2018-07-15T07:28:58.245+02:00 - DEBUG - applying 531965 new headers from height 0
2018-07-15T07:28:58.828+02:00 - DEBUG - downloading new block headers (531965 already indexed) from 0000000000000000001e01d834dc72ce35be96727cd40bb08a7c186a7ab04ef0
2018-07-15T07:28:58.829+02:00 - TRACE - downloaded 0000000000000000001e01d834dc72ce35be96727cd40bb08a7c186a7ab04ef0 block header
2018-07-15T07:28:58.830+02:00 - TRACE - downloaded 0000000000000000002337949e5107b68ec86c1332bcd154c58e85707e159f19 block header
2018-07-15T07:28:58.830+02:00 - TRACE - downloaded 0000000000000000001ab87a4f8652715058cccdd3a19c3916b827964322d764 block header
2018-07-15T07:28:58.831+02:00 - TRACE - downloaded 00000000000000000013be3d990cdca29ddae892d62685abab88d9c06ab9925c block header
2018-07-15T07:28:58.831+02:00 - TRACE - downloaded 0000000000000000000e59d4a6b71008315d436c7c700da199a240a39bed4321 block header
2018-07-15T07:28:58.832+02:00 - TRACE - downloaded 0000000000000000002284798efc672de5c338392ecf7d60925239db3cc4b40b block header
2018-07-15T07:28:58.832+02:00 - TRACE - downloaded 0000000000000000002040580a759f5368ae31f20149a3ebc46d1b29060ca497 block header
2018-07-15T07:28:58.833+02:00 - TRACE - downloaded 0000000000000000002a191b0816ae90e5f60bc98fee3930ef88f9b6ea9e77cd block header
2018-07-15T07:28:58.833+02:00 - TRACE - downloaded 00000000000000000026ade0f9f3302cbd9783a1313f630eae7d95f142349103 block header
2018-07-15T07:28:58.833+02:00 - TRACE - downloaded 0000000000000000002cd49d814613483efa73ac725e2fb164310865c1b925c6 block header
2018-07-15T07:28:58.834+02:00 - TRACE - downloaded 00000000000000000014105b7f22976164f3c2b4a53c965307e82782501eb3b4 block header
2018-07-15T07:28:58.834+02:00 - TRACE - downloaded 00000000000000000024fb83671d996476283709f03e3c166f7fef40470a9807 block header
2018-07-15T07:28:58.835+02:00 - TRACE - downloaded 0000000000000000001510cd0979ea602a14c121223db9216c01fe48d44d0d1b block header
2018-07-15T07:28:58.835+02:00 - TRACE - downloaded 00000000000000000030ae5f8b361497fa489cb3b5d36b321fd8b5b387328474 block header
2018-07-15T07:28:58.835+02:00 - TRACE - downloaded 00000000000000000018aa9a4f88d4721fd1061c36158b1d89eb3c2e9309c917 block header
2018-07-15T07:28:58.836+02:00 - TRACE - downloaded 0000000000000000001245ecd1105dadebd5596883e854007466f8a12d36d02e block header
2018-07-15T07:28:58.836+02:00 - TRACE - downloaded 0000000000000000002f677bc1750f41f4afcf2e77b1222f72d39bb4231df5b6 block header
2018-07-15T07:28:58.837+02:00 - TRACE - downloaded 00000000000000000027d294975da92c638b54079e188f6c0664a01193920e49 block header
2018-07-15T07:28:58.837+02:00 - INFO - best=0000000000000000001e01d834dc72ce35be96727cd40bb08a7c186a7ab04ef0 height=531982 @ 2018-07-15T05:23:44Z (18 left to index)
2018-07-15T07:29:03.993+02:00 - DEBUG - applying 18 new headers from height 531965
2018-07-15T07:29:03.998+02:00 - TRACE - 432 transactions in mempool (+432)
2018-07-15T07:29:03.999+02:00 - WARN - no mempool entry b0e0255e93558372460e936507d6dcd49dbf8dc99bcac15299e95bb7fcf5e929: missing fees section
2018-07-15T07:29:04.000+02:00 - WARN - no mempool entry f7e7e3f21f743bc492562cf9ab9cf363298286089398745262f0fd47a5094584: missing fees section
2018-07-15T07:29:04.000+02:00 - WARN - no mempool entry 

Many others .....

624a13e963a60bd1f38bf119cd4bf20846ca08ee13c8e38bc5a5a66561e07715: missing fees section
2018-07-15T07:29:04.178+02:00 - WARN - no mempool entry 2e86b8278b97f7a58bcf17cbe1689a9e2b174ad25dcba7c124e4098e5b38d6ef: missing fees section
thread 'main' panicked at 'assertion failed: `(left == right)`
  left: `0`,
 right: `1003`', src/mempool.rs:218:9
stack backtrace:
   0: std::sys::unix::backtrace::tracing::imp::unwind_backtrace
             at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
   1: std::sys_common::backtrace::print
             at libstd/sys_common/backtrace.rs:71
             at libstd/sys_common/backtrace.rs:59
   2: std::panicking::default_hook::{{closure}}
             at libstd/panicking.rs:211
   3: std::panicking::default_hook
             at libstd/panicking.rs:227
   4: std::panicking::rust_panic_with_hook
             at libstd/panicking.rs:463
   5: std::panicking::begin_panic_fmt
             at libstd/panicking.rs:350
   6: electrs::mempool::Tracker::update
   7: electrs::query::Query::update_mempool
   8: electrs::main
   9: std::rt::lang_start::{{closure}}
  10: std::panicking::try::do_call
             at libstd/rt.rs:59
             at libstd/panicking.rs:310
  11: __rust_maybe_catch_panic
             at libpanic_unwind/lib.rs:105
  12: std::rt::lang_start_internal
             at libstd/panicking.rs:289
             at libstd/panic.rs:374
             at libstd/rt.rs:58
  13: main
  14: __libc_start_main
  15: _start
2018-07-15T07:42:29.028+02:00 - TRACE - closing DB

from electrs.

romanz avatar romanz commented on July 28, 2024

The 2nd panic is actually a bug, so thanks a lot for helping me to find and fix it :)
Please try to re-run electrs using the latest commit from GitHub.

from electrs.

romanz avatar romanz commented on July 28, 2024

Regarding the 1st panic - it seems that JSONRPC connection was been disconnected (so the mempool polling failed), but I'm still not sure why this happens...
Could you look at the ~/.bitcoin/debug.log to see if there are any errors that may be related to this issue?

P.S.
You can run bitcoind -debug=rpc -debug=http to get more RPC/HTTP specific logging...

from electrs.

romanz avatar romanz commented on July 28, 2024

I've opened a new bug for handling graceful JSON RPC disconnections -> #18.

from electrs.

gabridome avatar gabridome commented on July 28, 2024

Regarding the 1st panic - it seems that JSONRPC connection was been disconnected (so the mempool polling failed), but I'm still not sure why this happens...
Could you look at the ~/.bitcoin/debug.log to see if there are any errors that may be related to this issue?

The program is running and, apart from the same WARN (reported above) it seems to have no problems.

One thought: I had c-lightning, lnd and electrs insisting on the same rpc api of my bitcoind. Is it possible that many connections/request makes it shut down or similar behaviours?

Now I have shut down c-lightning for the last test.

from electrs.

romanz avatar romanz commented on July 28, 2024

I had c-lightning, lnd and electrs insisting on the same rpc api of my bitcoind. Is it possible that many connections/request makes it shut down or similar behaviours?

Good suggestion - this should be solved by #19 :)

from electrs.

gabridome avatar gabridome commented on July 28, 2024

The program was running ok but when I fired up electrum it crashed.
here the relevant log from the current crash:

2018-07-15T22:04:07.339+02:00 - WARN - no mempool entry 21fc1c8585e33d0113c5aa63233945174b110aa3422e87607ce0666346ce1803: missing fees section
2018-07-15T22:04:07.340+02:00 - INFO - RPC server running on 127.0.0.1:50001
2018-07-15T22:04:10.898+02:00 - INFO - [127.0.0.1:50460] connected peer
thread 'reader' panicked at 'failed to read a request: Custom { kind: InvalidData, error: StringError("stream did not contain valid UTF-8") }', libcore/result.rs:945:5
stack backtrace:
   0:     0x563218fe6e1e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::he2ad84a733ff5a63
                               at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
   1:     0x563218fed256 - std::sys_common::backtrace::print::hf6fb23a1794250a5
                               at libstd/sys_common/backtrace.rs:71
                               at libstd/sys_common/backtrace.rs:59
   2:     0x563218fd626b - std::panicking::default_hook::{{closure}}::ha69c5f3cb0459cff
                               at libstd/panicking.rs:211
   3:     0x563218fd5f43 - std::panicking::default_hook::hf08727ddbbbad4bb
                               at libstd/panicking.rs:227
   4:     0x563218fd688e - std::panicking::rust_panic_with_hook::hd6baf0cfc62bef0f
                               at libstd/panicking.rs:463
   5:     0x563218fd642c - std::panicking::begin_panic_fmt::h067a7944e7e0f96e
                               at libstd/panicking.rs:350
   6:     0x563218fd63f1 - rust_begin_unwind
                               at libstd/panicking.rs:328
   7:     0x56321902e592 - core::panicking::panic_fmt::h61b193aee9efb823
                               at libcore/panicking.rs:71
   8:     0x563218b3bf28 - core::result::unwrap_failed::hfae190ddb24b527f
   9:     0x563218b4d025 - electrs::rpc::Connection::handle_requests::h3407ccb403d2f267
  10:     0x563218b5fc78 - std::sys_common::backtrace::__rust_begin_short_backtrace::h0497046b7d59a1a3
  11:     0x563218af7134 - std::panicking::try::do_call::h6d426ba7f081619f
  12:     0x563218ff42d9 - __rust_maybe_catch_panic
                               at libpanic_unwind/lib.rs:105
  13:     0x563218b94c74 - <F as alloc::boxed::FnBox<A>>::call_box::h8c7e53b6f46d56cc
  14:     0x563218fe8cca - std::sys_common::thread::start_thread::hd31f5c5fa3e47024
                               at /checkout/src/liballoc/boxed.rs:648
                               at libstd/sys_common/thread.rs:24
  15:     0x563218fd6e25 - std::sys::unix::thread::Thread::new::thread_start::hb3e7825324ee0f62
                               at libstd/sys/unix/thread.rs:90
  16:     0x7f23d163c6b9 - start_thread
  17:     0x7f23d115c41c - clone
  18:                0x0 - <unknown>

No relevant logs from bitcoind:

2018-07-15 20:04:07 Received a POST request for / from 127.0.0.1:40096
2018-07-15 20:04:07 ThreadRPCServer method=getmempoolentry
2018-07-15 20:04:07 Received a POST request for / from 127.0.0.1:40096
2018-07-15 20:04:12 Received a POST request for / from 127.0.0.1:40096
2018-07-15 20:04:12 ThreadRPCServer method=getbestblockhash
2018-07-15 20:04:12 Received a POST request for / from 127.0.0.1:40096
2018-07-15 20:04:12 ThreadRPCServer method=getrawmempool
2018-07-15 20:04:12 Received a POST request for / from 127.0.0.1:40096
2018-07-15 20:04:12 ThreadRPCServer method=getmempoolentry
2018-07-15 20:04:12 Received a POST request for / from 127.0.0.1:40096

from electrs.

gabridome avatar gabridome commented on July 28, 2024

Good suggestion - this should be solved by #19 :)

In which way? should I try to configure the service on a different port or IP?

from electrs.

romanz avatar romanz commented on July 28, 2024

In which way? should I try to configure the service on a different port or IP?

You can now configure Electrum RPC server address & port using:

--electrum-rpc-addr 127.0.0.1:54321

instead of the default 127.0.0.1:50001.

from electrs.

romanz avatar romanz commented on July 28, 2024

Regarding the "stream did not contain valid UTF-8" panic:
It seems that Electrum client is sending invalid data to the wallet...

You can test that the server works correctly by using netcat:

$ echo '{"id":0, "method": "server.version", "params": []}' | netcat localhost 50001
{"id":0,"jsonrpc":"2.0","result":["RustElectrum 0.1.0","1.2"]}

Does the above snippet work for you?

from electrs.

gabridome avatar gabridome commented on July 28, 2024

yes it does. It seems to work as expecteted.

~$ echo '{"id":0, "method": "server.version", "params": []}' | netcat localhost 50001
{"id":0,"jsonrpc":"2.0","result":["RustElectrum 0.1.0","1.2"]}

I connect to the server through an ssh tunnel:

ssh bitcoin@myremoteelectrumserver -L 50001:localhost:50001

But still the electrum client show no connection (red light in the network signal).

I will try to change the port of the service.

from electrs.

romanz avatar romanz commented on July 28, 2024

You're welcome, thank you for the testing and the debugging :)

from electrs.

gabridome avatar gabridome commented on July 28, 2024

I don't know if opening an other issue because the problem seems quite the same.
After hours it worked perfectly, I launched electrum on the port 54321.

2018-07-17T17:44:30.080+02:00 - TRACE - 3845 transactions in mempool (+7)
2018-07-17T17:44:35.159+02:00 - TRACE - 3859 transactions in mempool (+14)
2018-07-17T17:44:40.287+02:00 - TRACE - 3875 transactions in mempool (+16)
2018-07-17T17:44:40.349+02:00 - INFO - [127.0.0.1:54886] connected peer
thread 'reader' panicked at 'failed to read a request: Custom { kind: InvalidData, error: StringError("stream did not contain valid UTF-8") }', libcore/result.rs:945:5
stack backtrace:
   0:     0x557c4e0b478e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::he2ad84a733ff5a63
                               at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
   1:     0x557c4e0babc6 - std::sys_common::backtrace::print::hf6fb23a1794250a5
                               at libstd/sys_common/backtrace.rs:71
                               at libstd/sys_common/backtrace.rs:59
   2:     0x557c4e0a3bdb - std::panicking::default_hook::{{closure}}::ha69c5f3cb0459cff
                               at libstd/panicking.rs:211
   3:     0x557c4e0a38b3 - std::panicking::default_hook::hf08727ddbbbad4bb
                               at libstd/panicking.rs:227
   4:     0x557c4e0a41fe - std::panicking::rust_panic_with_hook::hd6baf0cfc62bef0f
                               at libstd/panicking.rs:463
   5:     0x557c4e0a3d9c - std::panicking::begin_panic_fmt::h067a7944e7e0f96e
                               at libstd/panicking.rs:350
   6:     0x557c4e0a3d61 - rust_begin_unwind
                               at libstd/panicking.rs:328
   7:     0x557c4e0fbf02 - core::panicking::panic_fmt::h61b193aee9efb823
                               at libcore/panicking.rs:71
   8:     0x557c4dc028a8 - core::result::unwrap_failed::hfae190ddb24b527f
   9:     0x557c4dc13365 - electrs::rpc::Connection::handle_requests::h3407ccb403d2f267
  10:     0x557c4dc2f3a8 - std::sys_common::backtrace::__rust_begin_short_backtrace::h0497046b7d59a1a3
  11:     0x557c4dbbc944 - std::panicking::try::do_call::h6d426ba7f081619f
  12:     0x557c4e0c1c49 - __rust_maybe_catch_panic
                               at libpanic_unwind/lib.rs:105
  13:     0x557c4dc58cf4 - <F as alloc::boxed::FnBox<A>>::call_box::h8c7e53b6f46d56cc
  14:     0x557c4e0b663a - std::sys_common::thread::start_thread::hd31f5c5fa3e47024
                               at /checkout/src/liballoc/boxed.rs:648
                               at libstd/sys_common/thread.rs:24
  15:     0x557c4e0a4795 - std::sys::unix::thread::Thread::new::thread_start::hb3e7825324ee0f62
                               at libstd/sys/unix/thread.rs:90
  16:     0x7ff397c5e6b9 - start_thread
  17:     0x7ff39777e41c - clone
  18:                0x0 - <unknown>
2018-07-17T17:44:45.375+02:00 - TRACE - 3888 transactions in mempool (+13)

I also did the check and went fine:

$ echo '{"id":0, "method": "server.version", "params": []}' | netcat localhost 50001
{"id":0,"jsonrpc":"2.0","result":["RustElectrum 0.1.0","1.2"]}

from electrs.

Related Issues (20)

Recommend Projects

  • React photo React

    A declarative, efficient, and flexible JavaScript library for building user interfaces.

  • Vue.js photo Vue.js

    🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.

  • Typescript photo Typescript

    TypeScript is a superset of JavaScript that compiles to clean JavaScript output.

  • TensorFlow photo TensorFlow

    An Open Source Machine Learning Framework for Everyone

  • Django photo Django

    The Web framework for perfectionists with deadlines.

  • D3 photo D3

    Bring data to life with SVG, Canvas and HTML. 📊📈🎉

Recommend Topics

  • javascript

    JavaScript (JS) is a lightweight interpreted programming language with first-class functions.

  • web

    Some thing interesting about web. New door for the world.

  • server

    A server is a program made to process requests and deliver data to clients.

  • Machine learning

    Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.

  • Game

    Some thing interesting about game, make everyone happy.

Recommend Org

  • Facebook photo Facebook

    We are working to build community through open source technology. NB: members must have two-factor auth.

  • Microsoft photo Microsoft

    Open source projects and samples from Microsoft.

  • Google photo Google

    Google ❤️ Open Source for everyone.

  • D3 photo D3

    Data-Driven Documents codes.