Skip site navigation (1)Skip section navigation (2)
Date:      Wed, 04 Feb 2015 02:27:28 +0000
From:      bugzilla-noreply@freebsd.org
To:        freebsd-ports-bugs@FreeBSD.org
Subject:   [Bug 197307] upgrade to thunderbird 31.4.0_1 broke enigmail?
Message-ID:  <bug-197307-13@https.bugs.freebsd.org/bugzilla/>

next in thread | raw e-mail | index | archive | help
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=3D197307

            Bug ID: 197307
           Summary: upgrade to thunderbird 31.4.0_1 broke enigmail?
           Product: Ports & Packages
           Version: Latest
          Hardware: Any
                OS: Any
            Status: New
          Severity: Affects Only Me
          Priority: ---
         Component: Individual Port(s)
          Assignee: freebsd-ports-bugs@FreeBSD.org
          Reporter: heikki@suonsivu.net

I upgraded my packages including thunderbird to from 31.3.0 to 31.4.0_1.  T=
his
also upgraded gnupg from 2.1.0_1 to 2.1.1_1.  After upgrade and restarting
thunderbird, enigmail fails in various ways:

- Cannot send mail, as Enigmail says "Send operation aborted   Error -
encryption command failed".

- When trying to open a draft email thunderbird says it cannot decrypt it.=
=20
Enigmail security info says=20

Observations:=20=20

- If I save the draft email which cannot be opened and gpg -d it, it decryp=
ts
fine.=20

- If I sign with gpg, it also works.

So it seems that something broke in Thunderbird in the last upgrade.

In the enigdbug log file, it seems to start gpg, and launch pinentry, but
immediately fails, so it might be that the pin entry bit does not work.  I =
get
no pin entry window like I did earlier.


The enigmail log file contains, when trying to send mail:



2015-02-04 04:08:12.967 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.sendMessageListener
2015-02-04 04:08:12.967 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.modifyCompFields: otherRandomHeaders =3D=20
2015-02-04 04:08:12.967 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.encryptMsg: msgSendType=3D0, Enigmail.msg.sendMode=3D1,
Enigmail.msg.statusEncrypted=3D11
2015-02-04 04:08:12.968 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.encryptMsg: currentId=3D[nsIMsgIdentity: id1], heikki@suonsivu=
.net
2015-02-04 04:08:12.968 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.encryptMsg:gMsgCompose=3D[xpconnect wrapped nsIMsgCompose]
2015-02-04 04:08:12.968 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.encryptMsg: BCC: hsu@bbnetworks.net
2015-02-04 04:08:20.104 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.keySelection()
2015-02-04 04:08:20.104 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.keySelection(): toAddrStr=3D"hsu@iki.fi, hsu@bbnetworks.net"
bccAddrStr=3D""
2015-02-04 04:08:20.104 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.processRules(): toAddrStr=3D"hsu@iki.fi, hsu@bbnetworks.net"
bccAddrStr=3D"" forceRecipientSettings=3Dfalse
2015-02-04 04:08:20.104 [DEBUG] enigmailMsgComposeHelper.js:
getRecipientsKeys(): emailAddrs=3D"hsu@iki.fi, hsu@bbnetworks.net"
interactive=3Dtrue forceRecipientSettings=3Dfalse
2015-02-04 04:08:20.105 [DEBUG] enigmail.js: getRulesData
2015-02-04 04:08:20.105 [DEBUG] enigmail.js: loadRulesFile
2015-02-04 04:08:20.105 [DEBUG] enigmail.js: getRulesFile
2015-02-04 04:08:20.105 [DEBUG] enigmailMsgComposeHelper.js:
validKeysForAllRecipients(): emailAddrs=3D"hsu@iki.fi, hsu@bbnetworks.net"
refresh=3D"true"
2015-02-04 04:08:20.105 [DEBUG] enigmailMsgComposeHelper.js:
validKeysForAllRecipients(): find keys with minTrustLevel=3D"?"
2015-02-04 04:08:20.105 [DEBUG] enigmailFuncs.jsm: loadKeyList
2015-02-04 04:08:20.105 [DEBUG] enigmailFuncs.jsm: obtainKeyList
2015-02-04 04:08:20.105 enigmail.js: Enigmail.execCmd: subprocess =3D
'/usr/local/bin/gpg'
2015-02-04 04:08:20.124 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
line/env/input to files /usr/users/hsu/enigcmd.txt/enigenv.txt/eniginp.txt
2015-02-04 04:08:20.125 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 --with-fingerprint
--fixed-list-mode --with-colons --list-keys
2015-02-04 04:08:20.296 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
out/err data to files /usr/users/hsu/enigout.txt/enigerr.txt
2015-02-04 04:08:20.296 [DEBUG] enigmail.js: Enigmail.execCmd: exitCode =3D=
 0
