CLI error "unexpected response from 1P" when 1Password itself is still locked
Hi,
When running op run I regularly get following error:
[ERROR] 2023/05/24 15:57:20 error initializing client: RequestDelegatedSession: received unexpected response from 1Password app. Please make sure 1Password CLI and the 1Password app are up-to-date.
This happens when 1Password app is running but locked. The error occurs after having done the actual authentication (using fingerprint).
Retrying the same command again then runs without issue.
Possibly relevant settings:
* Developer section:
* Ask approval for each new: application and terminal session
* Remember key approval: until 1Password locks
* Connect with 1Password CLI
* Security section:
* Unlock using system authentication service: enabled
Log when this occurs (with account id masked)
INFO 2023-05-24T14:10:01.560 tokio-runtime-worker(ThreadId(4)) [1P:native-messaging/op-native-core-integration/src/lib.rs:353] Extension connecting.
INFO 2023-05-24T14:10:01.560 tokio-runtime-worker(ThreadId(4)) [1P:native-messaging/op-native-core-integration/src/lib.rs:355] Extension connection accepted.
WARN 2023-05-24T14:10:02.566 invocation_loop(ThreadId(25)) [1P:op-app/src/app/backend.rs:244] operation blocking event loop invoke Invocation(External(NativeMessaging { invocation: NmRequestAuthorization(<NmRequestAuthorizationRequest>), client_info: NmClientInfo { pid: Some(178540), session: Cli(Tty { session_id: 178240, session_start_time: <U53> }) } })) took more than 50 ms (1004 ms)
INFO 2023-05-24T14:10:05.084 tokio-runtime-worker(ThreadId(9)) [1P:data/ext/op-account-ext-items/src/lib.rs:236] loaded *** items in * vaults for account: ****
INFO 2023-05-24T14:10:05.088 invocation_loop(ThreadId(25)) [1P:op-app/src/app/backend/unlock.rs:151] Lock state changed: Unlocked
ERROR 2023-05-24T14:10:05.362 tokio-runtime-worker(ThreadId(4)) [1P:native-messaging/op-native-core-integration/src/connection_handler.rs:62] message from b5x was None: EndConnection
ERROR 2023-05-24T14:10:05.362 tokio-runtime-worker(ThreadId(4)) [1P:native-messaging/op-native-core-integration/src/connection_handler.rs:31] Dropping connection with b5x due to error handling incoming message: EndConnection
INFO 2023-05-24T14:10:05.474 tokio-runtime-worker(ThreadId(4)) [1P:op-syncer/src/sync_job.rs:306] synced account **** (0.077690312s)
INFO 2023-05-24T14:10:05.475 tokio-runtime-worker(ThreadId(4)) [1P:data/op-file-transfer/src/lib.rs:565] find_and_complete_pending_uploads: '****'
INFO 2023-05-24T14:10:05.506 tokio-runtime-worker(ThreadId(15)) [1P:data/ext/op-account-ext-syncer/src/lib.rs:256] The B5 Notifier for (**** has connected, now monitoring for events.
Is this expected behavior (in which case at least the error message is confusing)?
Thanks,
Paul
1Password Version: 8.10.6 (81006027)
Extension Version: 2.18.0
OS Version: Ubuntu 22.04
Browser:_ Not Provided