polhenarejos / acme_email

ACME Email Client for EmailReply-00 Challenge
https://acme.castle.cloud
GNU General Public License v3.0
46 stars 7 forks source link

Fails with error: too many values to unpack (expected 2) #38

Closed realpixelcode closed 6 months ago

realpixelcode commented 7 months ago

Here's the terminal command I used:

python3 cli.py cert --config-dir . --work-dir . --logs-dir . -e pixelcode@dismail.de --contact me@example.org --imap --login pixelcode@dismail.de --password "abc" --host imap.dismail.de --ssl --smtp-method STARTTLS --smtp-port 587 --smtp-host smtp.dismail.de --passphrase "xyz"

And here's the error log it produced:

2024-02-06 23:14:29,397:DEBUG:certbot._internal.log:Root logging level set at 30
2024-02-06 23:14:29,410:DEBUG:certbot._internal.display.obj:Notifying user: You are requesting a S/MIME certificate to CASTLE ACME server. Remember to add
the root certificate into your trust store for proper operation.
2024-02-06 23:14:29,434:DEBUG:certbot.crypto_util:Generating RSA key (2048 bits): /home/pixelcode/Applications/acme_email/keys/0007_key-certbot.pem
2024-02-06 23:14:29,480:DEBUG:certbot_castle.csr:Creating CSR: /home/pixelcode/Applications/acme_email/csr/0007_csr-certbot.pem
2024-02-06 23:14:29,489:DEBUG:certbot._internal.plugins.selection:Requested authenticator castle-imap and installer castle-installer
2024-02-06 23:14:29,489:DEBUG:certbot._internal.plugins.selection:Single candidate plugin: * castle-installer
Description: Generates PKCS12 container from S/MIME challenge
Interfaces: Installer, Plugin
Entry point: EntryPoint(name='castle-installer', value='certbot_castle.plugins.installer:Installer', group='certbot.plugins')
Initialized: <certbot_castle.plugins.installer.Installer object at 0x7f515c8af2e0>
Prep: True
2024-02-06 23:14:29,876:DEBUG:imapclient.imapclient:Connected to host imap.dismail.de over SSL/TLS
2024-02-06 23:14:29,876:DEBUG:imapclient.imaplib:> b'DGBC1 LOGIN **REDACTED**
2024-02-06 23:14:30,052:DEBUG:imapclient.imaplib:< b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA'
2024-02-06 23:14:30,052:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'CAPABILITY', b' IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA', b'IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA')
2024-02-06 23:14:30,052:DEBUG:imapclient.imaplib:untagged_responses[CAPABILITY] 0 += ["b'IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA'"]
2024-02-06 23:14:30,053:DEBUG:imapclient.imaplib:< b'DGBC1 OK Logged in'
2024-02-06 23:14:30,053:DEBUG:imapclient.imaplib:   matched b'(?P<tag>DGBC\\d+) (?P<type>[A-Z]+) (?P<data>.*)' => (b'DGBC1', b'OK', b'Logged in')
2024-02-06 23:14:30,053:DEBUG:imapclient.imapclient:Logged in as pixelcode@dismail.de
2024-02-06 23:14:30,053:DEBUG:imapclient.imaplib:> b'DGBC2 SELECT "INBOX"'
2024-02-06 23:14:30,084:DEBUG:imapclient.imaplib:< b'* FLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled)'
2024-02-06 23:14:30,084:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'FLAGS', b' (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled)', b'(\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled)')
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:untagged_responses[FLAGS] 0 += ["b'(\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled)'"]
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:< b'* OK [PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)] Flags permitted.'
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'OK', b' [PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)] Flags permitted.', b'[PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)] Flags permitted.')
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:untagged_responses[OK] 0 += ["b'[PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)] Flags permitted.'"]
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'PERMANENTFLAGS', b' (\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)', b'(\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)')
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:untagged_responses[PERMANENTFLAGS] 0 += ["b'(\\Answered \\Flagged \\Deleted \\Seen \\Draft Junk NonJunk NOTJUNK receipt-handled \\*)'"]
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:< b'* 242 EXISTS'
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:   matched b'\\* (?P<data>\\d+) (?P<type>[A-Z-]+)( (?P<data2>.*))?' => (b'242', b'EXISTS', None, None)
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:untagged_responses[EXISTS] 0 += ["b'242'"]
2024-02-06 23:14:30,085:DEBUG:imapclient.imaplib:< b'* 0 RECENT'
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:   matched b'\\* (?P<data>\\d+) (?P<type>[A-Z-]+)( (?P<data2>.*))?' => (b'0', b'RECENT', None, None)
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:untagged_responses[RECENT] 0 += ["b'0'"]
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:< b'* OK [UNSEEN 208] First unseen.'
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'OK', b' [UNSEEN 208] First unseen.', b'[UNSEEN 208] First unseen.')
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:untagged_responses[OK] 1 += ["b'[UNSEEN 208] First unseen.'"]
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'UNSEEN', b' 208', b'208')
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:untagged_responses[UNSEEN] 0 += ["b'208'"]
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:< b'* OK [UIDVALIDITY 1604507957] UIDs valid'
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'OK', b' [UIDVALIDITY 1604507957] UIDs valid', b'[UIDVALIDITY 1604507957] UIDs valid')
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:untagged_responses[OK] 2 += ["b'[UIDVALIDITY 1604507957] UIDs valid'"]
2024-02-06 23:14:30,086:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'UIDVALIDITY', b' 1604507957', b'1604507957')
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:untagged_responses[UIDVALIDITY] 0 += ["b'1604507957'"]
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:< b'* OK [UIDNEXT 2020] Predicted next UID'
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'OK', b' [UIDNEXT 2020] Predicted next UID', b'[UIDNEXT 2020] Predicted next UID')
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:untagged_responses[OK] 3 += ["b'[UIDNEXT 2020] Predicted next UID'"]
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'UIDNEXT', b' 2020', b'2020')
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:untagged_responses[UIDNEXT] 0 += ["b'2020'"]
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:< b'* OK [HIGHESTMODSEQ 3366] Highest'
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'OK', b' [HIGHESTMODSEQ 3366] Highest', b'[HIGHESTMODSEQ 3366] Highest')
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:untagged_responses[OK] 4 += ["b'[HIGHESTMODSEQ 3366] Highest'"]
2024-02-06 23:14:30,087:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'HIGHESTMODSEQ', b' 3366', b'3366')
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:untagged_responses[HIGHESTMODSEQ] 0 += ["b'3366'"]
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:< b'DGBC2 OK [READ-WRITE] Select completed (0.006 + 0.000 + 0.006 secs).'
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:   matched b'(?P<tag>DGBC\\d+) (?P<type>[A-Z]+) (?P<data>.*)' => (b'DGBC2', b'OK', b'[READ-WRITE] Select completed (0.006 + 0.000 + 0.006 secs).')
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:   matched b'\\[(?P<type>[A-Z-]+)( (?P<data>.*))?\\]' => (b'READ-WRITE', None, None)
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:untagged_responses[READ-WRITE] 0 += ["b''"]
2024-02-06 23:14:30,088:DEBUG:imapclient.imaplib:> b'DGBC3 CAPABILITY'
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:< b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA'
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'CAPABILITY', b' IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA', b'IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA')
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:untagged_responses[CAPABILITY] 0 += ["b'IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA'"]
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:< b'DGBC3 OK Capability completed (0.001 + 0.000 secs).'
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:   matched b'(?P<tag>DGBC\\d+) (?P<type>[A-Z]+) (?P<data>.*)' => (b'DGBC3', b'OK', b'Capability completed (0.001 + 0.000 secs).')
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:untagged_responses[CAPABILITY] => [b'IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE QUOTA']
2024-02-06 23:14:30,116:DEBUG:imapclient.imaplib:> b'DGBC4 IDLE'
2024-02-06 23:14:30,149:DEBUG:imapclient.imaplib:< b'+ idling'
2024-02-06 23:14:30,150:DEBUG:imapclient.imaplib:   matched b'\\+( (?P<data>.*))?' => (b' idling', b'idling')
2024-02-06 23:15:26,642:DEBUG:certbot._internal.plugins.selection:Single candidate plugin: * castle-imap
Description: Automatic S/MIME challenge by using IMAP integration
Interfaces: Authenticator, Plugin
Entry point: EntryPoint(name='castle-imap', value='certbot_castle.plugins.imap:Authenticator', group='certbot.plugins')
Initialized: <certbot_castle.plugins.imap.Authenticator object at 0x7f515c8afe20>
Prep: True
2024-02-06 23:15:26,642:DEBUG:certbot._internal.plugins.selection:Selected authenticator <certbot_castle.plugins.imap.Authenticator object at 0x7f515c8afe20> and installer <certbot_castle.plugins.installer.Installer object at 0x7f515c8af2e0>
2024-02-06 23:15:26,642:INFO:certbot._internal.plugins.selection:Plugins selected: Authenticator castle-imap, Installer castle-installer
2024-02-06 23:15:26,715:DEBUG:certbot._internal.main:Picked account: <Account(RegistrationResource(body=Registration(key=None, contact=(), agreement=None, status=None, terms_of_service_agreed=None, only_return_existing=None, external_account_binding=None), uri='https://acme.castle.cloud/acme/acct/bsHWK6nbaOG', new_authzr_uri=None, terms_of_service=None), 0c1be56ef9bd06a1493d560f07392e52, Meta(creation_dt=datetime.datetime(2024, 2, 6, 21, 46, 5, tzinfo=<UTC>), creation_host='dell-zorin', register_to_eff=None))>
2024-02-06 23:15:26,715:DEBUG:acme.client:Sending GET request to https://acme.castle.cloud/acme/directory.
2024-02-06 23:15:26,717:DEBUG:urllib3.connectionpool:Starting new HTTPS connection (1): acme.castle.cloud:443
2024-02-06 23:15:27,382:DEBUG:urllib3.connectionpool:https://acme.castle.cloud:443 "GET /acme/directory HTTP/1.1" 200 None
2024-02-06 23:15:27,383:DEBUG:acme.client:Received response:
HTTP 200
Date: Tue, 06 Feb 2024 22:15:27 GMT
Content-Type: application/json
Transfer-Encoding: chunked
Connection: keep-alive
x-frame-options: DENY
x-content-type-options: nosniff
referrer-policy: same-origin
vary: Origin
access-control-allow-origin: *
strict-transport-security: max-age=7776000
CF-Cache-Status: DYNAMIC
Report-To: {"endpoints":[{"url":"https:\/\/a.nel.cloudflare.com\/report\/v3?s=IZRyTM7dmXbAQ8R%2Bm5rCmdBO5RZzjEYvrKnr28NQhQFfiuEUofSqioH8EQml0N%2F7OKnXF0NPtAA%2BpLutce1ZhnyNxvq%2F6CU%2FIJW70Fd7AsrEyQF5H3dxW6V17J2c%2FHIZ6aNUspB8BYtPBmGj9J2UHg%3D%3D"}],"group":"cf-nel","max_age":604800}
NEL: {"success_fraction":0,"report_to":"cf-nel","max_age":604800}
Server: cloudflare
CF-RAY: 8516c07ae9501961-FRA
Content-Encoding: gzip
alt-svc: h3=":443"; ma=86400