2015-02-04 04:08:20.297 [DEBUG] enigmail.js: Enigmail.execCmd: errOutput =
=3D gpg:
Warning: using insecure memory!

2015-02-04 04:08:20.297 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!

2015-02-04 04:08:20.297 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00000000
2015-02-04 04:08:20.297 [CONSOLE] gpg: Warning: using insecure memory!
2015-02-04 04:08:20.297 [DEBUG] enigmailCommon.jsm: stillActive:=20
2015-02-04 04:08:20.297 [DEBUG] enigmailFuncs.jsm: obtainKeyList
2015-02-04 04:08:20.298 enigmail.js: Enigmail.execCmd: subprocess =3D
'/usr/local/bin/gpg'
2015-02-04 04:08:20.317 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
line/env/input to files /usr/users/hsu/enigcmd.txt/enigenv.txt/eniginp.txt
2015-02-04 04:08:20.317 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 --with-fingerprint
--fixed-list-mode --with-colons --list-secret-keys
2015-02-04 04:08:20.502 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
out/err data to files /usr/users/hsu/enigout.txt/enigerr.txt
2015-02-04 04:08:20.503 [DEBUG] enigmail.js: Enigmail.execCmd: exitCode =3D=
 0
2015-02-04 04:08:20.503 [DEBUG] enigmail.js: Enigmail.execCmd: errOutput =
=3D gpg:
Warning: using insecure memory!

2015-02-04 04:08:20.503 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!

2015-02-04 04:08:20.503 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00000000
2015-02-04 04:08:20.503 [CONSOLE] gpg: Warning: using insecure memory!
2015-02-04 04:08:20.503 [DEBUG] enigmailCommon.jsm: stillActive:=20
2015-02-04 04:08:20.504 enigmail.js: Enigmail.execCmd: subprocess =3D
'/usr/local/bin/gpg'
2015-02-04 04:08:20.525 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
line/env/input to files /usr/users/hsu/enigcmd.txt/enigenv.txt/eniginp.txt
2015-02-04 04:08:20.526 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 --fixed-list-mode
--with-colons --list-config
2015-02-04 04:08:20.695 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
out/err data to files /usr/users/hsu/enigout.txt/enigerr.txt
2015-02-04 04:08:20.695 [DEBUG] enigmail.js: Enigmail.execCmd: exitCode =3D=
 0
2015-02-04 04:08:20.696 [DEBUG] enigmail.js: Enigmail.execCmd: errOutput =
=3D gpg:
Warning: using insecure memory!

2015-02-04 04:08:20.696 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!

