search

mautrix / signal

A Matrix-Signal puppeting bridge
GNU Affero General Public License v3.0
518 stars 75 forks source link

Message syncing failing: "Authorization failed" and "Error while syncing contacts" #360

Closed ibeckermayer closed 1 year ago

ibeckermayer commented 1 year ago

I am running the mautrix signal bridge bot via matrix-docker-ansible-deploy alongside dendrite. I'm having an apparent issue with syncing Signal.

Even when I send sync to Signal bridge bot or !signal sync in specific chats, nothing seems to sync, although the bot responds with "Sync complete" and I don't see any obvious error in the logs.

I tried logging out of the Signal bridge bot, restarting both matrix-mautrix-signal-daemon.service and matrix-mautrix-signal.service, then re-adding the bridge as a linked-device (sent link to Signal bridge bot and scanned the QR code), and then sending sync again to Signal bridge bot.

The logs that I see after that process look like this :

matrix-mautrix-signal.service ``` Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,328] [WARNING@mausignald] No handlers for RPC request ListenerState Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,348] [WARNING@mau.user.@isaiah:hermetic.chat] New IDENTIFIED websocket state from signald DISCONNECTED Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,349] [WARNING@mau.user.@isaiah:hermetic.chat] New UNIDENTIFIED websocket state from signald DISCONNECTED Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,351] [WARNING@mau.user.@isaiah:hermetic.chat] New IDENTIFIED websocket state from signald CONNECTING Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,355] [WARNING@mau.user.@isaiah:hermetic.chat] New UNIDENTIFIED websocket state from signald CONNECTING Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,474] [WARNING@mau.user.@isaiah:hermetic.chat] Failed to enable custom puppet: Didn' t get an access token: The username or password was incorrect or the account does not exist. Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,674] [WARNING@mausignald] No handlers for RPC request ListenerState Apr 29 03:50:22 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:50:22,771] [WARNING@mausignald] No handlers for RPC request ListenerState Apr 29 03:52:02 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:52:02,954] [WARNING@mau.user.@isaiah:hermetic.chat] Failed to enable custom puppet: Didn't get an access token: The username or password was incorrect or the account does not exist. Apr 29 03:53:19 hermetic matrix-mautrix-signal[436816]: [2023-04-29 03:53:19,269] [WARNING@mau.user.@isaiah:hermetic.chat] Failed to enable custom puppet: Didn't get an access token: The username or password was incorrect or the account does not exist. ```
matrix-mautrix-signal-daemon.service ``` Apr 29 03:48:24 hermetic systemd[1]: Starting Matrix Mautrix Signal daemon... ░░ Subject: A start job for unit matrix-mautrix-signal-daemon.service has begun execution ░░ Defined-By: systemd ░░ Support: http://www.ubuntu.com/support ░░ ░░ A start job for unit matrix-mautrix-signal-daemon.service has begun execution. ░░ ░░ The job identifier is 41520. Apr 29 03:48:30 hermetic matrix-mautrix-signal-daemon[436105]: not chowning signald data directory, if you have permission issues see https://signald.org/articles/install/docker/#migrating-from-versions-before-0180 Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: 03:48:31.588 [main] ERROR io.finn.signald.Main - Catching Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: java.nio.file.AccessDeniedException: /? Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at sun.nio.fs.UnixException.translateToIOException(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at sun.nio.fs.UnixException.rethrowAsIOException(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at sun.nio.fs.UnixException.rethrowAsIOException(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at sun.nio.fs.UnixFileSystemProvider.createDirectory(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at java.nio.file.Files.createDirectory(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at java.nio.file.Files.createAndCheckIsDirectory(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at java.nio.file.Files.createDirectories(Unknown Source) ~[?:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at io.finn.signald.db.sqlite.GroupsTable.setGroupAvatarPath(GroupsTable.java:165) ~[signald.jar:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at io.finn.signald.util.FileUtil.setDataPath(FileUtil.java:38) ~[signald.jar:?] Apr 29 03:48:31 hermetic matrix-mautrix-signal-daemon[436105]: at io.finn.signald.Main.main(Main.java:65) ~[signald.jar:?] Apr 29 03:48:31 hermetic systemd[1]: Started Matrix Mautrix Signal daemon. ░░ Subject: A start job for unit matrix-mautrix-signal-daemon.service has finished successfully ░░ Defined-By: systemd ░░ Support: http://www.ubuntu.com/support ░░ ░░ A start job for unit matrix-mautrix-signal-daemon.service has finished successfully. ░░ ░░ The job identifier is 41520. Apr 29 03:48:32 hermetic matrix-mautrix-signal-daemon[436286]: not chowning signald data directory, if you have permission issues see https://signald.org/articles/install/docker/#migrating-from-versions-before-0180 Apr 29 03:48:33 hermetic matrix-mautrix-signal-daemon[436286]: 03:48:33.429 [main] INFO io.finn.signald.Main - all data migrations complete Apr 29 03:48:33 hermetic matrix-mautrix-signal-daemon[436286]: 03:48:33.433 [main] INFO io.finn.signald.Main - Binding to socket /signald/signald.sock Apr 29 03:48:33 hermetic matrix-mautrix-signal-daemon[436286]: 03:48:33.472 [main] INFO io.finn.signald.Main - Started signald 0.23.1 Apr 29 03:49:28 hermetic matrix-mautrix-signal-daemon[436286]: 03:49:28.864 [connection-pid-0] INFO io.finn.signald.clientprotocol.ClientConnection - Client disconnected Apr 29 03:50:12 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:12.255 [f50e7bcb-4759-4a7a-ac6b-c018b3c19215-generate_linking_uri] INFO generate_linking_uri - handled request f50e7bcb-4759-4a7a-ac6b-c018b3c19215 successfully Apr 29 03:50:21 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:21.702 [69608015-e939-4da4-9752-3fe3b3ce3d2b-finish_link] INFO manager-[redacted 33]664 - Created a manager for [redacted 33]664 Apr 29 03:50:21 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:21.705 [69608015-e939-4da4-9752-3fe3b3ce3d2b-finish_link] INFO io.finn.signald.jobs.RefreshPreKeysJob - generating pre keys Apr 29 03:50:22 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:22.299 [69608015-e939-4da4-9752-3fe3b3ce3d2b-finish_link] INFO finish_link - handled request 69608015-e939-4da4-9752-3fe3b3ce3d2b successfully Apr 29 03:50:22 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:22.322 [4d3e2d81-4e98-4bfc-bd65-453341a9ad4b-subscribe] INFO subscribe - handled request 4d3e2d81-4e98-4bfc-bd65-453341a9ad4b successfully Apr 29 03:50:22 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:22.889 [c35c01fd-de55-4d58-900e-4394d8f5b365-list_contacts] INFO list_contacts - handled request c35c01fd-de55-4d58-900e-4394d8f5b365 successfully Apr 29 03:50:22 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:22.896 [45f5bddb-0f0b-4b0c-9cd9-fde6b7cef79d-list_groups] INFO list_groups - handled request 45f5bddb-0f0b-4b0c-9cd9-fde6b7cef79d successfully Apr 29 03:50:23 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:23.563 [[redacted 33]664-receiver] INFO manager-[redacted 33]664 - received contacts from device 1 Apr 29 03:50:23 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:23.583 [fe05f2b4-46d2-4aef-9283-85c0ae25169e-list_contacts] INFO list_contacts - handled request fe05f2b4-46d2-4aef-9283-85c0ae25169e successfully Apr 29 03:50:25 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:25.731 [b0279927-edff-4ddb-8d19-1613adaf33ba-list_groups] INFO list_groups - handled request b0279927-edff-4ddb-8d19-1613adaf33ba successfully Apr 29 03:50:25 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:25.832 [[redacted 33]664-receiver] INFO manager-[redacted 33]664 - received list of blocked users from device 1 Apr 29 03:50:25 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:25.982 [[redacted 33]664-receiver] INFO manager-[redacted 33]664 - received PNI identity key from device 1 Apr 29 03:50:27 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:27.160 [BackgroundJobRunnerThread] WARN io.finn.signald.jobs.BackgroundJobRunnerThread - error running io.finn.signald.jobs.SyncStorageDataJob Apr 29 03:50:27 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:27.250 [[redacted 33]664-receiver] INFO manager-[redacted 33]664 - received contacts from device 1 Apr 29 03:50:27 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:27.893 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:28 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:28.060 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:28 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:28.220 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:29 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:29.012 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:29 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:29.170 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:30 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:30.032 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:30 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:30.849 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:32 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:32.302 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:32 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:32.615 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:32 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:32.780 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:32 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:32.940 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:34 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:34.145 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:34 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:34.302 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:34 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:34.469 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:34 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:34.626 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:34 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:34.948 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:35 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:35.439 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:36 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:36.064 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:36 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:36.219 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:37 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:37.021 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:37 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:37.807 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:37 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:37.976 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:38 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:38.763 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.074 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.230 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.385 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.547 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.703 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:39 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:39.862 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.017 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.187 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.360 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.536 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.691 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.845 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:40 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:40.999 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:41 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:41.082 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:41 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:41.237 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:41 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:41.406 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:41 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:41.563 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:41 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:41.718 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:42 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:42.033 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:42 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:42.195 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:42 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:42.373 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:42 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:42.530 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:42 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:42.845 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:43 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:43.000 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:43 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:43.157 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:43 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:43.314 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:43 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:43.475 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:43 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:43.700 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.033 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.193 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.508 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.664 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.819 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:44 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:44.974 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.130 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.288 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.446 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.606 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.767 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:45 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:45.926 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:46 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:46.274 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:46 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:46.580 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:46 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:46.736 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:47 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:47.197 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:47 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:47.357 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:47 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:47.520 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:47 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:47.684 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:48 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:48.150 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:48 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:48.524 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:48 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:48.685 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:48 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:48.842 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:49 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:49.000 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:49 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:49.180 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:49 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:49.336 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:49 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:49.493 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:49 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:49.676 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:50 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:50.179 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:50 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:50.338 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:50 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:50.982 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:51 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:51.586 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:51 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:51.797 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:51 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:51.953 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:52 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:52.113 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:52 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:52.475 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:52 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:52.632 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:52 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:52.789 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.100 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.256 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.412 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.567 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.725 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:53 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:53.893 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:54 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:54.068 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:54 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:54.532 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.002 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.166 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.322 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.488 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.650 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.806 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:55 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:55.981 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:56 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:56.137 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as ENABLED after verification. Apr 29 03:50:56 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:56.315 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:56 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:56.470 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:56 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:56.626 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:56 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:56.783 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:57 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:57.110 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO io.finn.signald.jobs.RefreshProfileJob - Marking recipient UD status as disabled. Apr 29 03:50:57 hermetic matrix-mautrix-signal-daemon[436286]: 03:50:57.132 [cefd9e50-9a4d-4806-bba5-8251f23b63f1-list_contacts] INFO list_contacts - handled request cefd9e50-9a4d-4806-bba5-8251f23b63f1 successfully Apr 29 03:52:07 hermetic matrix-mautrix-signal-daemon[436286]: 03:52:07.484 [caa279dc-65a2-4a54-9d8f-5f677dda3af1-list_contacts] INFO list_contacts - handled request caa279dc-65a2-4a54-9d8f-5f677dda3af1 successfully Apr 29 03:52:07 hermetic matrix-mautrix-signal-daemon[436286]: 03:52:07.560 [546b99c3-c50e-47db-a642-ea1c272b12a6-list_groups] INFO list_groups - handled request 546b99c3-c50e-47db-a642-ea1c272b12a6 successfully Apr 29 03:53:23 hermetic matrix-mautrix-signal-daemon[436286]: 03:53:23.856 [3277dff1-87c5-49d3-9b8e-4788360dce87-list_contacts] INFO list_contacts - handled request 3277dff1-87c5-49d3-9b8e-4788360dce87 successfully Apr 29 03:53:23 hermetic matrix-mautrix-signal-daemon[436286]: 03:53:23.932 [366605d8-7a6f-402f-b420-05311d6682d3-list_groups] INFO list_groups - handled request 366605d8-7a6f-402f-b420-05311d6682d3 successfully Apr 29 04:01:23 hermetic matrix-mautrix-signal-daemon[436286]: 04:01:23.074 [320dfc7a-25d9-458d-98a5-1b1b13eb624a-get_linked_devices] WARN io.finn.signald.clientprotocol.v1.DeviceInfo - error decrypting name of linked device: Invalid DeviceInfo name. Apr 29 04:01:23 hermetic matrix-mautrix-signal-daemon[436286]: 04:01:23.076 [320dfc7a-25d9-458d-98a5-1b1b13eb624a-get_linked_devices] INFO get_linked_devices - handled request 320dfc7a-25d9-458d-98a5-1b1b13eb624a successfully ```
matrix-dendrite.service ``` Apr 29 03:48:38 hermetic matrix-dendrite[302321]: time="2023-04-29T03:48:38.819701676Z" level=info msg="Processing registration request" auth.type="" req.id=IwTyJnuBU2FG req.method=POST req.path=/_matrix/client/v3/register session_id="" username=signalbot Apr 29 03:49:35 hermetic matrix-dendrite[302321]: time="2023-04-29T03:49:35.983336495Z" level=info msg="Processing registration request" auth.type="" req.id=iz8zvtFpbeSw req.method=POST req.path=/_matrix/client/v3/register session_id="" username=signalbot Apr 29 03:50:11 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:11.367259043Z" level=info msg="Sent event to roomserver" event_id="$cG2wLJ4PpBbjQ9pYN5mWnPscdDnZ9B6tcSGN-X7TrHw" req.id=yrsLgsBbTcbu req.method=PUT req.path="/_matrix/client/r0/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/m1682740211243.34" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@isaiah:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.327551936Z" level=info msg="Uploading file" ContentType=image/png FileSizeBytes=1084 Origin=hermetic.chat UploadName=qr.png req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.328531538Z" level=info msg="File uploaded" Base64Hash=NVanbhulghuN6w97sONYBn9OCUoUcaB0r10bKfcPWDI ContentType=image/png FileSizeBytes=1084 Origin=hermetic.chat UploadName=qr.png media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.337651146Z" level=info msg="Generated thumbnail" ActualHeight=32 ActualWidth=32 Height=32 Origin=hermetic.chat ResizeMethod=crop Width=32 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 processTime=3.345256ms req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.338832631Z" level=info msg="Signalling other goroutines waiting for this goroutine to generate the thumbnail." Height=32 Origin=hermetic.chat ResizeMethod=crop Width=32 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.344257441Z" level=info msg="Generated thumbnail" ActualHeight=96 ActualWidth=96 Height=96 Origin=hermetic.chat ResizeMethod=crop Width=96 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 processTime=4.947376ms req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.345374543Z" level=info msg="Signalling other goroutines waiting for this goroutine to generate the thumbnail." Height=96 Origin=hermetic.chat ResizeMethod=crop Width=96 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.370816441Z" level=info msg="Generated thumbnail" ActualHeight=480 ActualWidth=480 Height=480 Origin=hermetic.chat ResizeMethod=scale Width=640 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 processTime=24.989984ms req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.380567463Z" level=info msg="Signalling other goroutines waiting for this goroutine to generate the thumbnail." Height=480 Origin=hermetic.chat ResizeMethod=scale Width=640 media_id=e7e159d0d403ec7e212334da16e9f2e374fdc0eca8c4ed86cd12d4e147a4c823 req.id=7R5FSM5W2mAi req.method=POST req.path=/_matrix/media/v3/upload user_id="@signalbot:hermetic.chat" Apr 29 03:50:12 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:12.387000318Z" level=info msg="Sent event to roomserver" event_id="$N_XVI1htNjUQaElElmCb9yZoZfPVTcABSMsfWSuYCoM" req.id=A7xY5T43jZVr req.method=PUT req.path="/_matrix/client/v3/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/mautrix-python_1682740212336370705_1" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@signalbot:hermetic.chat" Apr 29 03:50:22 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:22.354592089Z" level=info msg="Sent event to roomserver" event_id="$0OsKyKUH0cv56jFGNxAFNZLFp6Rz35OHRUh4bV2eUL4" req.id=0OQ1qyG8Kqyi req.method=PUT req.path="/_matrix/client/v3/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/mautrix-python_1682740222329876107_2" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@signalbot:hermetic.chat" Apr 29 03:50:57 hermetic matrix-dendrite[302321]: time="2023-04-29T03:50:57.240677384Z" level=info msg="Processing registration request" auth.type="" req.id=9tYcjfhAkeQj req.method=POST req.path=/_matrix/client/v3/register session_id="" username=signal_522e6bb2-2ea9-4c66-9142-e6e8beebf04d Apr 29 03:52:02 hermetic matrix-dendrite[302321]: time="2023-04-29T03:52:02.794824385Z" level=info msg="Sent event to roomserver" event_id="$Rk__KCkBzHJsd9i-b-DVL2RGnRn9Rkyo-d7nUWt368Y" req.id=seJquzjIltiq req.method=PUT req.path="/_matrix/client/r0/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/m1682740322681.35" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@isaiah:hermetic.chat" Apr 29 03:52:07 hermetic matrix-dendrite[302321]: time="2023-04-29T03:52:07.582663364Z" level=info msg="Sent event to roomserver" event_id="$J7DjgFv_JTNgwhm005IcVzjVpgnVT4QNdRNzlwkNB2k" req.id=B2S1OcZv6D3F req.method=PUT req.path="/_matrix/client/v3/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/mautrix-python_1682740327563846910_4" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@signalbot:hermetic.chat" Apr 29 03:53:19 hermetic matrix-dendrite[302321]: time="2023-04-29T03:53:19.086055490Z" level=info msg="Sent event to roomserver" event_id="$yzbjy0lyeoJPeeO7E7TkZQ4QLOSayHZYMAPogUkmmXo" req.id=RYnxSzsFgFZX req.method=PUT req.path="/_matrix/client/r0/rooms/!KxksSW7GJ52Th7Qj:hermetic.chat/send/m.room.message/m1682740398963.36" room_id="!KxksSW7GJ52Th7Qj:hermetic.chat" room_version=10 user_id="@isaiah:hermetic.chat" Apr 29 03:53:23 hermetic matrix-dendrite[302321]: time="2023-04-29T03:53:23.949276219Z" level=info msg="Sent event to roomserver" event_id="$zhcS7bx2SYeN-8ybZ_LH_G6jE-I4P8ys3HTV6WmJrfc" req.id=0jN9QAvhENxc req.method=PUT req.path="/_matrix/client/v3/rooms/!KxksSW7GJ52Th7Qj:hermetic.chat/send/m.room.message/mautrix-python_1682740403934956132_5" room_id="!KxksSW7GJ52Th7Qj:hermetic.chat" room_version=10 user_id="@signalbot:hermetic.chat" Apr 29 04:01:22 hermetic matrix-dendrite[302321]: time="2023-04-29T04:01:22.561052967Z" level=info msg="Sent event to roomserver" event_id="$byJQBKoMrC8N6OcjeZH_4BFpV5cdWmYgYbmWaSSSiWA" req.id=1aMSqQu6NL6I req.method=PUT req.path="/_matrix/client/r0/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/m1682740882461.37" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@isaiah:hermetic.chat" Apr 29 04:01:23 hermetic matrix-dendrite[302321]: time="2023-04-29T04:01:23.098500379Z" level=info msg="Sent event to roomserver" event_id="$lVkILbFXtddgi-iCSM7fc3eJCvsCOfCA-CZ-7q4DVfQ" req.id=bDBQnWeGhO3n req.method=PUT req.path="/_matrix/client/v3/rooms/!gBDmCDDJdMIAE1Ns:hermetic.chat/send/m.room.message/mautrix-python_1682740883080490114_6" room_id="!gBDmCDDJdMIAE1Ns:hermetic.chat" room_version=10 user_id="@signalbot:hermetic.chat" ```
ibeckermayer commented 1 year ago