{"Mm6uOfdzAcX": "https://community.letsencrypt.org/t/adding-random-entries-to-the-directory/33417", "keyChange": "https://acme.castle.cloud/acme/key-change", "meta": {"caaIdentities": ["castle.cloud"], "termsOfService": "https://acme.castle.cloud/terms-of-service/", "website": "https://acme.castle.cloud/acme/directory"}, "newAccount": "https://acme.castle.cloud/acme/new-acct", "newNonce": "https://acme.castle.cloud/acme/new-nonce", "newOrder": "https://acme.castle.cloud/acme/new-order", "revokeCert": "https://acme.castle.cloud/acme/revoke-cert"}
2024-02-06 23:15:27,384:DEBUG:certbot._internal.display.obj:Notifying user: Requesting a certificate for pixelcode@dismail.de
2024-02-06 23:15:27,384:DEBUG:certbot._internal.client:CSR: CSR(file='/home/pixelcode/Applications/acme_email/csr/0007_csr-certbot.pem', data=b'-----BEGIN CERTIFICATE REQUEST-----\nMIIC0TCCAbkCAQAwRDEdMBsGA1UEAwwUcGl4ZWxjb2RlQGRpc21haWwuZGUxIzAh\nBgkqhkiG9w0BCQEWFHBpeGVsY29kZUBkaXNtYWlsLmRlMIIBIjANBgkqhkiG9w0B\nAQEFAAOCAQ8AMIIBCgKCAQEAnDLZdc4B98INJJ8SDTTqbpdYUcz6DZRRYIlYm4P4\nw8lIeP1isw3Q/Ug+rp5a/TIX/OGTRKefPv4T6+aVHuvfs/MFkyVXwSFZ1Pmgm1al\n8E1CnmIUOpO6R8XAk+O0Bz17505QctdB1vVjhuIvYQBQ7BFdeqhywzA774YcX2nL\nnBoX3cv4oB9QUefTukTOzatOhJ/zRPEDd7RvwV/2Y+76s0KIdoTN/VICfrTfcY/4\nz0ucU2weRdFLCXnYqqbqAL2/Fm0X25OljYlJr5b+3vmose/M0hmb8goLFvXnNLxg\nxgQx1oD3wPm47K2Cb5RMrI2u/KBsRrIJchCiVntMlShzDQIDAQABoEgwRgYJKoZI\nhvcNAQkOMTkwNzA1BgNVHREELjAsgRRwaXhlbGNvZGVAZGlzbWFpbC5kZYIUcGl4\nZWxjb2RlQGRpc21haWwuZGUwDQYJKoZIhvcNAQELBQADggEBACc+4COnb1fe3lWG\nISvhV+Pnh9OoqkU2kK/+Ls5AgCNQnqelHT5B7fJdP83lgpyp400KxXSaHvHkfioP\nJY2yPkExLU+ugytKmH2IQaYfyPGDCkjMJfrYBm9GQWWvi4VPggvQB4tattw/9BsY\nvzp6e6ewSKwmR5Py8KFpRU5eZWdYkVzkUMIyUbDzJ3rrzPZFTzu0U86MH/m6K7w8\nJCWbdFG4AYcV+vvDnDfVOds0tcwsnVqe8KbSPSEhLk+FwiAqCoLFGbBEHbUKA8Kj\nBdAPf+qM7msYSekHgyPP/ACn6bw48oHVWppAIgiq6rMJjf6FOA3UtvfI456n1eI+\nrSfL7qA=\n-----END CERTIFICATE REQUEST-----\n', form='pem')
2024-02-06 23:15:27,384:DEBUG:acme.client:Requesting fresh nonce
2024-02-06 23:15:27,385:DEBUG:acme.client:Sending HEAD request to https://acme.castle.cloud/acme/new-nonce.
2024-02-06 23:15:27,484:DEBUG:urllib3.connectionpool:https://acme.castle.cloud:443 "HEAD /acme/new-nonce HTTP/1.1" 204 0
2024-02-06 23:15:27,484:DEBUG:acme.client:Received response:
HTTP 204
Date: Tue, 06 Feb 2024 22:15:27 GMT
Connection: keep-alive
replay-nonce: 9KMP4RsM7Om6NQmNWfwo2A
Cache-Control: no-store
x-frame-options: DENY
x-content-type-options: nosniff
referrer-policy: same-origin
vary: Origin
access-control-allow-origin: *
strict-transport-security: max-age=7776000
CF-Cache-Status: DYNAMIC
Report-To: {"endpoints":[{"url":"https:\/\/a.nel.cloudflare.com\/report\/v3?s=vBnHt6r%2FhjG9PX7dCuqqXcVDLAadUoWGNm3CNDxVZJBESo88yzmxbL58zcT3hOmSCXDtWXK1auIjWgIrTJx8uxwKpls6xzLWDZtFR6kkwutwhhcnVpNFOkcVA2uPP9whegxM622f3H44%2Fe1P07%2B0dg%3D%3D"}],"group":"cf-nel","max_age":604800}
NEL: {"success_fraction":0,"report_to":"cf-nel","max_age":604800}
Server: cloudflare
CF-RAY: 8516c07c1a2d1961-FRA
alt-svc: h3=":443"; ma=86400