2015-02-04 04:08:20.696 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00000000
2015-02-04 04:08:20.696 [CONSOLE] gpg: Warning: using insecure memory!
2015-02-04 04:08:20.696 [DEBUG] enigmailCommon.jsm: stillActive:=20
2015-02-04 04:08:20.696 [DEBUG] enigmailMsgComposeHelper.js:
getValidKeyForRecipient(): emailAddr=3D"hsu@iki.fi"
2015-02-04 04:08:20.696 [DEBUG] enigmailMsgComposeHelper.js:
getValidKeyForRecipient(): no key found
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeHelper.js:
validKeysForAllRecipients(): return null (no single valid key found
for=3D"hsu@iki.fi" with minTrustLevel=3D"?")
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.processFinalState()
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeOverlay.js:   encrypt=3Df=
alse
encryptByRules=3D1 encFinally=3D0
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeOverlay.js:   signed=3Dtr=
ue
signByRules=3D1 signFinally=3D1
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeOverlay.js:=20=20
pgpmimeByRules=3D1 pgpmimeFinally=3D0
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeHelper.js:
getRecipientsKeys(): emailAddrs=3D"" interactive=3Dtrue
forceRecipientSettings=3Dfalse
2015-02-04 04:08:20.697 [DEBUG] enigmail.js: getRulesData
2015-02-04 04:08:20.697 [DEBUG] enigmail.js: loadRulesFile
2015-02-04 04:08:20.697 [DEBUG] enigmail.js: getRulesFile
2015-02-04 04:08:20.697 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.keySelection(): return toAddrStr=3D"hsu@iki.fi, hsu@bbnetworks=
.net"
bccAddrStr=3D""
2015-02-04 04:08:20.698 [DEBUG] enigmailMsgComposeOverlay.js: hasAttachment=
s =3D
false
2015-02-04 04:08:20.701 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.editorGetContentAs
2015-02-04 04:08:20.701 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.replaceEditorText:
2015-02-04 04:08:20.702 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.editorInsertText
2015-02-04 04:08:20.703 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.editorInsertText
2015-02-04 04:08:20.703 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.editorGetContentAs
2015-02-04 04:08:20.704 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.editorGetCharset
2015-02-04 04:08:20.704 [DEBUG] enigmailMsgComposeOverlay.js:
Enigmail.msg.encryptMsg: charset=3Dutf-8
2015-02-04 04:08:20.704 [DEBUG] enigmail.js: Enigmail.encryptMessage: 7 byt=
es
from 0x1829841E to hsu@iki.fi, hsu@bbnetworks.net (97)
2015-02-04 04:08:20.704 [DEBUG] enigmailCommon.jsm: encryptMessageStart:
uiFlags=3D1, from 0x1829841E to hsu@iki.fi, hsu@bbnetworks.net,
hashAlgorithm=3Dnull (00000061)
2015-02-04 04:08:20.704 [DEBUG] enigmailCommon.jsm: getEncryptCommand:
hashAlgorithm=3Dnull
2015-02-04 04:08:20.704 enigmailCommon.jsm: execStart: command =3D
/usr/local/bin/gpg --charset utf-8 --display-charset utf-8 --batch --no-tty
--status-fd 2 -t --clearsign -u 0x1829841E, needPassphrase=3D1, domWindow=
=3D[object
ChromeWindow], listener=3D[object Object]
2015-02-04 04:08:20.704 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:08:20.704 [DEBUG] enigmailCommon.jsm: getPassphrase:
2015-02-04 04:08:20.705 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:08:20.705 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 -t --clearsign -u
0x1829841E --use-agent
2015-02-04 04:08:20.806 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:08:20.923 [DEBUG] enigmailCommon.jsm: encryptMessageEnd:
uiFlags=3D1, sendFlags=3D00000061, outputLen=3D56
2015-02-04 04:08:20.923 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!
[GNUPG:] BEGIN_SIGNING H8
[GNUPG:] PINENTRY_LAUNCHED 2280
gpg: allekirjoitus ep=C3=A4onnistui: Operation cancelled
gpg: [stdin]: clearsign failed: Operation cancelled

2015-02-04 04:08:20.924 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00000000
2015-02-04 04:08:20.924 [DEBUG] enigmailCommon.jsm: encryptMessageEnd: comm=
and
execution exit code: 2
2015-02-04 04:08:20.924 [DEBUG] enigmail.js: Enigmail.encryptMessage: comma=
nd
execution exit code: 2



When trying open a draft message, the log file contains:


2015-02-04 04:22:29.679 [DEBUG] enigmailMessengerOverlay.js: messageFrameUn=
load
2015-02-04 04:22:29.679 [DEBUG] enigmailMessengerOverlay.js: messageCleanup
2015-02-04 04:22:29.679 [DEBUG] enigmailMessengerOverlay.js:
setAttachmentReveal
2015-02-04 04:22:29.679 [DEBUG] enigmailMsgHdrViewOverlay.js:
this.messageUnload
2015-02-04 04:22:29.767 [DEBUG] enigmailMsgHdrViewOverlay.js:
_listener_onStartHeaders
2015-02-04 04:22:29.767 [DEBUG] enigmailMessengerOverlay.js:
setAttachmentReveal
2015-02-04 04:22:29.767 [DEBUG] enigmailCommon.jsm: getFrame: name=3Dmessag=
epane
2015-02-04 04:22:29.768 [DEBUG] enigmailMsgHdrViewOverlay.js: msgFrame=3D[o=
bject
XrayWrapper [object Window]]
2015-02-04 04:22:29.768 [DEBUG] enigmailCommon.jsm: forgetEncryptedUri:
uri=3Dimap-message://heikki@mail.bbnetworks.net/Drafts#15278
2015-02-04 04:22:29.768 [DEBUG] enigmailMsgHdrViewOverlay.js:
enigmailPrepSecurityInfo
2015-02-04 04:22:29.786 [DEBUG] enigmailMsgHdrViewOverlay.js:
_listener_onEndHeaders
2015-02-04 04:22:29.786 [DEBUG] enigmailMessengerOverlay.js:
setAttachmentReveal
2015-02-04 04:22:29.845 [DEBUG] enigmailCommon.jsm: decryptMessageStart:
verifyOnly=3Dfalse
2015-02-04 04:22:29.845 enigmailCommon.jsm: execStart: command =3D
/usr/local/bin/gpg --charset utf-8 --display-charset utf-8 --batch --no-tty
--status-fd 2 --max-output 125500 --decrypt, needPassphrase=3Dtrue,
domWindow=3D[object ChromeWindow], listener=3D[object Object]
2015-02-04 04:22:29.845 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:22:29.846 [DEBUG] enigmailCommon.jsm: getPassphrase:
2015-02-04 04:22:29.846 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:22:29.846 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 --max-output 125500
--decrypt --use-agent
2015-02-04 04:22:29.927 [DEBUG] enigmail.js: Setting useAgent to true for g=
pg2
>=3D 2.0.16
2015-02-04 04:22:30.110 [DEBUG] enigmailCommon.jsm: decryptMessageEnd:
uiFlags=3D8, verifyOnly=3Dfalse, noOutput=3Dfalse
2015-02-04 04:22:30.111 [DEBUG] enigmailCommon.jsm: decryptMessageEnd:
stderrStr=3D
gpg: Warning: using insecure memory!
[GNUPG:] ENC_TO 3D08188F6B052631 1 0
[GNUPG:] PINENTRY_LAUNCHED 2324
gpg: encrypted with 4096-bit RSA key, ID 6B052631, created 2014-12-08
      "Heikki Suonsivu <heikki@suonsivu.net>"
gpg: julkisen avaimen avaus ep=C3=A4onnistui: Operation cancelled
[GNUPG:] ERROR pkdecrypt_failed 83886179
[GNUPG:] BEGIN_DECRYPTION
[GNUPG:] DECRYPTION_FAILED
gpg: avaus ep=C3=A4onnistui: No secret key
[GNUPG:] END_DECRYPTION

2015-02-04 04:22:30.111 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!
[GNUPG:] ENC_TO 3D08188F6B052631 1 0
[GNUPG:] PINENTRY_LAUNCHED 2324
gpg: encrypted with 4096-bit RSA key, ID 6B052631, created 2014-12-08
      "Heikki Suonsivu <heikki@suonsivu.net>"