I'm noticing that an apparent attempt at a migration fails according to the systemctl logs

● matrix-mautrix-signal-daemon.service - Matrix Mautrix Signal daemon
     Loaded: loaded (/etc/systemd/system/matrix-mautrix-signal-daemon.service; enabled; vendor preset: enabled)
     Active: active (running) since Sat 2023-04-29 04:57:09 UTC; 18min ago
    Process: 460939 ExecStartPre=/usr/bin/env sh -c /usr/bin/env docker kill matrix-mautrix-signal-daemon 2>/dev/null || true (code=exited, status=0/SUCCESS)
    Process: 460961 ExecStartPre=/usr/bin/env sh -c /usr/bin/env docker rm matrix-mautrix-signal-daemon 2>/dev/null || true (code=exited, status=0/SUCCESS)
    Process: 460983 ExecStartPre=/usr/bin/env sleep 5 (code=exited, status=0/SUCCESS)
    Process: 460984 ExecStartPre=/usr/bin/env docker run --rm --name matrix-mautrix-signal-daemon --log-driver=none --user=998:1000 --cap-drop=ALL --network=matrix -v /matrix/mautrix-signal/signald:/signald:z docker.io/signald/signald:0.23.1 --migrate-data (code=exited, status=1/FAILURE)
   Main PID: 461166 (docker)
      Tasks: 9 (limit: 9255)
     Memory: 7.9M
        CPU: 305ms
     CGroup: /system.slice/matrix-mautrix-signal-daemon.service
             └─461166 docker run --rm --name matrix-mautrix-signal-daemon --log-driver=none --env-file=/matrix/mautrix-signal/signald/env --user=998:1000 --cap-drop=ALL --network=matrix -v /matrix/mautrix-signal/signald:/signald:z docker.io/signald/signald:0.23.1
