TCA does not connect with default bridges when it should
There actually are two bugs here but i have only one screencast and one log so i will describe both here:
- Checked "Configure Tor automatically (easier)
- Checked the checkbox "Configure a Tor bridge"
- Clicked "Connect to Tor"
- Checked "Use a default bridge"
- Clicked "Connect to Tor"
TCA will tell you they are blocked but actually they aren't.
(That's bug number one)
Now "fool" TCA by clicking one of the options in the "Error connecting to Tor" window without changing anything and TCA will now allow you to try connecting again.
- Clicked "Connect to Tor"
TCA will now connect you to Tor without bridges which is clearly not what i wanted.
(That's bug number two)
After step 6 the behavior was different almost every time.
In the videos you will see that connecting without bridges succeeded this time.
But sometimes TCA will fail and will then try with default bridges again.
Sometimes that works. Sometimes it doesn't and you will be back at the "Error connecting to Tor" window.
(My network conditions are the same like on #18303 (closed)).
Screencast_from_07-02-2021_08-52-36_AM Screencast_from_07-02-2021_08-53-00_AM
Terminal output:
DEBUG:__main__:Running ['sudo', '-n', '/usr/local/bin/tca']
INFO:__main__:['/usr/local/lib/connect-drop', '-c', 'FILE:/var/lib/tca/tca.conf:r+', '-c', 'UNIX:/run/tca-portal.sock', '--', '/bin/ip', 'netns', 'exec', 'torlaunch', '/sbin/runuser', '-u', 'amnesia', '--', 'bwrap', '--bind', '/', '/', '--proc', '/proc', '--dev', '/dev', '--bind', '/tmp/netns-specific/torlaunch', '/tmp/shared-with-me/', '--tmpfs', '/tmp/netns-specific/', 'env', 'DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus', 'XDG_RUNTIME_DIR=/run/user/1000', 'DISPLAY=:1', 'LANG=en_US.UTF-8', 'XDG_CURRENT_DESKTOP=GNOME', 'XAUTHORITY=/run/user/1000/gdm/Xauthority', 'DESKTOP_STARTUP_ID=', 'NOTIFY_SOCKET=', 'AT_SPI_BUS_ADDRESS=unix:path=/tmp/shared-with-me/at.sock', 'IBUS_ADDRESS=unix:path=/tmp/shared-with-me/ibus.sock', '/usr/bin/python3', '/usr/lib/python3/dist-packages/tca/application.py']
(application.py:11004): dbind-WARNING **: 08:52:37.964: Couldn't connect to accessibility bus: Failed to connect to socket /tmp/shared-with-me/at.sock: Connection refused
DEBUG:stem:GETCONF __owningcontrollerprocess (runtime: 0.0011)
DEBUG:stem:GETCONF usebridges (runtime: 0.0009)
DEBUG:stem:GETCONF socks4proxy (runtime: 0.0005)
DEBUG:stem:GETCONF socks5proxy (runtime: 0.0005)
DEBUG:stem:GETCONF httpsproxy (runtime: 0.0005)
DEBUG:stem:GETCONF disablenetwork (runtime: 0.0008)
INFO:TCAApplication:tor state changed: DisableNetwork
(Tor Connection:11004): IBUS-WARNING **: 08:52:38.266: Unable to connect to ibus: Could not connect: Connection refused
INFO:tca.ui.main_window:DisableNetwork changed 1
INFO:tca.ui.main_window:Status: up=True disable_network=True, working=False, step=hide
INFO:tca.ui.main_window:Local network changed True
INFO:tca.ui.main_window:Status: up=True disable_network=True, working=False, step=hide
INFO:tca.ui.main_window:Saving configuration (success=False)
DEBUG:stem:SETCONF UseBridges="1" Bridge="obfs4 192.95.36.142:443 CDF2E852BF539B82BD10E27E9115A31734E378C2 cert=qUVQ0srL1JI/vO6V6m/24anYXiJD3QP2HgzUKQtQ7GRqqUvs7P+tG43RtAqdhLOALP7DJQ iat-mode=1" Bridge="obfs4 38.229.1.78:80 C8CBDB2464FC9804A69531437BCF2BE31FDD2EE4 cert=Hmyfd2ev46gGY7NoVxA9ngrPF2zCZtzskRTzoWXbxNkzeVnGFPWmrTtILRyqCTjHR+s9dg iat-mode=1" Bridge="obfs4 37.218.245.14:38224 D9A82D2F9C2F65A18407B1D2B764F130847F8B5D cert=bjRaMrr1BRiAW8IE9U5z27fQaYgOhX1UCmOpg2pFpoMvo6ZgQMzLsaTzzQNTlm7hNcb+Sg iat-mode=0" Bridge="obfs4 85.31.186.98:443 011F2599C0E9B27EE74B353155E244813763C3E5 cert=ayq0XzCwhpdysn5o0EyDUbmSOx3X/oTEbzDMvczHOdBJKlvIdHHLJGkZARtT4dcBFArPPg iat-mode=0" Bridge="obfs4 85.31.186.26:443 91A6354697E6B02A386312F68D82CF86824D3606 cert=PBwr+S8JTVZo6MPdHnkTwXJPILWADLqfMGoVvhZClMq/Urndyd42BwX9YFJHZnBB3H0XCw iat-mode=0" Bridge="obfs4 144.217.20.138:80 FB70B257C162BF1038CA669D568D76F5B7F0BABB cert=vYIV5MgrghGQvZPIi1tJwnzorMgqgmlKaB77Y3Z9Q/v94wZBOAXkW+fdx4aSxLVnKO+xNw iat-mode=0" Bridge="obfs4 193.11.166.194:27015 2D82C2E354D531A68469ADF7F878FA6060C6BACA cert=4TLQPJrTSaDffMK7Nbao6LC7G9OW/NHkUwIdjLSS3KYf0Nv4/nQiiI8dY2TcsQx01NniOg iat-mode=0" Bridge="obfs4 193.11.166.194:27020 86AC7B8D430DAC4117E9F42C9EAED18133863AAF cert=0LDeJH4JzMDtkJJrFphJCiPqKx7loozKN7VNfuukMGfHO0Z8OGdzHVkhVAOfo1mUdv9cMg iat-mode=0" Bridge="obfs4 193.11.166.194:27025 1AE2C08904527FEA90C4C4F8C1083EA59FBC6FAF cert=ItvYZzW5tn6v3G4UnQa6Qz04Npro6e81AP70YujmK/KXwDFPTs3aHXcHp4n8Vt6w/bv8cA iat-mode=0" Bridge="obfs4 209.148.46.65:443 74FAD13168806246602538555B5521A0383A1875 cert=ssH+9rP8dG2NLDN2XuFw63hIO/9MNNinLmxQDpVa+7kTOa9/m+tGWT1SmSYpQ9uTBGa6Hw iat-mode=0" Bridge="obfs4 146.57.248.225:22 10A6CD36A537FCE513A322361547444B393989F0 cert=K1gDtDAIcUfeLqbstggjIw2rtgIKqdIhUlHp82XRqNSq/mtAjp1BIC9vHKJ2FAEpGssTPw iat-mode=0" Bridge="obfs4 45.145.95.6:27015 C5B7CD6946FF10C5B3E89691A7D3F2C122D2117C cert=TD7PbUO0/0k6xYHMPW3vJxICfkMZNdkRrb63Zhl5j9dW3iRGiCx0A7mPhe5T2EDzQ35+Zw iat-mode=0" Bridge="obfs4 [2a0c:4d80:42:702::1]:27015 C5B7CD6946FF10C5B3E89691A7D3F2C122D2117C cert=TD7PbUO0/0k6xYHMPW3vJxICfkMZNdkRrb63Zhl5j9dW3iRGiCx0A7mPhe5T2EDzQ35+Zw iat-mode=0" Bridge="obfs4 51.222.13.177:80 5EDAC3B810E12B01F6FD8050D2FD3E277B289A08 cert=2uplIpLQ0q9+0qMFrK5pkaYRDOe460LL9WHBvatgkuRr/SL31wBOEupaMMJ6koRE6Ld0ew iat-mode=0" Socks4Proxy Socks5Proxy HTTPSProxy Socks5ProxyUsername Socks5ProxyPassword HTTPSProxyAuthenticator (runtime: 0.0126)
DEBUG:stem:SETCONF DisableNetwork="0" (runtime: 0.0458)
DEBUG:stem:GETINFO version (runtime: 0.0010)
DEBUG:stem:GETCONF disablenetwork (runtime: 0.0006)
INFO:TCAApplication:tor state changed: DisableNetwork
INFO:tca.ui.main_window:DisableNetwork changed 0
INFO:tca.ui.main_window:Status: up=True disable_network=False, working=False, step=progress
INFO:tca.ui.main_window:Tor not working
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0008)
INFO:ConnectionProgress:new bootstrap_phase received: 2 going to 10.00%
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0010)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0024)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0013)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0013)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0008)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0029)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0009)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0029)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0018)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0007)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0025)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0014)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0027)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0009)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0030)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0029)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0029)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0028)
INFO:tca.ui.main_window:Failed with bridges
call async 1
INFO:tca.ui.main_window:Saving configuration (success=False)
DEBUG:stem:SETCONF UseBridges="0" Bridge Socks4Proxy Socks5Proxy HTTPSProxy Socks5ProxyUsername Socks5ProxyPassword HTTPSProxyAuthenticator (runtime: 0.0037)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0011)
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0837)
INFO:tca.ui.main_window:We received some sign of life from Tor network
INFO:ConnectionProgress:new bootstrap_phase received: 45 going to 50.00%
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0046)
INFO:ConnectionProgress:new bootstrap_phase received: 52 going to 50.00%
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0007)
INFO:ConnectionProgress:new bootstrap_phase received: 75 going to 50.00%
DEBUG:stem:GETINFO status/bootstrap-phase (runtime: 0.0007)
INFO:ConnectionProgress:new bootstrap_phase received: 100 going to 50.00%
INFO:TCAApplication:tor_is_working = True
INFO:tca.ui.main_window:Tor working changed True
INFO:tca.ui.main_window:Status: up=True disable_network=False, working=True, step=progress
INFO:tca.ui.main_window:Saving configuration (success=False)
INFO:tca.ui.main_window:Saving configuration (success=True)
INFO:tca.ui.main_window:Saving configuration (success=True)
amnesia@amnesia:~$
Possibly related reports on help desk:
- Bug report: 43ca99bca42120e5a2c389b75c785097