gpgme_op_keylist_start: error: Invalid crypto engine <GPGME>
Hans-Christoph Steiner
hans at guardianproject.info
Thu Oct 18 00:49:37 CEST 2012
On 10/17/2012 12:59 PM, Werner Koch wrote:
> On Wed, 17 Oct 2012 00:54, hans at guardianproject.info said:
>
>> So the gpgme logging did give me some insight into what gpgme is doing,
>> from that I added 'g13' to the build, so now that's included. But
>
> I doubt that you need it; it currently works only with encfs and has not
> been tested for a long time. However, that is not your problem.
>
>> unfortunately the log doesn't give any more detail about the "Invalid
>> crypto engine" error that is the show stopper.
>
> Argh, that damned catch-all error code.
>
>> GPGME 2012-09-14 23:08:11 <0x0d6e> gpgme_op_keylist_start: error:
>> Invalid crypto engine <GPGME>
>
> I guess this comes directly from engine-gpg.c. What I would do is to
> replace gpg2 by a wrapper script to log the environment and args.
>
> Something like this:
> ====
> #!/bin/sh
>
> echo ============ >>/tmp/gpg2.log
> echo === BEGIN == >>/tmp/gpg2.log
> echo ============ >>/tmp/gpg2.log
> printenv >>/tmp/gpg2.log
> echo "$@" >>/tmp/gpg2.log
> exec /foo/bar/gpg2-real "$@"
> =====
That worked for getting logs, but I'm not seeing anything in the
gpg2.log that's coming from the gpgme startup. Here are the logs (they
are also attached):
dirmngr.log
----------------------------
2012-10-17 19:57:48 dirmngr[957.0] listening on socket
'/data/data/info.guardianproject.gpg/app_opt/var/run/gnupg/S.dirmngr'
2012-10-17 19:57:48 dirmngr[958.0] permanently loaded certificates: 0
2012-10-17 19:57:48 dirmngr[958.0] runtime cached certificates: 0
gpg2.log
----------------------------
============
=== BEGIN ==
============
ANDROID_ROOT=/system
LD_LIBRARY_PATH=/vendor/lib:/system/lib
PATH=/sbin:/vendor/bin:/system/sbin:/system/bin:/system/xbin
LOOP_MOUNTPOINT=/mnt/obb
ASEC_MOUNTPOINT=/mnt/asec
ANDROID_SOCKET_zygote=9
BOOTCLASSPATH=/system/framework/core.jar:/system/framework/core-junit.jar:/system/framework/bouncycastle.jar:/system/framework/ext.jar:/system/framework/framework.jar:/system/framework/android.policy.jar:/system/framework/services.jar:/system/framework/apache-xml.jar
ANDROID_BOOTLOGO=1
ANDROID_ASSETS=/system/app
EXTERNAL_STORAGE=/mnt/sdcard
ANDROID_DATA=/data
ANDROID_PROPERTY_WORKSPACE=8,32768
--version
gpg-agent.log
----------------------------
2012-10-17 19:57:47 gpg-agent[946] listening on socket
'/data/data/info.guardianproject.gpg/app_home/.gnupg/S.gpg-agent'
2012-10-17 19:57:47 gpg-agent[956] gpg-agent (GnuPG) 2.1.0-beta82 started
2012-10-17 19:58:50 gpg-agent[956] handler 0x563d0 for fd 6 started
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 -> OK Pleased to meet
you, process 956
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_5 <- OK Pleased to meet
you, process 956
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_5 -> GETINFO pid
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 <- GETINFO pid
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 -> D 956
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_5 <- D 956
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 -> OK
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_5 <- OK
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_5 -> BYE
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 <- BYE
2012-10-17 19:58:50 gpg-agent[956] DBG: chan_6 -> OK closing connection
2012-10-17 19:58:50 gpg-agent[956] handler 0x563d0 for fd 6 terminated
2012-10-17 19:59:50 gpg-agent[956] handler 0x563d0 for fd 6 started
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 -> OK Pleased to meet
you, process 956
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_5 <- OK Pleased to meet
you, process 956
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_5 -> GETINFO pid
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 <- GETINFO pid
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 -> D 956
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_5 <- D 956
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 -> OK
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_5 <- OK
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_5 -> BYE
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 <- BYE
2012-10-17 19:59:50 gpg-agent[956] DBG: chan_6 -> OK closing connection
2012-10-17 19:59:50 gpg-agent[956] handler 0x563d0 for fd 6 terminated
gpgme.log
----------------------------
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_debug: level=9
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_check_version: call: 0=0x0,
req_version=(null), VERSION=1.3.3-git83e7420
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_check_version_internal: call:
0=0x0, req_version=(null), offset_sig_validity=32
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_set_locale: enter: ctx=0x0,
category=0, value=(null)
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_set_locale: leave
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_set_locale: enter: ctx=0x0,
category=5, value=(null)
GPGME 2012-10-17 15:57:45 <0x0391> gpgme_set_locale: leave
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_pipe: enter:
filedes=0xbeac65dc, inherit_idx=1 (GPGME uses it for reading)
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_pipe: leave: read=0x25,
write=0x26
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: enter:
path=0x4a2ea798, path=/data/data/info.guardianproject.gpg/app_opt/bin/gpg2
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea798, argv[ 0] =
/data/data/info.guardianproject.gpg/app_opt/bin/gpg2
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea798, argv[ 1] = --version
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea798, fd[0] = 0x26 -> 0x1
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea798, waiting for child process pid=941
GPGME 2012-10-17 15:57:45 <0x03ae> gpgme:max_fds: call: 0=0x0, max
fds=1024 (RLIMIT_NOFILE)
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_close: enter: fd=0x26
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_spawn: leave: result=0
GPGME 2012-10-17 15:57:45 <0x0391> _gpgme_io_read: enter: fd=0x25,
buffer=0xbeac65e4, count=79
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x25
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: enter:
filedes=0xbeac65dc, inherit_idx=1 (GPGME uses it for reading)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: leave: read=0x25,
write=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: enter:
path=0x4a2ea7d0, path=/data/data/info.guardianproject.gpg/app_opt/bin/gpgsm
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea7d0, argv[ 0] =
/data/data/info.guardianproject.gpg/app_opt/bin/gpgsm
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea7d0, argv[ 1] = --version
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea7d0, fd[0] = 0x26 -> 0x1
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea7d0, waiting for child process pid=948
GPGME 2012-10-17 15:57:46 <0x03b5> gpgme:max_fds: call: 0=0x0, max
fds=1024 (RLIMIT_NOFILE)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: enter: fd=0x25,
buffer=0xbeac65e4, count=79
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x25
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: enter:
filedes=0xbeac65dc, inherit_idx=1 (GPGME uses it for reading)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: leave: read=0x25,
write=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: enter:
path=0x4a2ea808,
path=/data/data/info.guardianproject.gpg/app_opt/bin/gpgconf
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, argv[ 0] =
/data/data/info.guardianproject.gpg/app_opt/bin/gpgconf
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, argv[ 1] = --version
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, fd[0] = 0x26 -> 0x1
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, waiting for child process pid=950
GPGME 2012-10-17 15:57:46 <0x03b7> gpgme:max_fds: call: 0=0x0, max
fds=1024 (RLIMIT_NOFILE)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: enter: fd=0x25,
buffer=0xbeac65e4, count=79
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x25
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: enter:
filedes=0xbeac6204, inherit_idx=1 (GPGME uses it for reading)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_pipe: leave: read=0x25,
write=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: enter:
path=0x4a2ea808,
path=/data/data/info.guardianproject.gpg/app_opt/bin/gpgconf
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, argv[ 0] =
/data/data/info.guardianproject.gpg/app_opt/bin/gpgconf
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, argv[ 1] = --list-dirs
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, fd[0] = 0x26 -> 0x1
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea808, waiting for child process pid=952
GPGME 2012-10-17 15:57:46 <0x03b9> gpgme:max_fds: call: 0=0x0, max
fds=1024 (RLIMIT_NOFILE)
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: enter: fd=0x26
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_spawn: leave: result=0
GPGME 2012-10-17 15:57:46 <0x0391> _gpgme_io_read: enter: fd=0x25,
buffer=0xbeac6218, count=1023
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_read: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: enter: fd=0x25
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_pipe: enter:
filedes=0xbeac65dc, inherit_idx=1 (GPGME uses it for reading)
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_pipe: leave: read=0x25,
write=0x26
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: enter:
path=0x4a2ea840, path=/data/data/info.guardianproject.gpg/app_opt/bin/g13
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea840, argv[ 0] =
/data/data/info.guardianproject.gpg/app_opt/bin/g13
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea840, argv[ 1] = --version
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea840, fd[0] = 0x26 -> 0x1
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: check:
path=0x4a2ea840, waiting for child process pid=954
GPGME 2012-10-17 15:57:47 <0x03bb> gpgme:max_fds: call: 0=0x0, max
fds=1024 (RLIMIT_NOFILE)
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: enter: fd=0x26
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_spawn: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_read: enter: fd=0x25,
buffer=0xbeac65e4, count=79
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_read: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: enter: fd=0x25
GPGME 2012-10-17 15:57:47 <0x0391> _gpgme_io_close: leave: result=0
GPGME 2012-10-17 15:57:47 <0x0391> gpgme_new: enter: r_ctx=0xbeac66d4
GPGME 2012-10-17 15:57:47 <0x0391> gpgme_new: leave: ctx=0x2a0d89a8
GPGME 2012-10-17 15:57:47 <0x0391> gpgme_set_armor: call:
ctx=0x2a0d89a8, use_armor=1 (yes)
GPGME 2012-10-17 15:57:47 <0x0391> gpgme_set_textmode: call:
ctx=0x2a0d89a8, use_textmode=1 (yes)
GPGME 2012-10-17 15:57:47 <0x0391> gpgme_set_keylist_mode: call:
ctx=0x2a0d89a8, keylist_mode=0x5
GPGME 2012-10-17 15:58:25 <0x0391> gpgme_op_keylist_start: enter:
ctx=0x2a0d89a8, pattern=hans, secret_only=0
GPGME 2012-10-17 15:58:25 <0x0391> gpgme_op_keylist_start: error:
Invalid crypto engine <GPGME>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: gpg-logs.tar.bz2
Type: application/x-bzip
Size: 1975 bytes
Desc: not available
URL: </pipermail/attachments/20121017/1c79e4ab/attachment-0001.bin>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 937 bytes
Desc: OpenPGP digital signature
URL: </pipermail/attachments/20121017/1c79e4ab/attachment-0001.pgp>
More information about the Gnupg-devel
mailing list