2024-02-06 23:15:27,485:DEBUG:acme.client:Storing nonce: 9KMP4RsM7Om6NQmNWfwo2A
2024-02-06 23:15:27,485:DEBUG:acme.client:JWS payload:
b'{\n  "identifiers": [\n    {\n      "type": "dns",\n      "value": "pixelcode@dismail.de"\n    }\n  ]\n}'
2024-02-06 23:15:27,488:DEBUG:acme.client:Sending POST request to https://acme.castle.cloud/acme/new-order:
{
  "protected": "eyJhbGciOiAiUlMyNTYiLCAia2lkIjogImh0dHBzOi8vYWNtZS5jYXN0bGUuY2xvdWQvYWNtZS9hY2N0L2JzSFdLNm5iYU9HIiwgIm5vbmNlIjogIjlLTVA0UnNNN09tNk5RbU5XZndvMkEiLCAidXJsIjogImh0dHBzOi8vYWNtZS5jYXN0bGUuY2xvdWQvYWNtZS9uZXctb3JkZXIifQ",
  "signature": "BDZAufB1xDUTS41TDmCu9IfodQoyHqSD83hRBRkYGW4lOHlIF8WWiT5grQGX2kiAGmAbw-e_nkDbIRtMEdpbvXZ-pyrJSyizKQRcI5kN3yDwqJyMUt_MKdnIgHNn8V1Vn_k2RnHviUkOInbUzehoYlF75Hou736luWDn1ge2-NPLqdjY4ksFRJUJjHbla451V9oWjuVhNiEg3dglTCjVTgBwbNp5wbDYFOlmhKXnfY-KfKhmebPaTEuAIzxHejagU-VI86FCD4ZhUsiWnWODeZXKf_h1DY6KtLZlni3A2rAifpemGgGjtsqSHgwQMA_1Ll8Dxiy-h8FJD59PCdvgZQ",
  "payload": "ewogICJpZGVudGlmaWVycyI6IFsKICAgIHsKICAgICAgInR5cGUiOiAiZG5zIiwKICAgICAgInZhbHVlIjogInBpeGVsY29kZUBkaXNtYWlsLmRlIgogICAgfQogIF0KfQ"
}
2024-02-06 23:15:29,918:DEBUG:urllib3.connectionpool:https://acme.castle.cloud:443 "POST /acme/new-order HTTP/1.1" 201 272
2024-02-06 23:15:29,919:DEBUG:acme.client:Received response:
HTTP 201
Date: Tue, 06 Feb 2024 22:15:29 GMT
Content-Type: application/json
Content-Length: 272
Connection: keep-alive
location: https://acme.castle.cloud/acme/order/5KmSSyl3r4T
replay-nonce: PGTffrLpn2LXYuNx7ZPFRw
x-frame-options: DENY
x-content-type-options: nosniff
referrer-policy: same-origin
vary: Origin
access-control-allow-origin: *
strict-transport-security: max-age=7776000
CF-Cache-Status: DYNAMIC
Report-To: {"endpoints":[{"url":"https:\/\/a.nel.cloudflare.com\/report\/v3?s=GPp7XqUy1krhxu3eKLFKawXYIPMiikwPEOV6NMJ4ZnUbWyfzHddY1pJhyFJmrcxDzvZj9tjmej6hVtH2juWfxbnPZZNmnjm0UxsP00Hg3tBM7nQPs%2Fn2u2p6ZrdVRwY44za6%2BkXyXkfdi8grIBkeaQ%3D%3D"}],"group":"cf-nel","max_age":604800}
NEL: {"success_fraction":0,"report_to":"cf-nel","max_age":604800}
Server: cloudflare
CF-RAY: 8516c07cbac61961-FRA
alt-svc: h3=":443"; ma=86400

