Hi, I am having some issues with the “send autocrypt message” feature.
Delta Chat version
0.510.1
Expected behavior
When you click on the Settings - Advanced - Send Autocrypt Setup Message, a security number should appear.
Actual behavior
A progress window appears with the text “One moment…” and the spinner. The options in the window I have is to click on the cancel button. I have let it work of quite some time without any luck. The security number never appears.
Steps to reproduce the problem
- Enter settings -> Advanced
- Click on the Send Autoencrypt Setup Message
- Confirm that you want to send the autoencrypt setup message.
- Progress window appears but never completes.
- A message is created but because the security number never appears it’s not possible to continue.
Debug logs
device=Fairphone FP2 (FP2)
android=7.1.2 (gms-404195ba, 19.05.3)
sdk=25
memory=13M (8.90% free, 512M max)
memoryClass=192
host=lxc-slave05
applicationId=chat.delta
app=Delta Chat 0.510.1-gplay
installer=com.android.vending
ignoreBatteryOptimizations=false
deltachat_core_version=v0.45.0
sqlite_version=3.26.0
sqlite_thread_safe=1
libetpan_version=1.8
openssl_version=1.0.1t
rpgp_enabled=0
compile_date=Jul 9 2019, 17:20:36
arch=32
number_of_chats=3
number_of_chat_messages=18
messages_in_contact_requests=0
number_of_contacts=150
database_dir=/data/user/0/chat.delta/files/messenger.db
database_version=55
blobdir=/data/user/0/chat.delta/files/messenger.db-blobs
display_name=0
is_configured=1
entered_account_settings=example@example_com example@example_com:***:imap_example_com:993 example@example_com:***:smtp_example_com:587 IMAP_SSL SMTP_STARTTLS
used_account_settings=example@example_com example@example_com:***:imap_example_com:993 example@example_com:***:smtp_example_com:587 AUTH_NORMAL IMAP_SSL SMTP_STARTTLS
inbox_watch=1
sentbox_watch=1
mvbox_watch=1
mvbox_move=1
folders_configured=3
configured_sentbox_folder=Sent
configured_mvbox_folder=DeltaChat
show_emails=0
mdns_enabled=1
e2ee_enabled=1
private_key_count=1
public_key_count=2
fingerprint=AA9A2DC10EB2BD4770B510F049114F075DF967A0
--------- beginning of main
08-02 21:31:18.535 17618 17651 I DeltaChat: INBOX-fetch started…
08-02 21:31:18.579 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:31:18.579 17618 17652 I DeltaChat: MVBOX-fetch done in 16 ms.
08-02 21:31:18.580 17618 17652 I DeltaChat: MVBOX-IDLE will not be started as it was interrupted while not ideling.
08-02 21:31:18.580 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:31:18.587 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:31:18.587 17618 17653 I DeltaChat: SENTBOX-fetch done in 19 ms.
08-02 21:31:18.590 17618 17653 I DeltaChat: SENTBOX-IDLE will not be started as it was interrupted while not ideling.
08-02 21:31:18.591 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:31:18.596 17618 17651 I DeltaChat: 0 mails read from “INBOX”.
08-02 21:31:18.596 17618 17651 I DeltaChat: INBOX-fetch done in 17 ms.
08-02 21:31:18.597 17618 17651 I DeltaChat: INBOX-IDLE started…
08-02 21:31:18.640 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:31:18.640 17618 17652 I DeltaChat: MVBOX-fetch done in 17 ms.
08-02 21:31:18.642 17618 17652 I DeltaChat: MVBOX-IDLE started…
08-02 21:31:18.647 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:31:18.647 17618 17653 I DeltaChat: SENTBOX-fetch done in 13 ms.
08-02 21:31:18.648 17618 17653 I DeltaChat: SENTBOX-IDLE started…
08-02 21:32:02.000 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:32:02.001 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:32:02.002 17618 17654 I DeltaChat: SMTP-job #51, action 5901 started…
08-02 21:32:02.433 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:03.931 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:05.331 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:06.904 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:06.945 17618 17654 I DeltaChat: SMTP-job #51 not succeeded on try #3, retry in ADD_TIME+43 (in -76 seconds).
08-02 21:32:06.945 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:32:06.946 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:32:06.946 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:32:06.947 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:32:06.947 17618 17654 I DeltaChat: SMTP-job #51, action 5901 started…
08-02 21:32:07.394 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:08.872 17618 17618 W PassphraseRequiredActionBarActivity: onPause()
08-02 21:32:08.948 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:09.384 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:10.026 17618 17618 I DeltaChat: -------------------- Screen off --------------------
08-02 21:32:10.038 17618 17618 I DeltaChat: *** KeepAliveService.onCreate()
08-02 21:32:10.051 17618 17618 I DeltaChat: *** KeepAliveService.onStartCommand()
08-02 21:32:11.103 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:11.158 17618 17654 I DeltaChat: SMTP-job #51 not succeeded on try #4, retry in ADD_TIME+34 (in -90 seconds).
08-02 21:32:11.158 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:32:11.161 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:32:11.164 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:32:11.166 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:32:11.167 17618 17654 I DeltaChat: SMTP-job #51, action 5901 started…
08-02 21:32:11.312 17618 17618 W PassphraseRequiredActionBarActivity: onResume()
08-02 21:32:11.328 17618 17618 I DeltaChat: *** KeepAliveService.onDestroy()
08-02 21:32:11.427 17618 17618 I DeltaChat: -------------------- Screen on --------------------
08-02 21:32:11.641 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:13.352 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:13.801 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:32:15.292 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:32:15.334 17618 17654 I DeltaChat: SMTP-job #51 not succeeded on try #5, retry in ADD_TIME+442 (in 314 seconds).
08-02 21:32:15.334 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:32:15.335 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:33:03.178 17618 17653 I DeltaChat: IMAP-IDLE has data.
08-02 21:33:03.178 17618 17653 I DeltaChat: SENTBOX-IDLE ended.
08-02 21:33:03.179 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:33:03.235 17618 17652 I DeltaChat: IMAP-IDLE has data.
08-02 21:33:03.235 17618 17652 I DeltaChat: MVBOX-IDLE ended.
08-02 21:33:03.235 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:33:03.236 17618 17653 I DeltaChat: SENTBOX-fetch done in 11 ms.
08-02 21:33:03.237 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:33:03.237 17618 17653 I DeltaChat: SENTBOX-IDLE started…
08-02 21:33:03.296 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:33:03.296 17618 17652 I DeltaChat: MVBOX-fetch done in 11 ms.
08-02 21:33:03.298 17618 17652 I DeltaChat: MVBOX-IDLE started…
08-02 21:33:18.747 17618 17651 I DeltaChat: IMAP-IDLE has data.
08-02 21:33:18.748 17618 17651 I DeltaChat: INBOX-IDLE ended.
08-02 21:33:18.749 17618 17651 I DeltaChat: INBOX-jobs started…
08-02 21:33:18.749 17618 17651 I DeltaChat: INBOX-jobs ended.
08-02 21:33:18.750 17618 17651 I DeltaChat: INBOX-fetch started…
08-02 21:33:18.806 17618 17651 I DeltaChat: 0 mails read from “INBOX”.
08-02 21:33:18.806 17618 17651 I DeltaChat: INBOX-fetch done in 11 ms.
08-02 21:33:18.808 17618 17651 I DeltaChat: INBOX-IDLE started…
08-02 21:33:53.212 17618 17618 I DeltaChat: Signaling the ongoing process to stop ASAP.
08-02 21:35:02.530 17618 17652 I DeltaChat: IMAP-IDLE has data.
08-02 21:35:02.530 17618 17652 I DeltaChat: MVBOX-IDLE ended.
08-02 21:35:02.531 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:35:02.538 17618 17653 I DeltaChat: IMAP-IDLE has data.
08-02 21:35:02.538 17618 17653 I DeltaChat: SENTBOX-IDLE ended.
08-02 21:35:02.545 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:35:02.594 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:35:02.594 17618 17652 I DeltaChat: MVBOX-fetch done in 3 ms.
08-02 21:35:02.595 17618 17652 I DeltaChat: MVBOX-IDLE started…
08-02 21:35:02.599 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:35:02.599 17618 17653 I DeltaChat: SENTBOX-fetch done in 2 ms.
08-02 21:35:02.600 17618 17653 I DeltaChat: SENTBOX-IDLE started…
08-02 21:35:07.194 17618 17618 W PassphraseRequiredActionBarActivity: onPause()
08-02 21:35:07.384 17618 24680 D OpenGLRenderer: endAllActiveAnimators on 0x8b785680 (RippleDrawable) with handle 0xa877f000
08-02 21:35:07.434 17618 32424 D Scrubber: scrubbing input
08-02 21:35:19.139 17618 17651 I DeltaChat: IMAP-IDLE has data.
08-02 21:35:19.139 17618 17651 I DeltaChat: INBOX-IDLE ended.
08-02 21:35:19.140 17618 17651 I DeltaChat: INBOX-jobs started…
08-02 21:35:19.141 17618 17651 I DeltaChat: INBOX-jobs ended.
08-02 21:35:19.141 17618 17651 I DeltaChat: INBOX-fetch started…
08-02 21:35:19.196 17618 17651 I DeltaChat: 0 mails read from “INBOX”.
08-02 21:35:19.197 17618 17651 I DeltaChat: INBOX-fetch done in 3 ms.
08-02 21:35:19.198 17618 17651 I DeltaChat: INBOX-IDLE started…
08-02 21:36:09.676 17618 17618 W PassphraseRequiredActionBarActivity: onResume()
08-02 21:36:09.728 17618 17618 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
08-02 21:36:14.662 17618 1040 I DeltaChat: Attaching “$BLOBDIR/autocrypt-setup-message-5.html” for message type #60.
08-02 21:36:14.776 17618 1040 I DeltaChat: Interrupting SMTP-idle…
08-02 21:36:14.776 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:36:14.776 17618 1040 I DeltaChat: Wait for setup message being sent …
08-02 21:36:14.777 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:36:14.777 17618 17654 I DeltaChat: SMTP-job #52, action 5901 started…
08-02 21:36:15.241 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:36:16.864 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:36:17.272 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:36:18.760 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:36:18.788 17618 17654 I DeltaChat: SMTP-job #52 not succeeded on try #1, retry in ADD_TIME+46 (in 42 seconds).
08-02 21:36:18.788 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:36:18.789 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:36:31.035 17618 17618 I DeltaChat: -------------------- on receive timer --------------------
08-02 21:36:31.038 17618 17618 I DeltaChat: Interrupting IMAP-IDLE…
08-02 21:36:31.039 17618 17618 I DeltaChat: Interrupting MVBOX-IDLE…
08-02 21:36:31.039 17618 17618 I DeltaChat: Interrupting SENTBOX-IDLE…
08-02 21:36:32.633 17618 17652 I DeltaChat: IMAP-IDLE interrupted.
08-02 21:36:32.633 17618 17652 I DeltaChat: MVBOX-IDLE ended.
08-02 21:36:32.633 17618 17651 I DeltaChat: IMAP-IDLE interrupted.
08-02 21:36:32.633 17618 17651 I DeltaChat: INBOX-IDLE ended.
08-02 21:36:32.638 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:36:32.640 17618 17651 I DeltaChat: INBOX-jobs started…
08-02 21:36:32.641 17618 17651 I DeltaChat: INBOX-jobs ended.
08-02 21:36:32.642 17618 17651 I DeltaChat: INBOX-fetch started…
08-02 21:36:32.656 17618 17653 I DeltaChat: IMAP-IDLE interrupted.
08-02 21:36:32.656 17618 17653 I DeltaChat: SENTBOX-IDLE ended.
08-02 21:36:32.666 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:36:32.714 17618 17651 I DeltaChat: 0 mails read from “INBOX”.
08-02 21:36:32.715 17618 17651 I DeltaChat: INBOX-fetch done in 31 ms.
08-02 21:36:32.716 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:36:32.717 17618 17652 I DeltaChat: MVBOX-fetch done in 34 ms.
08-02 21:36:32.719 17618 17651 I DeltaChat: INBOX-IDLE started…
08-02 21:36:32.720 17618 17652 I DeltaChat: MVBOX-IDLE will not be started as it was interrupted while not ideling.
08-02 21:36:32.721 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:36:32.733 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:36:32.733 17618 17653 I DeltaChat: SENTBOX-fetch done in 27 ms.
08-02 21:36:32.735 17618 17653 I DeltaChat: SENTBOX-IDLE will not be started as it was interrupted while not ideling.
08-02 21:36:32.737 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:36:32.780 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:36:32.780 17618 17652 I DeltaChat: MVBOX-fetch done in 15 ms.
08-02 21:36:32.782 17618 17652 I DeltaChat: MVBOX-IDLE started…
08-02 21:36:32.791 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:36:32.791 17618 17653 I DeltaChat: SENTBOX-fetch done in 13 ms.
08-02 21:36:32.792 17618 17653 I DeltaChat: SENTBOX-IDLE started…
08-02 21:36:46.504 17618 17618 I DeltaChat: Signaling the ongoing process to stop ASAP.
08-02 21:36:49.287 17618 17618 W PassphraseRequiredActionBarActivity: onPause()
08-02 21:36:49.459 17618 24680 D OpenGLRenderer: endAllActiveAnimators on 0x8d625c80 (RippleDrawable) with handle 0x8d6e58c0
08-02 21:36:49.461 17618 1457 D Scrubber: scrubbing input
08-02 21:37:01.000 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:37:01.001 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:37:01.002 17618 17654 I DeltaChat: SMTP-job #52, action 5901 started…
08-02 21:37:01.413 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:02.977 17618 17652 I DeltaChat: IMAP-IDLE has data.
08-02 21:37:02.977 17618 17652 I DeltaChat: MVBOX-IDLE ended.
08-02 21:37:02.982 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:02.983 17618 17652 I DeltaChat: MVBOX-fetch started…
08-02 21:37:02.995 17618 17653 I DeltaChat: IMAP-IDLE has data.
08-02 21:37:02.995 17618 17653 I DeltaChat: SENTBOX-IDLE ended.
08-02 21:37:02.996 17618 17653 I DeltaChat: SENTBOX-fetch started…
08-02 21:37:03.039 17618 17652 I DeltaChat: 0 mails read from “DeltaChat”.
08-02 21:37:03.040 17618 17652 I DeltaChat: MVBOX-fetch done in 9 ms.
08-02 21:37:03.040 17618 17652 I DeltaChat: MVBOX-IDLE started…
08-02 21:37:03.049 17618 17653 I DeltaChat: 0 mails read from “Sent”.
08-02 21:37:03.050 17618 17653 I DeltaChat: SENTBOX-fetch done in 3 ms.
08-02 21:37:03.051 17618 17653 I DeltaChat: SENTBOX-IDLE started…
08-02 21:37:03.477 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:05.097 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:05.150 17618 17654 I DeltaChat: SMTP-job #52 not succeeded on try #2, retry in ADD_TIME+37 (in -14 seconds).
08-02 21:37:05.151 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:37:05.154 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:37:05.155 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:37:05.160 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:37:05.161 17618 17654 I DeltaChat: SMTP-job #52, action 5901 started…
08-02 21:37:05.626 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:07.144 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:07.605 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:09.108 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:09.144 17618 17654 I DeltaChat: SMTP-job #52 not succeeded on try #3, retry in ADD_TIME+222 (in 167 seconds).
08-02 21:37:09.144 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:37:09.145 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:37:14.373 17618 17618 W IInputConnectionWrapper: reportFullscreenMode on inexistent InputConnection
08-02 21:37:14.373 17618 17618 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
08-02 21:37:18.908 17618 17651 I DeltaChat: IMAP-IDLE has data.
08-02 21:37:18.908 17618 17651 I DeltaChat: INBOX-IDLE ended.
08-02 21:37:18.914 17618 17651 I DeltaChat: INBOX-jobs started…
08-02 21:37:18.915 17618 17651 I DeltaChat: INBOX-jobs ended.
08-02 21:37:18.916 17618 17651 I DeltaChat: INBOX-fetch started…
08-02 21:37:18.975 17618 17651 I DeltaChat: 0 mails read from “INBOX”.
08-02 21:37:18.976 17618 17651 I DeltaChat: INBOX-fetch done in 5 ms.
08-02 21:37:18.980 17618 17651 I DeltaChat: INBOX-IDLE started…
08-02 21:37:30.000 17618 17654 I DeltaChat: SMTP-idle ended.
08-02 21:37:30.003 17618 17654 I DeltaChat: SMTP-jobs started…
08-02 21:37:30.004 17618 17654 I DeltaChat: SMTP-job #51, action 5901 started…
08-02 21:37:30.418 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:34.052 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:34.463 17618 17654 I DeltaChat: SMTP-server smtp_example_com:587 STARTTLS-connected.
08-02 21:37:36.018 17618 17654 W DeltaChat: SMTP failed to send message: Unexpected error code: 5.7.1 Reject for policy reason
08-02 21:37:36.049 17618 17654 I DeltaChat: SMTP-job #51 not succeeded on try #6, retry in ADD_TIME+1880 (in 1431 seconds).
08-02 21:37:36.049 17618 17654 I DeltaChat: SMTP-jobs ended.
08-02 21:37:36.050 17618 17654 I DeltaChat: SMTP-idle started…
08-02 21:38:33.254 17618 17618 W PassphraseRequiredActionBarActivity: onDestroy()
08-02 21:38:33.365 17618 17618 W PassphraseRequiredActionBarActivity: onResume()
08-02 21:38:36.222 17618 17618 W PassphraseRequiredActionBarActivity: onPause()
08-02 21:38:36.239 17618 17618 W PassphraseRequiredActionBarActivity: onCreate(null)
08-02 21:38:36.288 17618 17618 W PassphraseRequiredActionBarActivity: onResume()
08-02 21:38:36.456 17618 24680 D OpenGLRenderer: endAllActiveAnimators on 0x8b788b00 (MenuPopupWindow$MenuDropDownListView) with handle 0x8d67f780
08-02 21:38:53.311 17618 17618 W PassphraseRequiredActionBarActivity: onPause()