ibeckermayer commented 1 year ago

After messing around a bunch, including removing and then relinking my device several times, as well as resetting (deleting) the signald database, I realized that I was getting an empty list when querying for the groups in my account. I hunted down that another user was having this same issue with signald 0.23.1, which was fixed by updating to signald 0.23.2.

After doing so, groups were showing up, but my rooms were failing to update properly. I was getting messages from some users, but not others. In looking in the mautrix-signal logs, I found a bunch of errors that looked like

mautrix.errors.request.MForbidden: user does not belong to room

I decided that this was probably due to some internal state of mautrix signal getting messed up due to all of my manual tinkering with signald, and so I should just reset everything. I wrote down some instructions to myself to help me remember what's going on in case I run into a similar situation again, which I will post here in case anybody else runs into a similar problem.

Some of these instructions are specific to matrix-docker-ansible-deploy, but should be able to be pattern matched to other flavors of deployment:

How to completely reset mautrix signal

Ensure that mautrix-signal and signald services are stopped

systemctl stop matrix-mautrix-signal.service
systemctl stop matrix-mautrix-signal-daemon.service

Clear the mautrix-signal database

Mautrix signal stores its data in the postgres database managed by matrix-postgres.service. The credentials for the admin user for this database can be found by running

cat /matrix/postgres/env-postgres-psql

and taking PGUSER (matrix by default) and PGPASSWORD.

You can user these credentials to get an interactive psql shell to the database by running

docker exec -it matrix-postgres psql -U matrix -W

Then, you can drop the tables related to mautrix signal by running

DROP DATABASE IF EXISTS matrix_mautrix_signal;
DROP USER IF EXISTS matrix_mautrix_signal;

Clear signald data and remove mautrix signal configuration

All the rest of the persisted data on the system is held under /matrix/mautrix-signal/. Remove it by simply running

rm -rf /matrix/mautrix-signal/

Remove bridge as linked device in Signal

This is not essential, but for a clean reset do this. Specific instructions beyond scope, just google "Signal linked devices".

Rerun matrix-docker-ansible-deploy

just setup-all 2>&1 | tee /tmp/matrix-docker-ansible-deploy.out.log

Re-set-up everything

Now everything should be reset, continue with mautrix signal setup.