{"status": "pending", "expires": "2024-02-07T22:15:27.619Z", "identifiers": [{"type": "dns", "value": "pixelcode@dismail.de"}], "authorizations": ["https://acme.castle.cloud/acme/authz/XRu9SeciFhQ"], "finalize": "https://acme.castle.cloud/acme/order/5KmSSyl3r4T/finalize"}
2024-02-06 23:15:29,919:DEBUG:acme.client:Storing nonce: PGTffrLpn2LXYuNx7ZPFRw
2024-02-06 23:15:29,919:DEBUG:acme.client:JWS payload:
b''
2024-02-06 23:15:29,921:DEBUG:acme.client:Sending POST request to https://acme.castle.cloud/acme/authz/XRu9SeciFhQ:
{
  "protected": "eyJhbGciOiAiUlMyNTYiLCAia2lkIjogImh0dHBzOi8vYWNtZS5jYXN0bGUuY2xvdWQvYWNtZS9hY2N0L2JzSFdLNm5iYU9HIiwgIm5vbmNlIjogIlBHVGZmckxwbjJMWFl1Tng3WlBGUnciLCAidXJsIjogImh0dHBzOi8vYWNtZS5jYXN0bGUuY2xvdWQvYWNtZS9hdXRoei9YUnU5U2VjaUZoUSJ9",
  "signature": "kRINdiL9yjhuDuvuDUYVUg4rINgpPjGIIWXSxJwAgoCIW6n_ZWcOz124398WOG_Z2uoO3YXE2CtqiewKxe8B5EgttrpMy-duvQLJRXmLbBhtWmHYZpb3qrV07tGYCG613GuO5agpK-HWdGyaORhTZjDZvpHhS1B6EobXS9zn885LurQCP6tyDeWXxapLx8pUUlWYhIqOnBcd-HNp9-eGwSx8x-v64eO2wJdvnqBWLT6HM8ELfEv15osXdJm3hX02VyXjonXfV88QJlfrwAAF2-L9Qehpe8GD9sltUGI1H9o3NdoI9MJPccwjm3kGCcO6bmrf4GCkChpWkj18w2ErSw",
  "payload": ""
}
2024-02-06 23:15:30,043:DEBUG:urllib3.connectionpool:https://acme.castle.cloud:443 "POST /acme/authz/XRu9SeciFhQ HTTP/1.1" 200 None
2024-02-06 23:15:30,044:DEBUG:acme.client:Received response:
HTTP 200
Date: Tue, 06 Feb 2024 22:15:30 GMT
Content-Type: application/json
Transfer-Encoding: chunked
Connection: keep-alive
location: https://acme.castle.cloud/acme/authz/XRu9SeciFhQ
replay-nonce: eL9b6X2oVEBIlsDQrKB3LA
x-frame-options: DENY
x-content-type-options: nosniff
referrer-policy: same-origin
vary: Origin
access-control-allow-origin: *
strict-transport-security: max-age=7776000
CF-Cache-Status: DYNAMIC
Report-To: {"endpoints":[{"url":"https:\/\/a.nel.cloudflare.com\/report\/v3?s=%2BghnEBunthcX5vkUz6UbAXwvZMUn7xGkiUr8te6BPHzmbsugVObXQ7TGKhltCNL5ofSv88QSjEWiXRlYM9WpTMOsB%2FuGH0vQY09EvLgy3%2FKHdAKXpANq3lneRODH6DHMjrexFvGE2e%2FfEIH4z3XK7Q%3D%3D"}],"group":"cf-nel","max_age":604800}
NEL: {"success_fraction":0,"report_to":"cf-nel","max_age":604800}
Server: cloudflare
CF-RAY: 8516c08bffec1961-FRA
Content-Encoding: gzip
alt-svc: h3=":443"; ma=86400

