Slackware This Forum is for the discussion of Slackware Linux.
Notices
Welcome to
LinuxQuestions.org , a friendly and active Linux Community.
You are currently viewing LQ as a guest. By joining our community you will have the ability to post topics, receive our newsletter, use the advanced search, subscribe to threads and access many other special features. Registration is quick, simple and absolutely free.
Join our community today!
Note that registered members see fewer ads, and ContentLink is completely disabled once you log in.
Are you new to LinuxQuestions.org? Visit the following links:
Site Howto |
Site FAQ |
Sitemap |
Register Now
If you have any problems with the registration process or your account login, please
contact us . If you need to reset your password,
click here .
Having a problem logging in? Please visit this page to clear all LQ-related cookies.
Get a
virtual cloud desktop with the Linux distro that you want in less than five minutes with Shells! With over 10 pre-installed distros to choose from, the worry-free installation life is here! Whether you are a digital nomad or just looking for flexibility, Shells can put your Linux machine on the device that you want to use.
Exclusive for LQ members, get up to 45% off per month.
Click here for more info.
#1
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Rep:
tor won't start properly in virtual machine
I run Slackware64-14.2 on host. tor is 0.4.3.5 from SBo. tor starts and works fine
relevant log:
Code:
[notice] Bootstrapped 0% (starting): Starting
[notice] Starting with guard context "default"
[notice] Bootstrapped 5% (conn): Connecting to a relay
[notice] Bootstrapped 10% (conn_done): Connected to a relay
[notice] Bootstrapped 14% (handshake): Handshaking with a relay
[notice] Bootstrapped 15% (handshake_done): Handshake with a relay done
[notice] Bootstrapped 75% (enough_dirinfo): Loaded enough directory info to build circuits
[notice] Bootstrapped 90% (ap_handshake_done): Handshake finished with a relay to build circuits
[notice] Bootstrapped 95% (circuit_create): Establishing a Tor circuit
[notice] Bootstrapped 100% (done): Done
I also have Slackware-14.2 in a VirtualBox VM that I'm using as sandbox for testing stuff. Same tor version. I won't claim the guest system is totally identical though.
For some reason tor fails to start on the guest system.
It gets stuck after
Code:
[notice] Bootstrapped 0% (starting): Starting
[notice] Starting with guard context "default"
What can I do to try debugging this?
#2
Member
Registered: Aug 2014
Location: Leeds, England
Distribution: Slackware x86 64 version 15.0
Posts: 127
Rep:
Have you remembered to set up a virtual network in your emulator for tor to pretend it's connecting to ? It could be as simple as that.
#3
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
DarrenDrapkin
Have you remembered to set up a virtual network in your emulator for tor to pretend it's connecting to ? It could be as simple as that.
My VirtualBox VM network settings are the default. The network device is NAT. IP address gets assigned transparently over DHCP, /etc/resolv conf gets modified properly. Internet works in VM, names get resolved, I can ping, access websites in a browser etc. It's just tor that for some reason gets stuck at startup in this strange way.
#4
Senior Member
Registered: Apr 2015
Posts: 1,201
Rep:
Are you using snowflake-client?
#5
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
PROBLEMCHYLD
Are you using snowflake-client?
As I understand, snowflake is related to the browser. My question is about the tor daemon, not about tor browser.
#6
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
I have just upgraded to tor-0.4.3.6 from SBo. Same story. Works on host, fails to bootstrap on guest.
#7
Member
Registered: May 2013
Location: Massachusetts
Distribution: Slackware, NetBSD, Debian, 9front
Posts: 318
Rep:
Quote:
Originally Posted by
FlinchX
My VirtualBox VM network settings are the default. The network device is NAT. IP address gets assigned transparently over DHCP, /etc/resolv conf gets modified properly. Internet works in VM, names get resolved, I can ping, access websites in a browser etc. It's just tor that for some reason gets stuck at startup in this strange way.
Maybe the NAT isn't letting in tor traffic or is not forwarding all the needed ports. tcpdump time?
#8
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
thirdm
Maybe the NAT isn't letting in tor traffic or is not forwarding all the needed ports.
Do you mean the NAT that VirtualBox is doing by default? I am not aware of needing to explicitly do additional configuration like port forwarding for Tor. It also does not explain why tor browser, which relies on Tor, works in the same VM, albeit it has a different configuration.
Quote:
Originally Posted by
thirdm
tcpdump time?
How do I find the Tor traffic there? I don't know if Tor is using certain fixed ports.
#9
Member
Registered: May 2013
Location: Massachusetts
Distribution: Slackware, NetBSD, Debian, 9front
Posts: 318
Rep:
Quote:
Originally Posted by
FlinchX
Do you mean the NAT that VirtualBox is doing by default? I am not aware of needing to explicitly do additional configuration like port forwarding for Tor. It also does not explain why tor browser, which relies on Tor, works in the same VM, albeit it has a different configuration.
If torbrowser works that's probably not it then. With an independent daemon and palemoon and also running tor-browser, for me it seems like the independent daemon listens on and connects from port 9050 and tor-browser's tor daemon instead uses 9051. If you run tcpdump or something similar maybe you can see the traffic as the daemon attempts to start up. tor also has higher levels of debug info you can enable in the torrc. Are the messages you showed coming from that higher debug level or are they only the defaults?
In your case the two daemons aren't trying to use the same port are they?
Last edited by thirdm; 09-06-2020 at 09:08 PM .
#10
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
thirdm
With an independent daemon and palemoon and also running tor-browser, for me it seems like the independent daemon listens on and connects from port 9050 and tor-browser's tor daemon instead uses 9051.
Port 9050 is indeed the default port that Tor opens to listen for Socks connections from local applications. As the log shows, my problem happens somewhere else, at bootstrapping stage of Tor itself. Tor has no problem opening the SOCKS listener on 127.0.0.1:9050, as its startup message to stdout and netstat/ss show.
#11
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
thirdm
tor also has higher levels of debug info you can enable in the torrc. Are the messages you showed coming from that higher debug level or are they only the defaults?
Original post links to the default notice level messages, I'll enable logging with more verbosity and see what happens then. Will post the log here once I get to it.
#12
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Got a debug log, but I'm clueless
Code:
[notice] Tor 0.4.3.6 opening log file.
[notice] Tor 0.4.3.6 running on Linux with Libevent 2.0.22-stable, OpenSSL 1.0.2u, Zlib 1.2.11, Liblzma 5.2.2, and Libzstd N/A.
[notice] Tor can't help you if you use it wrong! Learn how to be safe at https://www.torproject.org/download/download#warning
[notice] Read configuration file "/etc/tor/torrc".
[notice] Opening Socks listener on 127.0.0.1:9050
[notice] Opened Socks listener on 127.0.0.1:9050
[warn] Your log may contain sensitive information - you're logging more than "notice". Don't log unless it serves an important reason. Overwrite the log afterwards.
[info] options_commit_listener_transaction(): Recomputed OOS thresholds: ConnLimit 1000, ConnLimit_ 32736, ConnLimit_high_thresh 32672, ConnLimit_low_thresh 24552
[info] crypto_openssl_late_init(): NOT using OpenSSL engine support.
[info] evaluate_evp_for_aes(): This version of OpenSSL has a known-good EVP counter-mode implementation. Using it.
[debug] tor_disable_debugger_attach(): Attemping to disable debugger attachment to Tor for unprivileged users.
[info] tor_lockfile_lock(): Locking "/var/lib/tor/lock"
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 128.31.0.39:9131 (9695)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 86.59.21.38:80 (847B)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 45.66.33.45:80 (7EA6)
[debug] parse_dir_authority_line(): Trusted 16 dirserver at 66.111.2.131:9030 (BA44)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 131.188.40.189:80 (F204)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 193.23.244.244:80 (7BE6)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 171.25.193.9:443 (BD6A)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 154.35.175.225:80 (CF6D)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 199.58.81.140:80 (74A9)
[debug] parse_dir_authority_line(): Trusted 100 dirserver at 204.13.164.118:80 (24E2)
[debug] file_status(): stat()ing /var/lib/tor/state
[debug] subsystems_register_state_formats(): Added state format for mainloop with index 0
[info] or_state_load(): Loaded state from "/var/lib/tor/state"
[debug] get_guard_selection_by_name(): Creating a guard selection called default
[info] sampled_guards_update_from_consensus(): Not updating the sample guard set; we have no reasonably live consensus.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard PXArelay02 ($E384748293FC4429E2B427360DB4F9D4C3D619D1): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard rinderwahnRelay23L ($EFA2E7B073AA4CE2DAF7160F23C90DB805948F4A): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Unnamed ($B8123550BE6A39FF7EC2D015C86755517907557E): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard bauruine ($4CE6D83FFA8AD24767007E8C972F371F2468F09A): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Logforme2 ($C3E0E9EA1FF3FCFC27E856BFE61533020DD7F090): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard TorZabehlice ($3D5D6178C44537E3692853B344385F6572A55767): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Binnacle ($4F0DB7E687FC7C0AE55C8F243DA8B0EB27FBF1F2): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard GrmmlNott ($CBBA40F7D9F284F47A243EE2C081E96682741D22): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard GeorgeIV ($0C41DC37946901C297626C0D1ABF68423947DDE5): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard arbitraryKenzie3 ($624B7391B9790E7CD2AF6A7238239BA3D6928A57): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard chomeles1blu ($EA3616A0B9BBBDC74121D8D6F01EABDDCF6BE35D): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard 1st ($1259F4C66D5D7A4145D6165680D7770161888F2B): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard ZKP1984 ($7C22E89AB620E77DF1B4A33787A5EC3F2AB4A8D1): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard sarahmanning ($B872BA6804C8C6E140AE1897B44CF32B42FD2397): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard torpidsFRonline4 ($0CF8F3E6590F45D50B70F2F7DA6605ECA6CD408F): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard parasol ($113143469021882C3A4B82F084F8125B08EE471E): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard hajmat ($32EB288C0EFB52964CCF8EF28BE6BC7FF592BB58): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard naiveTorer ($E36536404200A74930DB165858BD5BB554D2BEA2): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Assange024us ($04D9CEA8D778ABA130B014F758C2BCADD31DA05E): filtered=0; reachable_filtered=0.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard niij01 ($230A8B2A8BA861210D9B4BA97745AEC217A94207): filtered=0; reachable_filtered=0.
[info] sample_reachable_filtered_entry_guards(): Trying to sample a reachable guard: We know of 0 in the USABLE_FILTERED set.
[info] sample_reachable_filtered_entry_guards(): (That isn't enough. Trying to expand the sample.)
[info] entry_guards_expand_sample(): Not expanding the sample guard set; we have no reasonably live consensus.
[info] sample_reachable_filtered_entry_guards(): (After filters [b], we have 0 guards to consider.)
[info] circuit_build_times_parse_state(): Adding 1 timeouts.
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 675
[debug] circuit_build_times_add_time(): Adding circuit build time 975
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 1175
[debug] circuit_build_times_add_time(): Adding circuit build time 775
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 725
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 1475
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 1275
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 7875
[debug] circuit_build_times_add_time(): Adding circuit build time 875
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 46825
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 675
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 775
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 1675
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 1375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 1175
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 725
[debug] circuit_build_times_add_time(): Adding circuit build time 8475
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 725
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 1925
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 675
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 4075
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 625
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 2147483646
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 575
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 325
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 525
[debug] circuit_build_times_add_time(): Adding circuit build time 675
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 925
[debug] circuit_build_times_add_time(): Adding circuit build time 775
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[debug] circuit_build_times_add_time(): Adding circuit build time 475
[debug] circuit_build_times_add_time(): Adding circuit build time 725
[debug] circuit_build_times_add_time(): Adding circuit build time 425
[debug] circuit_build_times_add_time(): Adding circuit build time 375
[info] circuit_build_times_parse_state(): Loaded 168/168 values from 23 lines in circuit time histogram
[info] circuit_build_times_get_xm(): Xm mode #0: 375 57
[info] circuit_build_times_set_timeout(): Set buildtimeout to low value 628.686058ms. Setting to 1500ms
[info] circuit_build_times_set_timeout(): Based on 168 circuit times, it looks like we don't need to wait so long for circuits to finish. We will now assume a circuit is too slow to use after waiting 2 seconds.
[info] circuit_build_times_set_timeout(): Circuit timeout data: 1500.000000ms, 60000.000000ms, Xm: 375, a: 3.114804, r: 0.041667
[debug] kist_scheduler_run_interval(): KISTSchedRunInterval=0, turning to the consensus.
[debug] scheduler_can_use_kist(): Determined KIST sched_run_interval should be 10. Can use KIST.
[info] scheduler_kist_set_full_mode(): Setting KIST scheduler with kernel support (KIST mode)
[debug] kist_scheduler_run_interval(): KISTSchedRunInterval=0, turning to the consensus.
[info] cmux_ewma_set_options(): Enabled cell_ewma algorithm because of value in CircuitPriorityHalflifeMsec in consensus; scale factor is 0.793701 per 10 seconds
[notice] Parsing GEOIP IPv4 file /usr/share/tor/geoip.
[notice] Parsing GEOIP IPv6 file /usr/share/tor/geoip6.
[info] circpad_machine_client_hide_intro_circuits(): Registered client intro point hiding padding machine (0)
[info] circpad_machine_relay_hide_intro_circuits(): Registered relay intro circuit hiding padding machine (0)
[info] circpad_machine_client_hide_rend_circuits(): Registered client rendezvous circuit hiding padding machine (1)
[info] circpad_machine_relay_hide_rend_circuits(): Registered relay rendezvous circuit hiding padding machine (1)
[info] add_predicted_port(): New port prediction added. Will continue predictive circ building for 2625 more seconds.
[debug] file_status(): stat()ing /var/lib/tor/unparseable-descs
[notice] Bootstrapped 0% (starting): Starting
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for bastet
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority bastet with signing key D4256F8F3059FF48585BF9D636808B43D24349C1
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for tor26
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority tor26 with signing key 4ABD14E600065842C3A3D1079BD39CDB1969A51F
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for dizum
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dizum with signing key 472B3A0BCDC5DBF1EB54A60FA32A2478D92C5D4E
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for Faravahar
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority Faravahar with signing key 757F4244FF0E65AEBF55FFA36E7D2AEBB81A005D
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for moria1
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority moria1 with signing key ACE88AC828C1641CD528F8681F570FB53A65807E
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for dannenberg
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dannenberg with signing key 0AF48E6865839B2529BFB19DB8F97AFB3AAD2FFD
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for longclaw
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority longclaw with signing key 509EF6508DD58C083D55BECAC7C1B6B8BED4D358
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for gabelmoo
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority gabelmoo with signing key C4F720E2C59F9DDD4867FFF465CA04031E35648F
[debug] trusted_dirs_load_certs_from_string(): Parsed certificate for maatuska
[info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority maatuska with signing key 80563A5D95D7CE8842A6755CA288983178AF16C5
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-consensus" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/unverified-consensus" for mmap(): No such file or directory
[info] A consensus needs 5 good signatures from recognized authorities for us to accept it. This microdesc one has 9 (dannenberg tor26 longclaw bastet maatuska moria1 dizum gabelmoo Faravahar).
[debug] kist_scheduler_run_interval(): KISTSchedRunInterval=0, turning to the consensus.
[debug] scheduler_can_use_kist(): Determined KIST sched_run_interval should be 10. Can use KIST.
[info] scheduler_kist_set_full_mode(): Setting KIST scheduler with kernel support (KIST mode)
[debug] kist_scheduler_run_interval(): KISTSchedRunInterval=0, turning to the consensus.
[info] Choosing expected valid-after time as 2020-09-06 15:40:00: consensus_set=0, interval=1800
[info] microdesc_cache_reload(): Reloaded microdescriptor cache. Found 6844 descriptors.
[info] node_set_hsdir_index(): Not setting hsdir index with a non-live consensus.
[info] update_consensus_networkstatus_fetch_time_impl(): No live microdesc consensus; we should fetch one immediately.
[info] cmux_ewma_set_options(): Enabled cell_ewma algorithm because of value in CircuitPriorityHalflifeMsec in consensus; scale factor is 0.793701 per 10 seconds
[info] tor_mmap_file(): Could not open "/var/lib/tor/unverified-microdesc-consensus" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-descriptors" for mmap(): No such file or directory
[debug] file_status(): stat()ing /var/lib/tor/cached-descriptors.new
[info] routerlist_remove_old_routers(): We have 0 live routers and 0 old router descriptors.
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-extrainfo" for mmap(): No such file or directory
[debug] file_status(): stat()ing /var/lib/tor/cached-extrainfo.new
[notice] Starting with guard context "default"
[info] sampled_guards_update_from_consensus(): Not updating the sample guard set; we have no reasonably live consensus.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard PXArelay02 ($E384748293FC4429E2B427360DB4F9D4C3D619D1): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard rinderwahnRelay23L ($EFA2E7B073AA4CE2DAF7160F23C90DB805948F4A): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Unnamed ($B8123550BE6A39FF7EC2D015C86755517907557E): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard bauruine ($4CE6D83FFA8AD24767007E8C972F371F2468F09A): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Logforme2 ($C3E0E9EA1FF3FCFC27E856BFE61533020DD7F090): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard TorZabehlice ($3D5D6178C44537E3692853B344385F6572A55767): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Binnacle ($4F0DB7E687FC7C0AE55C8F243DA8B0EB27FBF1F2): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard GrmmlNott ($CBBA40F7D9F284F47A243EE2C081E96682741D22): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard GeorgeIV ($0C41DC37946901C297626C0D1ABF68423947DDE5): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard arbitraryKenzie3 ($624B7391B9790E7CD2AF6A7238239BA3D6928A57): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard chomeles1blu ($EA3616A0B9BBBDC74121D8D6F01EABDDCF6BE35D): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard 1st ($1259F4C66D5D7A4145D6165680D7770161888F2B): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard ZKP1984 ($7C22E89AB620E77DF1B4A33787A5EC3F2AB4A8D1): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard sarahmanning ($B872BA6804C8C6E140AE1897B44CF32B42FD2397): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard torpidsFRonline4 ($0CF8F3E6590F45D50B70F2F7DA6605ECA6CD408F): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard parasol ($113143469021882C3A4B82F084F8125B08EE471E): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard hajmat ($32EB288C0EFB52964CCF8EF28BE6BC7FF592BB58): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard naiveTorer ($E36536404200A74930DB165858BD5BB554D2BEA2): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard Assange024us ($04D9CEA8D778ABA130B014F758C2BCADD31DA05E): filtered=1; reachable_filtered=1.
[debug] entry_guard_set_filtered_flags(): Updated sampled guard niij01 ($230A8B2A8BA861210D9B4BA97745AEC217A94207): filtered=1; reachable_filtered=1.
[info] entry_guards_update_primary(): Primary entry guards have changed. New primary guard list is:
[info] entry_guards_update_primary(): 1/3: Logforme2 ($C3E0E9EA1FF3FCFC27E856BFE61533020DD7F090) (confirmed)
[info] entry_guards_update_primary(): 2/3: parasol ($113143469021882C3A4B82F084F8125B08EE471E) (confirmed)
[info] entry_guards_update_primary(): 3/3: Binnacle ($4F0DB7E687FC7C0AE55C8F243DA8B0EB27FBF1F2) (confirmed)
[info] I learned some more directory information, but not enough to build a circuit: We have no recent usable consensus.
#13
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
The tail of the log is here:
Code:
[debug] periodic_events_rescan_by_roles(): Launching periodic event add_entropy
[debug] periodic_events_rescan_by_roles(): Launching periodic event heartbeat
[debug] periodic_events_rescan_by_roles(): Launching periodic event reset_padding_counts
[debug] periodic_events_rescan_by_roles(): Disabling periodic event second_elapsed
[debug] periodic_events_rescan_by_roles(): Disabling periodic event retry_listeners
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_expired_networkstatus
[debug] periodic_events_rescan_by_roles(): Disabling periodic event fetch_networkstatus
[debug] periodic_events_rescan_by_roles(): Disabling periodic event launch_descriptor_fetches
[debug] periodic_events_rescan_by_roles(): Disabling periodic event rotate_x509_certificate
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_network_participation
[debug] periodic_events_rescan_by_roles(): Disabling periodic event clean_caches
[debug] periodic_events_rescan_by_roles(): Disabling periodic event save_state
[debug] periodic_events_rescan_by_roles(): Disabling periodic event write_stats_file
[debug] periodic_events_rescan_by_roles(): Disabling periodic event prune_old_routers
[debug] periodic_events_rescan_by_roles(): Disabling periodic event hs_service
[debug] periodic_events_rescan_by_roles(): Disabling periodic event record_bridge_stats
[debug] periodic_events_rescan_by_roles(): Disabling periodic event rend_cache_failure_clean
[debug] periodic_events_rescan_by_roles(): Disabling periodic event clean_consdiffmgr
[debug] periodic_events_rescan_by_roles(): Disabling periodic event control_per_second_events
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_canonical_channels
[debug] periodic_events_rescan_by_roles(): Disabling periodic event expire_old_circuits_serverside
[debug] periodic_events_rescan_by_roles(): Disabling periodic event retry_dns
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_dns_honesty
[debug] periodic_events_rescan_by_roles(): Disabling periodic event rotate_onion_key
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_descriptor
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_for_reachability_bw
[debug] periodic_events_rescan_by_roles(): Disabling periodic event reachability_warnings
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_ed_keys
[debug] periodic_events_rescan_by_roles(): Disabling periodic event check_onion_keys_expiry_time
#14
Senior Member
Registered: Jul 2017
Location: EU
Distribution: Slackware
Posts: 1,634
In the log from #12 you get a lot of "Could not open" errors for files that should be available in /var/lib/tor/
#15
Member
Registered: Nov 2017
Distribution: Slackware Linux
Posts: 666
Original Poster
Rep:
Quote:
Originally Posted by
abga
In the log from #12 you get a lot of "Could not open" errors for files that should be available in /var/lib/tor/
I suppose you mean these lines?
Code:
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-consensus" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/unverified-consensus" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/unverified-microdesc-consensus" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-descriptors" for mmap(): No such file or directory
[info] tor_mmap_file(): Could not open "/var/lib/tor/cached-extrainfo" for mmap(): No such file or directory
They show up as info level messages so, I don't know if them missing is the problem.
But, to address your questions.
I run the Tor daemon as tor user, I created the user and group just like the SBo README suggests.
None of those files above actually exist.
Here is the listing of /var/lib/tor in the VM:
Code:
# ls -la /var/lib/tor
total 7336
drwx------ 3 tor tor 4096 Sep 7 11:53 .
drwxr-xr-x 35 root root 4096 Sep 7 11:20 ..
-rw------- 1 tor tor 20442 Sep 5 04:40 cached-certs
-rw------- 1 tor tor 2291172 Sep 6 04:40 cached-microdesc-consensus
-rw------- 1 tor tor 5178292 Sep 5 04:42 cached-microdescs
-rw------- 1 tor tor 0 Sep 5 04:42 cached-microdescs.new
drwx------ 2 tor tor 4096 Aug 22 15:09 keys
-rw------- 1 tor tor 0 Sep 7 11:19 lock
-rw------- 1 tor tor 4090 Sep 7 11:53 state
All existing files seem properly owned by tor:tor, as expected.
And this matches exactly the content of /var/lib/tor on the host system, where Tor works
All times are GMT -5. The time now is 08:36 AM .
LinuxQuestions.org is looking for people interested in writing
Editorials, Articles, Reviews, and more. If you'd like to contribute
content, let us know .
