Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Onboarding any pubs with 1.0.18 fails #333

Closed
kode54 opened this issue Feb 2, 2022 · 3 comments
Closed

Onboarding any pubs with 1.0.18 fails #333

kode54 opened this issue Feb 2, 2022 · 3 comments
Assignees
Labels
bug Something isn't working

Comments

@kode54
Copy link

kode54 commented Feb 2, 2022

I cannot join any pubs with the latest version.

@kode54
Copy link
Author

kode54 commented Feb 2, 2022

Log output:

2022-02-02 02:45:36.449815-0800 Planetary[25761:4317367] LOG:INFO: RedeemInviteOperation started.
2022-02-02 02:45:36.457175-0800 Planetary[25761:4317367] LOG:DEBUG: Redeeming invite to star @CIlwTOK+m6v1hT2zUVOCJvvZq7KE/65ErN6yA2yrURY=.ed25519...
preparing
2022-02-02 02:45:37.070201-0800 Planetary[25761:4318299] [tcp] tcp_output [C11.1:2] flags=[R.] seq=2199044601, ack=1217046547, win=4117 state=CLOSED rcv_nxt=1217046547, snd_una=2199044601
failed(-9816: Optional(server closed session with no notification))
2022-02-02 02:45:37.074431-0800 Planetary[25761:4317367] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:45:37.077083-0800 Planetary[25761:4317367] LOG:ERROR: unexpectedFault("Could not connect to Star.")
cancelled
level=debug ts="2022-02-02 10:45:46.0016380 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:45:46.0082070 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:56099|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:45:46.0086950 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:8008 remote=[fe80::18ff:d750:5124:af4f%en2]:56099 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:45:46.0209520 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:45:46.0218540 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:56100|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:45:46.0220000 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::8ba:8998:b73d:db35%en0]:56100 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:45:46.0414820 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:45:46.0455850 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:56101|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:45:46.0459500 (UTC)" conn=closed local=10.0.0.214:8008 remote=10.0.0.138:56101 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:45:46.2069980 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:45:46.2130870 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:56102|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:45:46.2137920 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::2f:9b56:a6b:1d01%en0]:56102 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:46:03.4874670 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:03.4941460 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:03.4947500 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:52090 remote=[fe80::18ff:d750:5124:af4f%en2]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:03.7131190 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:03.7194260 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:03.7197670 (UTC)" conn=closed local=10.0.0.214:52091 remote=10.0.0.138:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:03.7318360 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:03.7362160 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:03.7366550 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52092 remote=[fe80::8ba:8998:b73d:db35%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:03.8272830 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:03.8327410 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.113:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:03.8331910 (UTC)" conn=closed local=10.0.0.214:52093 remote=10.0.0.113:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:03.8570800 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:03.8613410 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:03.8618140 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52094 remote=[fe80::2f:9b56:a6b:1d01%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:31.0019930 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:31.0148930 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:56231|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:31.0151000 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:8008 remote=[fe80::18ff:d750:5124:af4f%en2]:56231 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:46:31.0196410 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:31.0202580 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:56232|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:31.0203520 (UTC)" conn=closed local=10.0.0.214:8008 remote=10.0.0.138:56232 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:46:31.0433870 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:31.0470830 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:56233|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:31.0474300 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::8ba:8998:b73d:db35%en0]:56233 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:46:31.0659650 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:31.0712720 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:56234|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:31.0719190 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::2f:9b56:a6b:1d01%en0]:56234 tx="178 B" rx="176 B"
2022-02-02 02:46:32.458599-0800 Planetary[25761:4318713] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:46:32.459754-0800 Planetary[25761:4318713] LOG:ERROR: unexpectedFault("Could not connect to Star.")
cancelled
2022-02-02 02:46:32.596510-0800 Planetary[25761:4318713] [tcp] tcp_output [C14.1:2] flags=[R.] seq=3610713436, ack=3376214551, win=4117 state=CLOSED rcv_nxt=3376214551, snd_una=3610713436
failed(-9816: Optional(server closed session with no notification))
2022-02-02 02:46:32.600929-0800 Planetary[25761:4318559] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:46:32.602159-0800 Planetary[25761:4318559] LOG:ERROR: unexpectedFault("Could not connect to Star.")
cancelled
2022-02-02 02:46:32.768175-0800 Planetary[25761:4318559] [tcp] tcp_output [C12.1:2] flags=[R.] seq=4210448426, ack=4069928457, win=4117 state=CLOSED rcv_nxt=4069928457, snd_una=4210448426
failed(-9816: Optional(server closed session with no notification))
2022-02-02 02:46:32.771868-0800 Planetary[25761:4318719] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:46:32.772995-0800 Planetary[25761:4318719] LOG:ERROR: unexpectedFault("Could not connect to Star.")
cancelled
level=debug ts="2022-02-02 10:46:48.4899720 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:48.4944900 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:48.4948300 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:52095 remote=[fe80::18ff:d750:5124:af4f%en2]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:48.5689590 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:48.5736030 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:48.5740510 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52096 remote=[fe80::8ba:8998:b73d:db35%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:48.6003000 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:48.6049650 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:48.6055110 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52097 remote=[fe80::2f:9b56:a6b:1d01%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:48.6217310 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:48.6256120 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:48.6261060 (UTC)" conn=closed local=10.0.0.214:52098 remote=10.0.0.138:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:46:48.6567340 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:46:48.6609250 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.113:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:46:48.6612860 (UTC)" conn=closed local=10.0.0.214:52099 remote=10.0.0.113:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:47:16.0013410 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:16.0110310 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:56374|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:16.0116600 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:8008 remote=[fe80::18ff:d750:5124:af4f%en2]:56374 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:47:16.0152590 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:16.0159470 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:56375|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:16.0160430 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::8ba:8998:b73d:db35%en0]:56375 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:47:16.0351760 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:16.0388500 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:56376|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:16.0391410 (UTC)" conn=closed local=10.0.0.214:8008 remote=10.0.0.138:56376 tx="178 B" rx="176 B"
level=debug ts="2022-02-02 10:47:16.2121980 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:16.2162880 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:56377|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:16.2166560 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:8008 remote=[fe80::2f:9b56:a6b:1d01%en0]:56377 tx="178 B" rx="176 B"
2022-02-02 02:47:32.392601-0800 Planetary[25761:4318971] LOG:DEBUG: Seeding known stars stars...
2022-02-02 02:47:32.398292-0800 Planetary[25761:4318973] LOG:DEBUG: Retrieving list of available stars...
2022-02-02 02:47:32.399673-0800 Planetary[25761:4318973] LOG:DEBUG: There are 3 missing stars.
2022-02-02 02:47:32.400407-0800 Planetary[25761:4318971] LOG:INFO: RedeemInviteOperation started.
2022-02-02 02:47:32.400451-0800 Planetary[25761:4318972] LOG:INFO: RedeemInviteOperation started.
2022-02-02 02:47:32.400495-0800 Planetary[25761:4318849] LOG:INFO: RedeemInviteOperation started.
2022-02-02 02:47:32.403182-0800 Planetary[25761:4318971] LOG:DEBUG: Redeeming invite to star @CIlwTOK+m6v1hT2zUVOCJvvZq7KE/65ErN6yA2yrURY=.ed25519...
preparing
2022-02-02 02:47:32.406860-0800 Planetary[25761:4318972] LOG:DEBUG: Redeeming invite to star @7jJ7oou5pKKuyKvIlI5tl3ncjEXmZcbm3TvKqQetJIo=.ed25519...
preparing
2022-02-02 02:47:32.410055-0800 Planetary[25761:4318849] LOG:DEBUG: Redeeming invite to star @LQ8HBiEinU5FiXGaZH9JYFGBGdsB99mepBdh/Smq3VI=.ed25519...
preparing
2022-02-02 02:47:32.416198-0800 Planetary[25761:4318971] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:47:32.417052-0800 Planetary[25761:4318971] LOG:ERROR: unexpectedFault("Could not connect to Star.")
cancelled
2022-02-02 02:47:32.883045-0800 Planetary[25761:4318849] [tcp] tcp_output [C16.1:2] flags=[R.] seq=3982057724, ack=2022631811, win=4117 state=CLOSED rcv_nxt=2022631811, snd_una=3982057724
2022-02-02 02:47:32.884894-0800 Planetary[25761:4318849] [tcp] tcp_output [C15.1:2] flags=[R.] seq=3347041743, ack=3215110293, win=4117 state=CLOSED rcv_nxt=3215110293, snd_una=3347041743
failed(-9816: Optional(server closed session with no notification))
failed(2022-02-02 02:47:32.888267-0800 Planetary[25761:4318972] LOG:ERROR: unexpectedFault("Could not connect to Star.")
-9816: Optional(server closed session with no notification))
2022-02-02 02:47:32.889312-0800 Planetary[25761:4318971] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:47:32.889820-0800 Planetary[25761:4318972] LOG:ERROR: unexpectedFault("Could not connect to Star.")
2022-02-02 02:47:32.890360-0800 Planetary[25761:4318971] LOG:ERROR: unexpectedFault("Could not connect to Star.")
level=debug ts="2022-02-02 10:47:33.4908880 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:33.4964230 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::18ff:d750:5124:af4f%en2]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:33.4967560 (UTC)" conn=closed local=[fe80::140c:c0d8:c306:d247%en2]:52100 remote=[fe80::18ff:d750:5124:af4f%en2]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:47:33.7278220 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:33.7330790 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.138:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:33.7335030 (UTC)" conn=closed local=10.0.0.214:52101 remote=10.0.0.138:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:47:33.7539030 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:33.7586620 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::8ba:8998:b73d:db35%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:33.7591190 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52102 remote=[fe80::8ba:8998:b73d:db35%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:47:33.8269030 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:33.8320020 (UTC)" conn=mkHandler err="nope - access denied" peer="[fe80::2f:9b56:a6b:1d01%en0]:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:33.8325810 (UTC)" conn=closed local=[fe80::1438:f6ef:750b:3c6d%en0]:52103 remote=[fe80::2f:9b56:a6b:1d01%en0]:8008 tx="210 B" rx="144 B"
level=debug ts="2022-02-02 10:47:33.8610600 (UTC)" invite="not for us"
level=warn ts="2022-02-02 10:47:33.8658430 (UTC)" conn=mkHandler err="nope - access denied" peer="10.0.0.113:8008|@TU6163LaDNyNVN1FG5ECFQ/6tppSGexchR5MFJS52I0=.ed25519"
level=debug ts="2022-02-02 10:47:33.8663520 (UTC)" conn=closed local=10.0.0.214:52104 remote=10.0.0.113:8008 tx="210 B" rx="144 B"

@mplorentz mplorentz self-assigned this Feb 2, 2022
@mplorentz mplorentz added the bug Something isn't working label Feb 2, 2022
@mplorentz
Copy link
Member

Thanks for this report @kode54. Fixes for this are difficult to test because of #262, which is part of the reason I missed this bug before releasing 1.0.18. Here are the steps I am using to reproduce:

  1. Start a fresh identity (side menu -> settings -> advanced settings -> reset application and identity)
  2. Go through onboarding
  3. Give the app couple minutes to sync
  4. Navigate to your profile and look at your list of followers.
    Expected: you are being followed by some of the Planetary pubs.
    Actual: you have no followers.

@mplorentz
Copy link
Member

This should be fixed in 1.0.19 which was just released to the App Store.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
Archived in project
Development

No branches or pull requests

2 participants