{"status": "pending", "expires": "2024-02-07T22:15:27.713Z", "identifier": {"type": "dns", "value": "pixelcode@dismail.de"}, "challenges": [{"url": "https://acme.castle.cloud/acme/chall/xXb61nuNAfl", "type": "email-reply-00", "token": "ZEJBXUVJRV1BLRB3C6pmkA", "status": "processing", "from": "acme+0564hK1RPh4@castle.cloud"}]}
2024-02-06 23:15:30,044:DEBUG:acme.client:Storing nonce: eL9b6X2oVEBIlsDQrKB3LA
2024-02-06 23:15:30,045:INFO:certbot._internal.auth_handler:Performing the following challenges:
2024-02-06 23:15:30,045:INFO:certbot._internal.auth_handler:email-reply-00 challenge for pixelcode@dismail.de
2024-02-06 23:15:30,046:DEBUG:certbot._internal.display.obj:Notifying user: A challenge request for S/MIME certificate has been sent. In few minutes, ACME
server will send a challenge e-mail to requested recipient pixelcode@dismail.de.
You do not need to take ANY action, as it will be replied automatically.
2024-02-06 23:15:30,046:DEBUG:imapclient.imaplib:< b'* OK Still here'
2024-02-06 23:15:30,046:DEBUG:imapclient.imapclient:< DONE
2024-02-06 23:15:30,072:DEBUG:imapclient.imaplib:< b'DGBC4 OK Idle completed (59.926 + 59.923 + 59.925 secs).'
2024-02-06 23:15:30,072:DEBUG:imapclient.imaplib:   matched b'(?P<tag>DGBC\\d+) (?P<type>[A-Z]+) (?P<data>.*)' => (b'DGBC4', b'OK', b'Idle completed (59.926 + 59.923 + 59.925 secs).')
2024-02-06 23:15:30,073:DEBUG:imapclient.imaplib:> b'DGBC5 IDLE'
2024-02-06 23:15:30,098:DEBUG:imapclient.imaplib:< b'+ idling'
2024-02-06 23:15:30,098:DEBUG:imapclient.imaplib:   matched b'\\+( (?P<data>.*))?' => (b' idling', b'idling')
2024-02-06 23:15:32,254:DEBUG:imapclient.imaplib:< b'* 228 FETCH (FLAGS (\\Seen))'
2024-02-06 23:15:32,254:DEBUG:imapclient.imapclient:< DONE
2024-02-06 23:15:32,283:DEBUG:imapclient.imaplib:< b'DGBC5 OK Idle completed (2.187 + 2.183 + 2.186 secs).'
2024-02-06 23:15:32,284:DEBUG:imapclient.imaplib:   matched b'(?P<tag>DGBC\\d+) (?P<type>[A-Z]+) (?P<data>.*)' => (b'DGBC5', b'OK', b'Idle completed (2.187 + 2.183 + 2.186 secs).')
2024-02-06 23:15:32,290:DEBUG:certbot._internal.error_handler:Encountered exception:
Traceback (most recent call last):
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 88, in handle_authorizations
    resps = self.auth.perform(achalls)
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 97, in perform
    return [self._perform_emailreply00(achall) for achall in achalls]
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 97, in <listcomp>
    return [self._perform_emailreply00(achall) for achall in achalls]
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 109, in _perform_emailreply00
    uid, state = msg
