Rust errors make browsers unusable (linux)

carlosreq
carlosreq
Community Member

I'm seeing errors like this in /var/log/syslog

Oct 8 14:06:35 framework regolith.desktop[393627]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-08T14:06:35.599#033[0m tokio-runtime-worker(ThreadId(5)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXX) has disconnected.#033[0m
Oct 8 14:07:00 framework regolith.desktop[393627]: INFO 2021-10-08T14:07:00.410 tokio-runtime-worker(ThreadId(6)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXX) has connected, now monitoring for events.

(where 393627 is the pid for /opt/1Password/1password )

During that period of disconnection, the browsers are unusable (both Chrome and Firefox, which have the extension installed).

This happens even if I'm not using 1password at all.

The timeout since to be 3 minutes, so very often (more than once per hour) I can't browse.


1Password Version: 8.2.2
Extension Version: 2.1.2
OS Version: Ubuntu 21.04

Comments

  • carlosreq
    carlosreq
    Community Member

    Adding to this, in case it helps. The console (on firefox) for the extension shows stuff like this:

    Initializing 1Password background.js:2:2011711
    channel: stable
    version: 2.1.2
    build: 20180 (93.0)
    browser: Firefox (93.0)
    os: Linux ()
    Unchecked lastError value: Error: Could not establish connection. Receiving end does not exist. 8 background.js:2
    V0 moz-extension://cfe930ff-8b15-4499-b1a7-5cde96109098/background/background.js:2
    Unchecked lastError value: Error: Frame not found, or missing host permission background.js:2
    f1 moz-extension://cfe930ff-8b15-4499-b1a7-5cde96109098/background/background.js:2
    The Web Console logging API (console.log, console.info, console.warn, console.error) has been disabled by a script on this page.
    The connection to wss://b5n.1password.com/XXX/YYY/zzz was interrupted while the page was loading.

  • Thank you for the detailed report, @carlosreq. The logs are very helpful. 🙏

    I personally don't recognize this error so I'm going to go tap our Linux devs on the shoulder and ask for their help.

    ++dave;
    1Password Founder

  • Oh I just noticed you said stable and your post was on the 8th (last Friday). We just released a new 8.3 update yesterday so could you give that a go and let us know if the same issue reoccurs or if it gets resolved?

    Thanks!

    ++dave;
    1Password Founder

  • nickmcguire
    nickmcguire
    1Password Alumni

    Heya @carlosreq 👋🏼

    Is there a bunch of repeating logs in the extension during that period of disconnection or just what you've shared above? Also if you disable the integration between the app and the extension, do you experience any point of the browser becoming unusable? 😬

  • carlosreq
    carlosreq
    Community Member

    @nickmcguire

    (before I forget: I upgraded 1password to the stable version and part of them are with the previous beta, but I don't see changes)

    1 - Those messages appeared a bunch for times. Today:

    Oct 12 07:51:05 framework regolith.desktop[6996]: INFO 2021-10-12T07:51:05.568 tokio-runtime-worker(ThreadId(2)) [1P:op-data-layer/src/load.rs:131] loaded 903 items in 7 vaults for account: XXXXX
    Oct 12 07:51:07 framework regolith.desktop[6996]: INFO 2021-10-12T07:51:07.061 tokio-runtime-worker(ThreadId(1)) [1P:op-syncer/src/sync_job.rs:271] synced account XXXXX (0.118179031s)
    Oct 12 07:51:07 framework regolith.desktop[6996]: INFO 2021-10-12T07:51:07.061 tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/file.rs:495] find_and_complete_pending_uploads: 'XXXXX'
    Oct 12 07:51:07 framework regolith.desktop[6996]: INFO 2021-10-12T07:51:07.258 tokio-runtime-worker(ThreadId(3)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 08:01:17 framework regolith.desktop[6996]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T08:01:17.256#033[0m tokio-runtime-worker(ThreadId(6)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 08:02:16 framework regolith.desktop[6996]: INFO 2021-10-12T08:02:16.794 tokio-runtime-worker(ThreadId(6)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 08:05:07 framework regolith.desktop[19035]: INFO 2021-10-12T08:05:07.176 tokio-runtime-worker(ThreadId(3)) [1P:op-data-layer/src/load.rs:131] loaded 903 items in 7 vaults for account: XXXXX
    Oct 12 08:05:08 framework regolith.desktop[19035]: INFO 2021-10-12T08:05:08.745 tokio-runtime-worker(ThreadId(1)) [1P:op-syncer/src/sync_job.rs:271] synced account XXXXX (0.128401571s)
    Oct 12 08:05:08 framework regolith.desktop[19035]: INFO 2021-10-12T08:05:08.746 tokio-runtime-worker(ThreadId(7)) [1P:op-data-layer/src/file.rs:495] find_and_complete_pending_uploads: 'XXXXX'
    Oct 12 08:05:08 framework regolith.desktop[19035]: INFO 2021-10-12T08:05:08.945 tokio-runtime-worker(ThreadId(4)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 08:26:06 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T08:26:06.950#033[0m tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 08:27:04 framework regolith.desktop[19035]: INFO 2021-10-12T08:27:04.975 tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 09:03:20 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T09:03:20.975#033[0m tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 09:37:37 framework regolith.desktop[19035]: INFO 2021-10-12T09:37:37.336 tokio-runtime-worker(ThreadId(4)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 10:22:53 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T10:22:53.341#033[0m tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 11:31:47 framework regolith.desktop[19035]: INFO 2021-10-12T11:31:47.683 tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 11:36:33 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T11:36:33.685#033[0m tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 11:37:08 framework regolith.desktop[19035]: INFO 2021-10-12T11:37:08.032 tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 11:59:54 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T11:59:54.034#033[0m tokio-runtime-worker(ThreadId(4)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 12:00:32 framework regolith.desktop[19035]: INFO 2021-10-12T12:00:32.755 tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.
    Oct 12 12:44:00 framework regolith.desktop[19035]: #033[1;38;5;208mWARN #033[0m #033[1;38;5;208m2021-10-12T12:44:00.730#033[0m tokio-runtime-worker(ThreadId(1)) [1P:op-data-layer/src/sync.rs:475] #033[1;38;5;208mThe B5 Notifier for (XXXXX) has disconnected.#033[0m
    Oct 12 12:44:16 framework regolith.desktop[19035]: INFO 2021-10-12T12:44:16.612 tokio-runtime-worker(ThreadId(4)) [1P:op-data-layer/src/sync.rs:484] The B5 Notifier for (XXXXX) has connected, now monitoring for events.

    2 - With the extension disabled everything works fine AFAICT. This is a freshly installed system, by the way, so there's not much else going on. In fact, 1Password is the only browser extension I have, and the problem happens both in Firefox and Chrome.

    I can't personally troubleshoot much myself because well, the extensions are obfuscated :-) But if I can assist otherwise let me know, I'm OK with debugging sessions or whatever else helps figure this out.

  • nickmcguire
    nickmcguire
    1Password Alumni

    Thank you so much for the additional context around #1 @carlosreq!

    For #2, could you try disabling the integration between the app and the extension. To do this, open the settings page which is available through right clicking on the 1Password icon in your browser, or opening the popover and clicking settings in the settings cog menu, then toggling 'Integrate with 1Password app' off and see if you continue to have any problems. I'm curious to see if there is an issue in the connection between the two clients or if there's something in the extension that needs some fix-ups.

    And if you could grab the logs from the extension (which I think you know how but if not we have a support article here, https://support.1password.com/cs/extension-console-log/) and send them to support+x@1password.com, I'd love to see if there is anything that jumps out at me.

  • carlosreq
    carlosreq
    Community Member

    @nickmcguire I've been troubleshooting this and I suspect that the extension is a victim of something else going on but it doesn't handle that "something else" well.

    I realize I'm being quite vague :-) I'll update this ticket once I have a way to reproduce.

  • nickmcguire
    nickmcguire
    1Password Alumni

    ++! If you have anything to share in way of 'something else', we'd of course love to hear so we can help make sure we're not a part of that problem. Also you're the best ❤️ @carlosreq

This discussion has been closed.