gpg: julkisen avaimen avaus ep=C3=A4onnistui: Operation cancelled
[GNUPG:] ERROR pkdecrypt_failed 83886179
[GNUPG:] BEGIN_DECRYPTION
[GNUPG:] DECRYPTION_FAILED
gpg: avaus ep=C3=A4onnistui: No secret key
[GNUPG:] END_DECRYPTION

2015-02-04 04:22:30.111 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00010002
2015-02-04 04:22:30.112 enigmail.js: Enigmail.execCmd: subprocess =3D
'/usr/local/bin/gpg'
2015-02-04 04:22:30.131 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
line/env/input to files /usr/users/hsu/enigcmd.txt/enigenv.txt/eniginp.txt
2015-02-04 04:22:30.131 [CONSOLE] enigmail> /usr/local/bin/gpg --charset ut=
f-8
--display-charset utf-8 --batch --no-tty --status-fd 2 --fixed-list-mode
--with-colons --list-keys 0x3D08188F6B052631
2015-02-04 04:22:30.333 [DEBUG] enigmail.js: Enigmail.execCmd: copied comma=
nd
out/err data to files /usr/users/hsu/enigout.txt/enigerr.txt
2015-02-04 04:22:30.333 [DEBUG] enigmail.js: Enigmail.execCmd: exitCode =3D=
 0
2015-02-04 04:22:30.333 [DEBUG] enigmail.js: Enigmail.execCmd: errOutput =
=3D gpg:
Warning: using insecure memory!

2015-02-04 04:22:30.333 [DEBUG] enigmailCommon.jsm: parseErrorOutput: status
message:=20
gpg: Warning: using insecure memory!

2015-02-04 04:22:30.333 [DEBUG] enigmailCommon.jsm: parseErrorOutput:
statusFlags =3D 00000000
2015-02-04 04:22:30.333 [CONSOLE] gpg: Warning: using insecure memory!
2015-02-04 04:22:30.333 [DEBUG] enigmailCommon.jsm: stillActive:=20
2015-02-04 04:22:30.334 [DEBUG] enigmailCommon.jsm: decryptMessageEnd: comm=
and
execution exit code: 2
2015-02-04 04:22:30.334 [DEBUG] enigmailMsgHdrViewOverlay.js:
EnigMimeHeaderSink.updateSecurityStatus:
uriSpec=3Dimap-message://heikki@mail.bbnetworks.net/Drafts#15283
2015-02-04 04:22:30.335 [DEBUG] enigmailMsgHdrViewOverlay.js:
EnigMimeHeaderSink.updateSecurityStatus:
msgUriSpec=3Dimap-message://heikki@mail.bbnetworks.net/Drafts#15283
2015-02-04 04:22:30.335 [DEBUG] enigmailMsgHdrViewOverlay.js:
this.updateHdrIcons: exitCode=3D2, statusFlags=3D2162690, keyId=3D, userId=
=3D, gpg:
avaus ep=C3=A4onnistui: No secret key

Note: the message is encrypted with the following User ID's / Keys:=20
  0x3D08188F6B052631 (Heikki Suonsivu <heikki@suonsivu.net>)

2015-02-04 04:22:30.336 [DEBUG] enigmailMsgHdrViewOverlay.js: this.updateMs=
gDb
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: messageDecrypt:
[object XrayWrapper [object Event]]
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: messageDecrypt=
Cb:
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: messageDecrypt=
Cb:
mimeMsg is null
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: header
content-type: multipart/encrypted; protocol=3D"application/pgp-encrypted";
boundary=3D"A9gsfoGJGCi7i2SS9m1QCdQ591jNJpRqb"
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: header
content-transfer-encoding:=20
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: header
x-enigmail-version:=20
2015-02-04 04:22:30.406 [DEBUG] enigmailMessengerOverlay.js: header
x-pgp-encoding-format:=20
2015-02-04 04:22:30.407 [DEBUG] enigmailMessengerOverlay.js:
multipart/encrypted

--=20
You are receiving this mail because:
You are the assignee for the bug.=



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?bug-197307-13>