ValueError: too many values to unpack (expected 2)

2024-02-06 23:15:32,290:DEBUG:certbot._internal.error_handler:Calling registered functions
2024-02-06 23:15:32,290:INFO:certbot._internal.auth_handler:Cleaning up challenges
2024-02-06 23:15:32,290:DEBUG:imapclient.imaplib:> b'DGBC6 LOGOUT'
2024-02-06 23:15:32,319:DEBUG:imapclient.imaplib:< b'* BYE Logging out'
2024-02-06 23:15:32,319:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'BYE', b' Logging out', b'Logging out')
2024-02-06 23:15:32,320:DEBUG:imapclient.imaplib:untagged_responses[BYE] 0 += ["b'Logging out'"]
2024-02-06 23:15:32,320:DEBUG:imapclient.imaplib:BYE response: b'Logging out'
2024-02-06 23:15:32,320:DEBUG:imapclient.imapclient:Logged out, connection closed
2024-02-06 23:15:32,361:DEBUG:certbot._internal.log:Exiting abnormally:
Traceback (most recent call last):
  File "/home/pixelcode/Applications/acme_email/cli.py", line 265, in <module>
    main(args)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 203, in main
    request_cert(args, config)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 125, in request_cert
    cert_path, chain_path, fullchain_path = certbot_main._csr_get_and_save_cert(config, le_client)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/main.py", line 1516, in _csr_get_and_save_cert
    cert, chain = le_client.obtain_certificate_from_csr(csr)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 334, in obtain_certificate_from_csr
    orderr = self._get_order_and_authorizations(csr.data, best_effort=False)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 496, in _get_order_and_authorizations
    authzr = self.auth_handler.handle_authorizations(orderr, self.config, best_effort)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 88, in handle_authorizations
    resps = self.auth.perform(achalls)
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 97, in perform
    return [self._perform_emailreply00(achall) for achall in achalls]
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 97, in <listcomp>
    return [self._perform_emailreply00(achall) for achall in achalls]
  File "/home/pixelcode/Applications/acme_email/certbot_castle/plugins/imap.py", line 109, in _perform_emailreply00
    uid, state = msg
ValueError: too many values to unpack (expected 2)
2024-02-06 23:15:32,364:ERROR:certbot._internal.log:An unexpected error occurred:
2024-02-06 23:15:32,364:ERROR:certbot._internal.log:ValueError: too many values to unpack (expected 2)

Certbot version:

$ python3 -c "import certbot;print(certbot.__version__)"
2.8.0

Version of acme_email used: 24b2510

polhenarejos commented 7 months ago

Sometimes mail provider does not work. Can you try a couple of times and see if it can be reproduced?

realpixelcode commented 7 months ago

I tried it from a different network, and now I don't get that error anymore. Instead, half of the time I get this:

2024-02-08 13:04:02,172:DEBUG:certbot._internal.log:Exiting abnormally:
Traceback (most recent call last):
  File "/home/pixelcode/Applications/acme_email/cli.py", line 265, in <module>
    main(args)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 203, in main
    request_cert(args, config)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 125, in request_cert
    cert_path, chain_path, fullchain_path = certbot_main._csr_get_and_save_cert(config, le_client)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/main.py", line 1521, in _csr_get_and_save_cert
    cert_path, chain_path, fullchain_path = le_client.save_certificate(
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 618, in save_certificate
    cert_file, abs_cert_path = _open_pem_file(self.config, 'cert_path', cert_path)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 864, in _open_pem_file
    if config.set_by_user(cli_arg_path):
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/configuration.py", line 111, in set_by_user
    raise RuntimeError(
RuntimeError: NamespaceConfig.set_by_user called without an ArgumentSources dict. See NamespaceConfig.set_argument_sources().
2024-02-08 13:04:02,173:ERROR:certbot._internal.log:An unexpected error occurred:
2024-02-08 13:04:02,173:ERROR:certbot._internal.log:RuntimeError: NamespaceConfig.set_by_user called without an ArgumentSources dict. See NamespaceConfig.set_argument_sources().

And for the other half, I get this:

{"status": "pending", "expires": "2024-02-09T11:59:26.433Z", "identifier": {"type": "dns", "value": "pixelcode@dismail.de"}, "challenges": [{"url": "https://acme.castle.cloud/acme/chall/xxx", "type": "email-reply-00", "token": "xxx", "status": "processing", "from": "acme+xxx@castle.cloud"}]}
2024-02-08 13:01:03,180:DEBUG:acme.client:Storing nonce: xxx
2024-02-08 13:01:03,185:DEBUG:certbot._internal.error_handler:Encountered exception:
Traceback (most recent call last):
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 108, in handle_authorizations
    self._poll_authorizations(authzrs, max_retries, max_time_mins, best_effort)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 216, in _poll_authorizations
    raise errors.AuthorizationError('All authorizations were not finalized by the CA.')
certbot.errors.AuthorizationError: All authorizations were not finalized by the CA.

2024-02-08 13:01:03,185:DEBUG:certbot._internal.error_handler:Calling registered functions
2024-02-08 13:01:03,185:INFO:certbot._internal.auth_handler:Cleaning up challenges
2024-02-08 13:01:03,186:DEBUG:imapclient.imaplib:> b'LGAP8 LOGOUT'
2024-02-08 13:01:03,203:DEBUG:imapclient.imaplib:< b'* BYE Logging out'
2024-02-08 13:01:03,203:DEBUG:imapclient.imaplib:   matched b'\\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => (b'BYE', b' Logging out', b'Logging out')
2024-02-08 13:01:03,203:DEBUG:imapclient.imaplib:untagged_responses[BYE] 0 += ["b'Logging out'"]
2024-02-08 13:01:03,203:DEBUG:imapclient.imaplib:BYE response: b'Logging out'
2024-02-08 13:01:03,204:DEBUG:imapclient.imapclient:Logged out, connection closed
2024-02-08 13:01:03,240:DEBUG:certbot._internal.log:Exiting abnormally:
Traceback (most recent call last):
  File "/home/pixelcode/Applications/acme_email/cli.py", line 265, in <module>
    main(args)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 203, in main
    request_cert(args, config)
  File "/home/pixelcode/Applications/acme_email/cli.py", line 125, in request_cert
    cert_path, chain_path, fullchain_path = certbot_main._csr_get_and_save_cert(config, le_client)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/main.py", line 1516, in _csr_get_and_save_cert
    cert, chain = le_client.obtain_certificate_from_csr(csr)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 334, in obtain_certificate_from_csr
    orderr = self._get_order_and_authorizations(csr.data, best_effort=False)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/client.py", line 496, in _get_order_and_authorizations
    authzr = self.auth_handler.handle_authorizations(orderr, self.config, best_effort)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 108, in handle_authorizations
    self._poll_authorizations(authzrs, max_retries, max_time_mins, best_effort)
  File "/home/pixelcode/Applications/acme_email/venv/lib/python3.10/site-packages/certbot/_internal/auth_handler.py", line 216, in _poll_authorizations
    raise errors.AuthorizationError('All authorizations were not finalized by the CA.')
certbot.errors.AuthorizationError: All authorizations were not finalized by the CA.
2024-02-08 13:01:03,241:ERROR:certbot._internal.log:All authorizations were not finalized by the CA.
polhenarejos commented 6 months ago

This happens when mail backend fails. It has a kind of throttle. If you retry, at some point it should work.

realpixelcode commented 6 months ago

Closing, as the original issue is resolved.