search

keybase / keybase-issues

A single repo for managing publicly recognized issues with the keybase client, installer, and website.
902 stars 37 forks source link

INFO PGP: openpgp: unsupported feature: S2K function #1822

Open kramimus opened 8 years ago

kramimus commented 8 years ago 
$ kbstage login
▶ WARNING Running in staging mode
Enter a public name for this device: compy
How would you like to sign this install of Keybase?

(1) using PGP   (requires access to your PGP key)
Choose a signing option: 1
▶ INFO PGP: openpgp: unsupported feature: S2K function
kramimus commented 8 years ago

This is a stage0 issue, but don't appear to have permission to label.

maxtaco commented 8 years ago

Thank you @kramimus for the bug report.

Can you help me figure out what type of key protection you're using? This command would do it:

gpg --export-secret-key EF6ED8E7C37B3370 | gpg --list-packets | grep S2K

It shouldn't leak any secrets, but as a precaution, you can send me the output encrypted via https://keybase.io/max and max@keybase.io

Thanks!

maxtaco commented 8 years ago

Got your mail, seems like the Go OpenPGP libraries don't support gnu-dummy S2K, algo: 3, SHA1 protection, hash: 2 . That's my best guess. We'll make a ticket for it, thanks!

md5 commented 8 years ago

I ran into this same issue trying to set up my Keybase account. I'm currently unable to set up my keybase command line tool since I hit this issue for both the "Keybase passphrase" and the "GPG" login methods and I can't use the other two since I don't have another device configured and I can't generate a paper key without logging in.

maxtaco commented 8 years ago

Our new release has a fix/workaround for this issue, allowing a shell-out to the GPG command line for signing the install.

kramimus commented 8 years ago

I installed the latest .deb and tried this again. I tried logging in and using option 4), which looks like it shells out to GPG to create a device key or something, but it failed with a weird GPG error. I lost the terminal buffer before I could paste it here.

I ran deprovision and now when I try to login, I get this error:

$ kbstage login
▶ WARNING Running in staging mode
How would you like to sign this install of Keybase?

(1) Use an existing device
(2) Use a paper key
(3) Use my Keybase passphrase
(4) Use GPG
Choose a signing option: 4
In order to authorize this installation, keybase needs to sign this installation
with your GPG secret key.

You have two options.

(1) Keybase can use GPG commands to sign the installation.

(2) Keybase can export your secret key from GPG and save it to keybase's local encrypted
    keyring. This way, it can be used in 'keybase pgp sign' and 'keybase pgp decrypt' 
    going forward.
Which do you prefer?: 2
#    Algo   Key Id             Created      UserId
=    ====   ======             =======      ======
1    R      EF6ED8E7C37B3370   2014-03-24   Mark G. Whitney <mark@whitneyindustries.com>, Mark G. Whitney <markwhitney@gmail.com>, kramimus <kramimus@gmail.com>, kramimus <kramimus@keybase.io>
2    R      4368ECA26E351AB6   2011-03-20   Mark G. Whitney <markwhitney@gmail.com>
Choose a key: 1
▶ WARNING Failed to load fb53422d3236dfd34bd73c7c9963c200 from storage: resource temporarily unavailable
▶ WARNING not exportable error: resource temporarily unavailable (syscall.Errno)
▶ ERROR resource temporarily unavailable

Is there a way to start from scratch and login again?

maxtaco commented 8 years ago

Hmmm you are still running kbstage? What happens if you run keybase? And which platform are you on?

My guess is this is a bug in deprovision, that it doesn't reopen the local store after nuking it. @oconnor663 what do you think?

On Monday, November 23, 2015, Mark Whitney notifications@github.com wrote:

I installed the latest .deb and tried this again. I tried logging in and using option 4), which looks like it shells out to GPG to create a device key or something, but it failed with a weird GPG error. I lost the terminal buffer before I could paste it here.

I ran deprovision and now when I try to login, I get this error:

$ kbstage login ▶ WARNING Running in staging mode How would you like to sign this install of Keybase?

(1) Use an existing device (2) Use a paper key (3) Use my Keybase passphrase (4) Use GPG Choose a signing option: 4 In order to authorize this installation, keybase needs to sign this installation with your GPG secret key.

You have two options.

(1) Keybase can use GPG commands to sign the installation.

(2) Keybase can export your secret key from GPG and save it to keybase's local encrypted keyring. This way, it can be used in 'keybase pgp sign' and 'keybase pgp decrypt' going forward. Which do you prefer?: 2 Algo Key Id Created UserId

= ==== ====== ======= ====== 1 R EF6ED8E7C37B3370 2014-03-24 Mark G. Whitney mark@whitneyindustries.com javascript:_e(%7B%7D,'cvml','mark@whitneyindustries.com');, Mark G. Whitney markwhitney@gmail.com javascript:_e(%7B%7D,'cvml','markwhitney@gmail.com');, kramimus kramimus@gmail.com javascript:_e(%7B%7D,'cvml','kramimus@gmail.com');, kramimus kramimus@keybase.io javascript:_e(%7B%7D,'cvml','kramimus@keybase.io'); 2 R 4368ECA26E351AB6 2011-03-20 Mark G. Whitney markwhitney@gmail.com javascript:_e(%7B%7D,'cvml','markwhitney@gmail.com'); Choose a key: 1 ▶ WARNING Failed to load fb53422d3236dfd34bd73c7c9963c200 from storage: resource temporarily unavailable ▶ WARNING not exportable error: resource temporarily unavailable (syscall.Errno) ▶ ERROR resource temporarily unavailable

Is there a way to start from scratch and login again?

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-159105238 .

kramimus commented 8 years ago

$ kbstage --version keybase version 1.0.1-0

keybase seems to still be OK. I am on Ubuntu 15.10.

danpolanco commented 8 years ago

I'm on mac OS X with brew installation: El Capitan 10.11.1 Keybase Client: 1.0.1-0 Keybase Service: 1.0.1-0

Received this error INFO PGP: openpgp: unsupported feature: S2K function as well. Tried the command line method and received ▶ ERROR no device id set.

I have a Yubikey registered with this key as well as multiple subkeys. This is without the Yubikey inserted but all private keys are stored on the computer locally.

Is it safe to post output of gpg --export-secret-key EF6ED8E7C37B3370 | gpg --list-packets | grep S2K?

patrickxb commented 8 years ago

@kramimus and @DanTheColoradan : Once you select option (4) for GPG, can you try option (1) "Keybase can use GPG commands to sign the installation." instead of option (2)?

That should get around the openpgp unsupported feature: S2K function.

And @kramimus if you get ERROR resource temporarily unavailable again, can you post the result of ps ax | grep keybase?

Thanks!

maxtaco commented 8 years ago

Concurrently, I'll look into supporting this S2K GNU dummy feature

danpolanco commented 8 years ago

@patrickxb I had the issue of ▶ ERROR no device id set when I used option 4 -> option 2 earlier.

http://pastebin.com/Pcw1qZuM

patrickxb commented 8 years ago

@DanTheColoradan could you could add the -d flag (keybase -d login) choose option 4, then option 1 (as you did in the pastebin above) and send me the debug output? That would be very helpful. You can email it to me (patrick at keybase io) as it will probably be very long.

Thank you for all your help! I've been trying to reproduce locally to no avail.

kramimus commented 8 years ago 
$ ps -ef | grep keybase
mark     23392     1  0 Nov23 ?        00:00:07 /usr/bin/kbstage service --chdir /run/user/1000/keybase.staging --auto-forked

I killed that process and tried the login again:

$ kbstage -d login
14:49:32.599264 ▶ [DEBU keybase json.go:40] 001 + loading config file: /home/mark/.config/keybase.staging/config.json
14:49:32.599302 ▶ [DEBU keybase json.go:48] 002 No config file found; tried /home/mark/.config/keybase.staging/config.json
14:49:32.599333 ▶ [DEBU keybase config.go:114] 003 Config: mapping server -> 
14:49:32.599425 ▶ [DEBU keybase config.go:114] 004 Config: mapping socket_file -> 
14:49:32.599492 ▶ [DEBU keybase config.go:114] 005 Config: mapping timers -> 
14:49:32.599508 ▶ [DEBU keybase globals.go:189] 006 Keybase CLI 1.0.1-0
14:49:32.599519 ▶ [DEBU keybase globals.go:189] 007 - Built with go1.5.1
14:49:32.599533 ▶ [DEBU keybase globals.go:189] 008 - Visit https://keybase.io for more details
14:49:32.599550 ▶ [WARN keybase main.go:57] 009 Running in staging mode
14:49:32.599562 ▶ [DEBU keybase main.go:100] 00a + configureProcesses
14:49:32.599581 ▶ [DEBU keybase fork_server.go:47] 00b Getting flock
14:49:32.599609 ▶ [DEBU keybase config.go:114] 00c Config: mapping pid_file -> 
14:49:32.599640 ▶ [DEBU keybase fork_server.go:64] 00d The server is still up
14:49:32.599653 ▶ [DEBU keybase main.go:157] 00e | After forks; newProc=false
14:49:32.599671 ▶ [DEBU keybase main.go:178] 00f + configureLogging
14:49:32.599690 ▶ [DEBU keybase config.go:114] 010 Config: mapping local_rpc_debug -> 
14:49:32.599707 ▶ [DEBU keybase socket_nix.go:23] 011 Dialing unix:/run/user/1000/keybase.staging/keybased.sock
14:49:32.599772 ▶ [DEBU keybase config.go:114] 012 Config: mapping local_rpc_debug -> 
14:49:32.599837 ▶ [DEBU keybase main.go:214] 013 Setting remote log level: 1
14:49:32.600285 ▶ [DEBU keybase main.go:180] 014 - configureLogging
14:49:32.600333 ▶ [DEBU keybase versionfix.go:21] 015 + FixVersionClash
14:49:32.600635 ▶ [DEBU keybase log.go:30] 016 Config: mapping server -> 
14:49:32.600846 ▶ [DEBU keybase log.go:30] 017 Config: mapping socket_file -> 
14:49:32.601070 ▶ [DEBU keybase log.go:30] 018 | configured GPG w/ path: /usr/bin/gpg2
14:49:32.601267 ▶ [DEBU keybase log.go:30] 019 | configured GPG w/ path: /usr/bin/gpg2
14:49:32.601430 ▶ [DEBU keybase log.go:30] 01a Config: mapping config_file -> 
14:49:32.601583 ▶ [DEBU keybase log.go:30] 01b Config: mapping home -> 
14:49:32.601784 ▶ [DEBU keybase versionfix.go:33] 01c | Contacted service; got version: 1.0.1-0
14:49:32.601814 ▶ [DEBU keybase versionfix.go:55] 01d | version check 1.0.1-0 v 1.0.1-0
14:49:32.601832 ▶ [DEBU keybase versionfix.go:57] 01e | versions check out
14:49:32.601844 ▶ [DEBU keybase versionfix.go:23] 01f - FixVersionClash -> <nil>
14:49:32.601856 ▶ [DEBU keybase main.go:102] 020 - configureProcesses -> <nil>
14:49:32.602053 ▶ [DEBU keybase log.go:30] 021 + RunEngine(Login)
14:49:32.602215 ▶ [DEBU keybase log.go:30] 022 + RunEngine(LoginCurrentDevice)
14:49:32.602429 ▶ [DEBU keybase log.go:30] 023 + Account "LoggedInProvisionedLoad"
14:49:32.602644 ▶ [DEBU keybase log.go:30] 024 + Loading session
14:49:32.602788 ▶ [DEBU keybase log.go:30] 025 Config: mapping session_file -> 
14:49:32.602930 ▶ [DEBU keybase log.go:30] 026 Config: mapping home -> 
14:49:32.603105 ▶ [DEBU keybase log.go:30] 027 Config: mapping session_file -> 
14:49:32.603249 ▶ [DEBU keybase log.go:30] 028 Config: mapping home -> 
14:49:32.603439 ▶ [DEBU keybase log.go:30] 029 + loading session file: /home/mark/.cache/keybase.staging/session.json
14:49:32.603609 ▶ [DEBU keybase log.go:30] 02a No session file found; tried /home/mark/.cache/keybase.staging/session.json
14:49:32.603748 ▶ [DEBU keybase log.go:30] 02b - Loaded session
14:49:32.603908 ▶ [DEBU keybase log.go:30] 02c - Account "LoggedInProvisionedLoad"
14:49:32.604050 ▶ [DEBU keybase log.go:30] 02d error getting user config: <root>.current_user: no such key: current_user (*jsonw.Error)
14:49:32.604200 ▶ [DEBU keybase log.go:30] 02e - RunEngine(LoginCurrentDevice) -> ERROR: No user config available
14:49:32.604372 ▶ [DEBU keybase log.go:30] 02f LoginCurrentDevice error: No user config available (continuing with device provisioning...)
14:49:32.604535 ▶ [DEBU keybase log.go:30] 030 + RunEngine(LoginProvision)
14:49:32.604702 ▶ [DEBU keybase log.go:30] 031 | configured GPG w/ path: /usr/bin/gpg2
14:49:32.604869 ▶ [DEBU keybase log.go:30] 032 | running Gpg: /usr/bin/gpg2 [--with-colons --fingerprint -K]
14:49:32.608302 ▶ [DEBU keybase log.go:30] 033 have gpg.  num private keys: 4
14:49:32.608529 ▶ [DEBU keybase log.go:30] 034 found gpg with private keys?: true
How would you like to sign this install of Keybase?

(1) Use an existing device
(2) Use a paper key
(3) Use my Keybase passphrase
(4) Use GPG
Choose a signing option: 4
In order to authorize this installation, keybase needs to sign this installation
with your GPG secret key.

You have two options.

(1) Keybase can use GPG commands to sign the installation.

(2) Keybase can export your secret key from GPG and save it to keybase's local encrypted
    keyring. This way, it can be used in 'keybase pgp sign' and 'keybase pgp decrypt' 
    going forward.
Which do you prefer?: 1
14:49:35.359982 ▶ [DEBU keybase log.go:30] 035 | running Gpg: /usr/bin/gpg2 [--with-colons --fingerprint -K]
#    Algo   Key Id             Created      UserId
=    ====   ======             =======      ======
1    R      EF6ED8E7C37B3370   2014-03-24   Mark G. Whitney <mark@whitneyindustries.com>, Mark G. Whitney <markwhitney@gmail.com>, kramimus <kramimus@gmail.com>, kramimus <kramimus@keybase.io>
...

Choose a key: 1
14:49:36.087980 ▶ [DEBU keybase log.go:30] 036 SelectKey result: EF6ED8E7C37B3370
14:49:36.088191 ▶ [DEBU keybase log.go:30] 037 + API GET request to https://stage0.keybase.io/_/api/1.0/key/basics.json?fingerprint=103ce381391cc7be7f9c9962ef6ed8e7c37b3370
14:49:36.173557 ▶ [DEBU keybase log.go:30] 038 | Result is: 200 OK
14:49:36.173812 ▶ [DEBU keybase log.go:30] 039 found user (kramimus, fb53422d3236dfd34bd73c7c9963c200) for key 103ce381391cc7be7f9c9962ef6ed8e7c37b3370
14:49:36.174034 ▶ [DEBU keybase log.go:30] 03a LoginProvision: loading user kramimus
14:49:36.174226 ▶ [DEBU keybase log.go:30] 03b LoadUser: {UID: Name:kramimus PublicKeyOptional:true NoCacheResult:false Self:false ForceReload:false AllKeys:false LoginContext:<nil> Contextified:{g:0xc820124420}}
14:49:36.174376 ▶ [DEBU keybase log.go:30] 03c + LoadUser(uid=, name=kramimus)
14:49:36.174522 ▶ [DEBU keybase log.go:30] 03d + Resolving username kramimus
14:49:36.174859 ▶ [DEBU keybase log.go:30] 03e + Account "G - GetMyUID - GetUID"
14:49:36.176057 ▶ [DEBU keybase log.go:30] 03f - Account "G - GetMyUID - GetUID"
14:49:36.176537 ▶ [DEBU keybase log.go:30] 040 | resolved to fb53422d3236dfd34bd73c7c9963c200
14:49:36.176738 ▶ [DEBU keybase log.go:30] 041 + loadUserFromLocalStorage(fb53422d3236dfd34bd73c7c9963c200)
14:49:36.176934 ▶ [DEBU keybase log.go:30] 042 + LevelDb.open
14:49:36.177120 ▶ [DEBU keybase log.go:30] 043 - LevelDb.open -> ok
14:49:36.178301 ▶ [DEBU keybase log.go:30] 044 | Loaded successfully
14:49:36.178474 ▶ [DEBU keybase log.go:30] 045 + ParseKeyFamily
14:49:36.186279 ▶ [DEBU keybase log.go:30] 046 - ParseKeyFamily -> ok
14:49:36.186465 ▶ [DEBU keybase log.go:30] 047 | Loaded username kramimus (uid=fb53422d3236dfd34bd73c7c9963c200)
14:49:36.186636 ▶ [DEBU keybase log.go:30] 048 - loadUserFromLocalStorage(kramimus,fb53422d3236dfd34bd73c7c9963c200)
14:49:36.186778 ▶ [DEBU keybase log.go:30] 049 + MerkleClient.LookupUser(map[uid:fb53422d3236dfd34bd73c7c9963c200])
14:49:36.186931 ▶ [DEBU keybase log.go:30] 04a + MerkleClient.LoadRoot()
14:49:36.187091 ▶ [DEBU keybase log.go:30] 04b + LevelDb.open
14:49:36.187240 ▶ [DEBU keybase log.go:30] 04c - LevelDb.open -> ok
14:49:36.187410 ▶ [DEBU keybase log.go:30] 04d + LevelDb.open
14:49:36.187553 ▶ [DEBU keybase log.go:30] 04e - LevelDb.open -> ok
14:49:36.187900 ▶ [DEBU keybase log.go:30] 04f - MerkleClient.LoadRoot() -> &{{0xc820124420} 292602 [165 69 104 91 61 230 200 247 178 95 52 7 251 250 218 73 174 145 93 134] 0xc820664690 {"body":{"key":{"fingerprint":"a545685b3de6c8f7b25f3407fbfada49ae915d86","key_id":"FBFADA49AE915D86"},"legacy_uid_root":"d3450288d233fe9125d0b6f8196dbc93447bca2630300898781a637a44752032","prev":"953a3476896ed36f8d15b6f4f41f07916a118796b6b8dbfbe4e41ac93fd0b0e6c36ee56d05b405d30bfb295c073736a8d2b4de7389fd38507767e53029b84200","root":"337ce86d9d9d6ed87063f33478db51bdc704c6d0f2c0093aeda92ae8526aaabbce448e8e5d4d0cec0fb5e7c4d71cab3379bfc3c2a701f47fa9f4601ff1125188","seqno":292602,"txid":"16136c0a289dacf35e990d6f75059415","type":"merkle_root","version":1},"ctime":1448374075,"tag":"signature"} 0xc820664810 [51 124 232 109 157 157 110 216 112 99 243 52 120 219 81 189 199 4 198 208 242 192 9 58 237 169 42 232 82 106 170 187 206 68 142 142 93 77 12 236 15 181 231 196 215 28 171 51 121 191 195 194 167 1 244 127 169 244 96 31 241 18 81 136] [211 69 2 136 210 51 254 145 37 208 182 248 25 109 188 147 68 123 202 38 48 48 8 152 120 26 99 122 68 117 32 50] 1448374075}
14:49:36.188069 ▶ [DEBU keybase log.go:30] 050 | LookupPath
14:49:36.188252 ▶ [DEBU keybase log.go:30] 051 + API GET request to https://stage0.keybase.io/_/api/1.0/merkle/path.json?poll=10&uid=fb53422d3236dfd34bd73c7c9963c200
14:49:36.369391 ▶ [DEBU keybase log.go:30] 052 | Result is: 200 OK
14:49:36.454684 ▶ [DEBU keybase log.go:30] 053 - successful API call
14:49:36.455009 ▶ [DEBU keybase log.go:30] 054 | VerifyRoot
14:49:36.455221 ▶ [DEBU keybase log.go:30] 055 | Merkle root: got back 292602, >= cached 292602
14:49:36.455408 ▶ [DEBU keybase log.go:30] 056 | VerifyUser
14:49:36.457533 ▶ [DEBU keybase log.go:30] 057 + ParsingMerkleUserLeaf
14:49:36.457766 ▶ [DEBU keybase log.go:30] 058 - ParsingMerkleUserLeaf -> ok
14:49:36.457989 ▶ [DEBU keybase log.go:30] 059 | VerifyUsername
14:49:36.458281 ▶ [DEBU keybase log.go:30] 05a | Failed to map Username kramimus -> UID fb53422d3236dfd34bd73c7c9963c200 via direct hash
14:49:36.459376 ▶ [DEBU keybase log.go:30] 05b | Username kramimus mapped to fb53422d3236dfd34bd73c7c9963c200 via Merkle lookup
14:49:36.459838 ▶ [DEBU keybase log.go:30] 05c - MerkleClient.LookupUser(map[uid:fb53422d3236dfd34bd73c7c9963c200 poll:10]) -> OK
14:49:36.460075 ▶ [DEBU keybase log.go:30] 05d | Local basics version is up-to-date @ version 57
14:49:36.460311 ▶ [DEBU keybase log.go:30] 05e | Freshness: basics=true; for fb53422d3236dfd34bd73c7c9963c200
14:49:36.460635 ▶ [DEBU keybase log.go:30] 05f + SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200)
14:49:36.460865 ▶ [DEBU keybase log.go:30] 060 | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) GetFingerprint
14:49:36.461099 ▶ [DEBU keybase log.go:30] 061 | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) AccessPreload
14:49:36.461253 ▶ [DEBU keybase log.go:30] 062 | Preload failed
14:49:36.461414 ▶ [DEBU keybase log.go:30] 063 | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) LoadLinksFromStorage
14:49:36.461619 ▶ [DEBU keybase log.go:30] 064 + SigChainLoader.LoadFromStorage(fb53422d3236dfd34bd73c7c9963c200)
14:49:36.461793 ▶ [DEBU keybase log.go:30] 065 + LevelDb.open
14:49:36.461973 ▶ [DEBU keybase log.go:30] 066 - LevelDb.open -> ok
14:49:36.462264 ▶ [DEBU keybase log.go:30] 067 | loading link; curr=b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8
14:49:36.462466 ▶ [DEBU keybase log.go:30] 068 + LevelDb.open
14:49:36.462619 ▶ [DEBU keybase log.go:30] 069 - LevelDb.open -> ok
14:49:36.462992 ▶ [DEBU keybase log.go:30] 06a | Link is marked as 'sig_verified'
14:49:36.463227 ▶ [DEBU keybase log.go:30] 06b | Unpacked Link b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8
14:49:36.463412 ▶ [DEBU keybase log.go:30] 06c | Setting loadKID=01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a
14:49:36.463579 ▶ [DEBU keybase log.go:30] 06d | loading link; curr=b980c32a5ada9fe3d95abb98fe5a791f3b67656a217138d40d71d5559992aa18
14:49:36.463723 ▶ [DEBU keybase log.go:30] 06e + LevelDb.open
14:49:36.463877 ▶ [DEBU keybase log.go:30] 06f - LevelDb.open -> ok
14:49:36.464162 ▶ [DEBU keybase log.go:30] 070 | Unpacked Link b980c32a5ada9fe3d95abb98fe5a791f3b67656a217138d40d71d5559992aa18
14:49:36.464319 ▶ [DEBU keybase log.go:30] 071 | loading link; curr=bf5518e7418db92e4bf44359899ccf0c32722154332dae24358691ffad575000
14:49:36.464488 ▶ [DEBU keybase log.go:30] 072 + LevelDb.open
14:49:36.464619 ▶ [DEBU keybase log.go:30] 073 - LevelDb.open -> ok
14:49:36.464887 ▶ [DEBU keybase log.go:30] 074 | Unpacked Link bf5518e7418db92e4bf44359899ccf0c32722154332dae24358691ffad575000
14:49:36.465036 ▶ [DEBU keybase log.go:30] 075 | loading link; curr=708adfc888829ff5d813c8a25313a0c299fd40efec7ab0bd7b44efa392226366
14:49:36.465176 ▶ [DEBU keybase log.go:30] 076 + LevelDb.open
14:49:36.465329 ▶ [DEBU keybase log.go:30] 077 - LevelDb.open -> ok
14:49:36.465671 ▶ [DEBU keybase log.go:30] 078 | Unpacked Link 708adfc888829ff5d813c8a25313a0c299fd40efec7ab0bd7b44efa392226366
14:49:36.465824 ▶ [DEBU keybase log.go:30] 079 | loading link; curr=72106715e45889cf3576151d062e6334c0edf2a2de65c06fe3accbfa7de7825e
14:49:36.465960 ▶ [DEBU keybase log.go:30] 07a + LevelDb.open
14:49:36.466120 ▶ [DEBU keybase log.go:30] 07b - LevelDb.open -> ok
14:49:36.466407 ▶ [DEBU keybase log.go:30] 07c | Unpacked Link 72106715e45889cf3576151d062e6334c0edf2a2de65c06fe3accbfa7de7825e
14:49:36.466575 ▶ [DEBU keybase log.go:30] 07d | loading link; curr=b4ad4041db45659f977fff41cab5cd62f8eac8be4926455363858ad88aaef220
14:49:36.466735 ▶ [DEBU keybase log.go:30] 07e + LevelDb.open
14:49:36.466875 ▶ [DEBU keybase log.go:30] 07f - LevelDb.open -> ok
14:49:36.467147 ▶ [DEBU keybase log.go:30] 080 | Unpacked Link b4ad4041db45659f977fff41cab5cd62f8eac8be4926455363858ad88aaef220
14:49:36.467294 ▶ [DEBU keybase log.go:30] 081 | loading link; curr=2362b487756b4ee0fe13aca7f03ee65777b624a1211275f65e10baca3e3395b3
14:49:36.467443 ▶ [DEBU keybase log.go:30] 082 + LevelDb.open
14:49:36.467601 ▶ [DEBU keybase log.go:30] 083 - LevelDb.open -> ok
14:49:36.467875 ▶ [DEBU keybase log.go:30] 084 | Unpacked Link 2362b487756b4ee0fe13aca7f03ee65777b624a1211275f65e10baca3e3395b3
14:49:36.468050 ▶ [DEBU keybase log.go:30] 085 | loading link; curr=4742b61bb1976457316bc3dd71dc1d7368bd36d68922f2ceafd65b358759cebd
14:49:36.468197 ▶ [DEBU keybase log.go:30] 086 + LevelDb.open
14:49:36.468344 ▶ [DEBU keybase log.go:30] 087 - LevelDb.open -> ok
14:49:36.468662 ▶ [DEBU keybase log.go:30] 088 | Unpacked Link 4742b61bb1976457316bc3dd71dc1d7368bd36d68922f2ceafd65b358759cebd
14:49:36.468841 ▶ [DEBU keybase log.go:30] 089 | loading link; curr=fa4ff1c39c6320f06193f3ae724f1eb25437738af195f8adac58e260bee819eb
14:49:36.468970 ▶ [DEBU keybase log.go:30] 08a + LevelDb.open
14:49:36.469132 ▶ [DEBU keybase log.go:30] 08b - LevelDb.open -> ok
14:49:36.469435 ▶ [DEBU keybase log.go:30] 08c | Unpacked Link fa4ff1c39c6320f06193f3ae724f1eb25437738af195f8adac58e260bee819eb
14:49:36.469580 ▶ [DEBU keybase log.go:30] 08d | loading link; curr=99382d21aae31cf5a9ab57d6dcb1746910df74bf1c06c42f86fb880f683bef73
14:49:36.469725 ▶ [DEBU keybase log.go:30] 08e + LevelDb.open
14:49:36.469856 ▶ [DEBU keybase log.go:30] 08f - LevelDb.open -> ok
14:49:36.470170 ▶ [DEBU keybase log.go:30] 090 | Unpacked Link 99382d21aae31cf5a9ab57d6dcb1746910df74bf1c06c42f86fb880f683bef73
14:49:36.470318 ▶ [DEBU keybase log.go:30] 091 | loading link; curr=6d29f39124924d9f8aff3466a2b26363a8190fa903de025dbbadb2e494449e90
14:49:36.470476 ▶ [DEBU keybase log.go:30] 092 + LevelDb.open
14:49:36.470629 ▶ [DEBU keybase log.go:30] 093 - LevelDb.open -> ok
14:49:36.470938 ▶ [DEBU keybase log.go:30] 094 | Unpacked Link 6d29f39124924d9f8aff3466a2b26363a8190fa903de025dbbadb2e494449e90
14:49:36.471075 ▶ [DEBU keybase log.go:30] 095 | loading link; curr=3f8aff5a6bbf88e9d2f78840511e0c8d9d03be56c5a6dd69b42f6c8f55558a0c
14:49:36.471206 ▶ [DEBU keybase log.go:30] 096 + LevelDb.open
14:49:36.471357 ▶ [DEBU keybase log.go:30] 097 - LevelDb.open -> ok
14:49:36.471725 ▶ [DEBU keybase log.go:30] 098 | Unpacked Link 3f8aff5a6bbf88e9d2f78840511e0c8d9d03be56c5a6dd69b42f6c8f55558a0c
14:49:36.471981 ▶ [DEBU keybase log.go:30] 099 | loading link; curr=bcf6cfbb64f49758e0d998533c359ca0c98a7356c6edddbd973bc81837705876
14:49:36.472150 ▶ [DEBU keybase log.go:30] 09a + LevelDb.open
14:49:36.472385 ▶ [DEBU keybase log.go:30] 09b - LevelDb.open -> ok
14:49:36.472736 ▶ [DEBU keybase log.go:30] 09c | Unpacked Link bcf6cfbb64f49758e0d998533c359ca0c98a7356c6edddbd973bc81837705876
14:49:36.472885 ▶ [DEBU keybase log.go:30] 09d | loading link; curr=15c4a4136579e5924144064f898f4608d9fd2ee839267dc3a763e33ff6b9df6d
14:49:36.473029 ▶ [DEBU keybase log.go:30] 09e + LevelDb.open
14:49:36.473182 ▶ [DEBU keybase log.go:30] 09f - LevelDb.open -> ok
14:49:36.473516 ▶ [DEBU keybase log.go:30] 0a0 | Unpacked Link 15c4a4136579e5924144064f898f4608d9fd2ee839267dc3a763e33ff6b9df6d
14:49:36.473670 ▶ [DEBU keybase log.go:30] 0a1 | loading link; curr=4105c78c88e08ed89773824cac7f29dbfad9b9f4480b4f3b95eb5d06a5612c7a
14:49:36.473831 ▶ [DEBU keybase log.go:30] 0a2 + LevelDb.open
14:49:36.473988 ▶ [DEBU keybase log.go:30] 0a3 - LevelDb.open -> ok
14:49:36.474263 ▶ [DEBU keybase log.go:30] 0a4 | Unpacked Link 4105c78c88e08ed89773824cac7f29dbfad9b9f4480b4f3b95eb5d06a5612c7a
14:49:36.474416 ▶ [DEBU keybase log.go:30] 0a5 | loading link; curr=a45ac030c36bc1a81eecbab3c1fb006c033ddbf8a7227cff8fec367bc438b5f8
14:49:36.474591 ▶ [DEBU keybase log.go:30] 0a6 + LevelDb.open
14:49:36.474729 ▶ [DEBU keybase log.go:30] 0a7 - LevelDb.open -> ok
14:49:36.475044 ▶ [DEBU keybase log.go:30] 0a8 | Unpacked Link a45ac030c36bc1a81eecbab3c1fb006c033ddbf8a7227cff8fec367bc438b5f8
14:49:36.475198 ▶ [DEBU keybase log.go:30] 0a9 | loading link; curr=8eb55103b4d7bd981af37fed29dfa95b280f8496c6ebcb6084a77eccbad049c3
14:49:36.475348 ▶ [DEBU keybase log.go:30] 0aa + LevelDb.open
14:49:36.475508 ▶ [DEBU keybase log.go:30] 0ab - LevelDb.open -> ok
14:49:36.475829 ▶ [DEBU keybase log.go:30] 0ac | Unpacked Link 8eb55103b4d7bd981af37fed29dfa95b280f8496c6ebcb6084a77eccbad049c3
14:49:36.475999 ▶ [DEBU keybase log.go:30] 0ad | Stop loading at KID=01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a (!= KID=010165bee8c1e1059a17b63c232ba2cd56069ab0fa8aa7660ee0a22c19caf75810430a)
14:49:36.476165 ▶ [DEBU keybase log.go:30] 0ae - SigChainLoader.LoadFromStorage(fb53422d3236dfd34bd73c7c9963c200) -> ok
14:49:36.476313 ▶ [DEBU keybase log.go:30] 0af | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) MakeSigChain
14:49:36.476466 ▶ [DEBU keybase log.go:30] 0b0 | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) VerifyChain
14:49:36.476619 ▶ [DEBU keybase log.go:30] 0b1 + SigChain::VerifyChain()
14:49:36.482341 ▶ [DEBU keybase log.go:30] 0b2 - SigChain::VerifyChain() -> ok
14:49:36.483438 ▶ [DEBU keybase log.go:30] 0b3 | SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) CheckFreshness
14:49:36.483656 ▶ [DEBU keybase log.go:30] 0b4 + CheckFreshness
14:49:36.483832 ▶ [DEBU keybase log.go:30] 0b5 | Server triple: &{22 b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8 cf77c12bed0632f53df0ea8ae1c6ed44e1d1a3262b5bf1e9f47a4fe91f63373d0f}
14:49:36.484018 ▶ [DEBU keybase log.go:30] 0b6 | Client triple: &{22 b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8 }
14:49:36.484168 ▶ [DEBU keybase log.go:30] 0b7 | Future triple=nil
14:49:36.484376 ▶ [DEBU keybase log.go:30] 0b8 | Local chain version is up-to-date @ version 22
14:49:36.484573 ▶ [DEBU keybase log.go:30] 0b9 - CheckFreshness (fb53422d3236dfd34bd73c7c9963c200) -> (false,ok)
14:49:36.484734 ▶ [DEBU keybase log.go:30] 0ba - SigChainLoader.Load(fb53422d3236dfd34bd73c7c9963c200) -> (true, ok)
14:49:36.484891 ▶ [DEBU keybase log.go:30] 0bb + LoadSigHints(fb53422d3236dfd34bd73c7c9963c200)
14:49:36.485046 ▶ [DEBU keybase log.go:30] 0bc + LevelDb.open
14:49:36.485204 ▶ [DEBU keybase log.go:30] 0bd - LevelDb.open -> ok
14:49:36.485628 ▶ [DEBU keybase log.go:30] 0be | SigHints loaded @v2
14:49:36.485780 ▶ [DEBU keybase log.go:30] 0bf - LoadSigHints(fb53422d3236dfd34bd73c7c9963c200)
14:49:36.485914 ▶ [DEBU keybase log.go:30] 0c0 + Refresh SigHints() for uid=fb53422d3236dfd34bd73c7c9963c200
14:49:36.486089 ▶ [DEBU keybase log.go:30] 0c1 + API GET request to https://stage0.keybase.io/_/api/1.0/sig/hints.json?low=2&uid=fb53422d3236dfd34bd73c7c9963c200
14:49:36.839583 ▶ [DEBU keybase log.go:30] 0c2 | Result is: 200 OK
14:49:36.839817 ▶ [DEBU keybase log.go:30] 0c3 - successful API call
14:49:36.840004 ▶ [DEBU keybase log.go:30] 0c4 | No changes; version 2 was up-to-date
14:49:36.840163 ▶ [DEBU keybase log.go:30] 0c5 - Refresh SigHints() for uid=fb53422d3236dfd34bd73c7c9963c200
14:49:36.840314 ▶ [DEBU keybase log.go:30] 0c6 + Store user kramimus
14:49:36.840495 ▶ [DEBU keybase log.go:30] 0c7 + SigHints.Store() for uid=fb53422d3236dfd34bd73c7c9963c200
14:49:36.840640 ▶ [DEBU keybase log.go:30] 0c8 | SigHints.Store() skipped; wasn't dirty
14:49:36.840765 ▶ [DEBU keybase log.go:30] 0c9 - SigHints.Store() for uid=fb53422d3236dfd34bd73c7c9963c200 -> ok
14:49:36.840920 ▶ [DEBU keybase log.go:30] 0ca - Store for kramimus skipped; user wasn't dirty
14:49:36.841089 ▶ [DEBU keybase log.go:30] 0cb + Populate ID Table
14:49:36.841420 ▶ [DEBU keybase log.go:30] 0cc - Populate ID Table
14:49:36.841544 ▶ [DEBU keybase log.go:30] 0cd + VerifySelfSig for user kramimus
14:49:36.841740 ▶ [DEBU keybase log.go:30] 0ce | Found self-signature for kramimus @uid=fb53422d3236dfd34bd73c7c9963c200, seq=22, link=b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8
14:49:36.841876 ▶ [DEBU keybase log.go:30] 0cf - VerifySelfSig via SigChain
14:49:36.842019 ▶ [DEBU keybase log.go:30] 0d0 using gpg key 01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a
14:49:36.842174 ▶ [DEBU keybase log.go:30] 0d1 + LoginWithPrompt(kramimus) called
14:49:36.842302 ▶ [DEBU keybase log.go:30] 0d2 + Login "loginWithPromptHelper"
14:49:36.842469 ▶ [DEBU keybase log.go:30] 0d3 + checkedLoggedIn()
14:49:36.842624 ▶ [DEBU keybase log.go:30] 0d4 + Loading session
14:49:36.842774 ▶ [DEBU keybase log.go:30] 0d5 - Skipped; already loaded
14:49:36.842923 ▶ [DEBU keybase log.go:30] 0d6 - checkedLoggedIn() -> false, ok
14:49:36.843159 ▶ [DEBU keybase log.go:30] 0d7 | Can't switch user to kramimus: User  wasn't found (kramimus)
14:49:36.843290 ▶ [DEBU keybase log.go:30] 0d8 + pubkeyLoginHelper()
14:49:36.843452 ▶ [DEBU keybase log.go:30] 0d9 | No Userconfig for kramimus: Bad UID ''; must be 16 bytes long
14:49:36.843606 ▶ [DEBU keybase log.go:30] 0da - pubkeyLoginHelper() -> ERROR: Bad UID ''; must be 16 bytes long
14:49:36.843752 ▶ [DEBU keybase log.go:30] 0db | Public key login failed, falling back: Bad UID ''; must be 16 bytes long
14:49:36.843902 ▶ [DEBU keybase log.go:30] 0dc + LoginState.passphraseLogin (username=kramimus)
14:49:36.844058 ▶ [DEBU keybase log.go:30] 0dd + API GET request to https://stage0.keybase.io/_/api/1.0/getsalt.json?email_or_username=kramimus
14:49:36.930529 ▶ [DEBU keybase log.go:30] 0de | Result is: 200 OK
14:49:36.930787 ▶ [DEBU keybase log.go:30] 0df - successful API call
14:49:36.930949 ▶ [DEBU keybase log.go:30] 0e0 + stretchPassphraseIfNecessary (kramimus)
14:49:36.931096 ▶ [DEBU keybase log.go:30] 0e1 | stretchPassphraseIfNecessary: getting keybase passphrase via ui
14:49:36.931256 ▶ [DEBU keybase secret_entry.go:30] 0e2 + SecretEntry.Init()
14:49:36.931301 ▶ [DEBU keybase pinentry_nix.go:62] 0e3 + FindPinentry()
14:49:36.931315 ▶ [DEBU keybase pinentry_nix.go:71] 0e4 | Check fullpath /usr/local/MacGPG2/libexec/pinentry-mac.app/Contents/MacOS/pinentry-mac
14:49:36.931342 ▶ [DEBU keybase pinentry_nix.go:87] 0e5 | Looking for pinentry-gtk-2 in standard PATH /home/mark/.virtualenvs/web/bin:/home/mark/.rbenv/shims:/home/mark/.rbenv/bin:/home/mark/.rbenv/shims:/home/mark/.rbenv/bin:/home/mark/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/home/mark/bin:/home/mark/dev/dashboard/scripts:/home/mark/.local/bin:/home/mark/work/go/bin:/home/mark/work/scripts:/home/mark/work/arcanist/bin/arc:/home/mark/work/pebble-dev/sdk/bin:/home/mark/work/adt/sdk/tools:/home/mark/work/adt/sdk/platform-tools:/home/mark/rescale/rescale-platform-web/node_modules/.bin:/usr/local/maven/bin:/home/mark/bin
14:49:36.931393 ▶ [DEBU keybase pinentry_nix.go:90] 0e6 - Found /usr/bin/pinentry-gtk-2
14:49:36.931424 ▶ [DEBU keybase pinentry_nix.go:122] 0e7 | found tty=/dev/pts/1
14:49:36.931443 ▶ [DEBU keybase secret_entry.go:47] 0e8 | Pinentry initialized
14:49:36.931455 ▶ [DEBU keybase secret_entry.go:59] 0e9 - SecretEntry.Init() -> ok
14:49:36.931469 ▶ [DEBU keybase pinentry.go:78] 0ea + Pinentry::Get()
14:49:36.931480 ▶ [DEBU keybase pinentry.go:131] 0eb + pinentryInstance::Init()
14:49:36.937843 ▶ [DEBU keybase pinentry.go:157] 0ec setting ttyname to /dev/pts/1
14:49:36.937930 ▶ [DEBU keybase pinentry.go:164] 0ed setting ttytype to rxvt-unicode
14:49:36.937973 ▶ [DEBU keybase pinentry.go:171] 0ee - pinentryInstance::Init() -> <nil>
14:49:39.344048 ▶ [DEBU keybase pinentry.go:95] 0ef - Pinentry::Get() -> <nil>
14:49:39.461408 ▶ [DEBU keybase log.go:30] 0f0 - stretchPassphraseIfNecessary
14:49:39.461637 ▶ [DEBU keybase log.go:30] 0f1 + API Post request to https://stage0.keybase.io/_/api/1.0/login.json
14:49:39.692542 ▶ [DEBU keybase log.go:30] 0f2 | Result is: 200 OK
14:49:39.694442 ▶ [DEBU keybase log.go:30] 0f3 - successful API call
14:49:39.694667 ▶ [DEBU keybase log.go:30] 0f4 | SetUserConfig(kramimus)
14:49:39.694885 ▶ [DEBU keybase log.go:30] 0f5 + saving config file /home/mark/.config/keybase.staging/config.json
14:49:39.698003 ▶ [DEBU keybase log.go:30] 0f6 Created parent directory /home/mark/.config/keybase.staging/
14:49:39.698249 ▶ [DEBU keybase log.go:30] 0f7 Wrote config file to /home/mark/.config/keybase.staging/config.json
14:49:39.698406 ▶ [DEBU keybase log.go:30] 0f8 - saved config file /home/mark/.config/keybase.staging/config.json
14:49:39.698573 ▶ [DEBU keybase log.go:30] 0f9 + saving session file /home/mark/.cache/keybase.staging/session.json
14:49:39.698790 ▶ [DEBU keybase log.go:30] 0fa Wrote session file to /home/mark/.cache/keybase.staging/session.json
14:49:39.698954 ▶ [DEBU keybase log.go:30] 0fb - saved session file /home/mark/.cache/keybase.staging/session.json
14:49:39.699109 ▶ [DEBU keybase log.go:30] 0fc passphraseLogin success
14:49:39.699281 ▶ [DEBU keybase log.go:30] 0fd - LoginState.passphraseLogin -> ok
Enter a public name for this device: eddie
14:49:42.671970 ▶ [DEBU keybase log.go:30] 0fe + RunEngine(DeviceWrap)
14:49:42.672166 ▶ [DEBU keybase log.go:30] 0ff + RunEngine(DeviceRegister)
14:49:42.672396 ▶ [DEBU keybase log.go:30] 100 Device name:   eddie
14:49:42.672559 ▶ [DEBU keybase log.go:30] 101 Device ID:     5487213c241e840e74f24643864a2f18
14:49:42.672739 ▶ [DEBU keybase log.go:30] 102 | Setting DeviceID to 5487213c241e840e74f24643864a2f18
14:49:42.672904 ▶ [DEBU keybase log.go:30] 103 | SetUserConfig(kramimus)
14:49:42.673125 ▶ [DEBU keybase log.go:30] 104 + saving config file /home/mark/.config/keybase.staging/config.json
14:49:42.673395 ▶ [DEBU keybase log.go:30] 105 Wrote config file to /home/mark/.config/keybase.staging/config.json
14:49:42.673557 ▶ [DEBU keybase log.go:30] 106 - saved config file /home/mark/.config/keybase.staging/config.json
14:49:42.673712 ▶ [DEBU keybase log.go:30] 107 Setting Device ID to 5487213c241e840e74f24643864a2f18
14:49:42.673876 ▶ [DEBU keybase log.go:30] 108 - RunEngine(DeviceRegister) -> ok
14:49:42.674015 ▶ [DEBU keybase log.go:30] 109 + RunEngine(DeviceKeygen)
14:49:42.674171 ▶ [DEBU keybase log.go:30] 10a + Loading session
14:49:42.674319 ▶ [DEBU keybase log.go:30] 10b - Skipped; already loaded
14:49:42.674458 ▶ [DEBU keybase log.go:30] 10c + Checking session
14:49:42.674637 ▶ [DEBU keybase log.go:30] 10d + API GET request to https://stage0.keybase.io/_/api/1.0/sesscheck.json
14:49:42.674813 ▶ [DEBU keybase log.go:30] 10e | Cli wasn't found; remaking for cookied=true
14:49:43.044668 ▶ [DEBU keybase log.go:30] 10f | Result is: 200 OK
14:49:43.048812 ▶ [DEBU keybase log.go:30] 110 - successful API call
14:49:43.049069 ▶ [DEBU keybase log.go:30] 111 | Stored session checked out
14:49:43.049371 ▶ [DEBU keybase log.go:30] 112 + saving session file /home/mark/.cache/keybase.staging/session.json
14:49:43.049748 ▶ [DEBU keybase log.go:30] 113 Wrote session file to /home/mark/.cache/keybase.staging/session.json
14:49:43.049973 ▶ [DEBU keybase log.go:30] 114 - saved session file /home/mark/.cache/keybase.staging/session.json
14:49:43.050203 ▶ [DEBU keybase log.go:30] 115 - Checked session
14:49:43.050914 ▶ [DEBU keybase log.go:30] 116 + LKsec:Encrypt()
14:49:43.051151 ▶ [DEBU keybase log.go:30] 117 + LKSec::Load()
14:49:43.051387 ▶ [DEBU keybase log.go:30] 118 | ServerHalf already loaded
14:49:43.051627 ▶ [DEBU keybase log.go:30] 119 | Making XOR'ed secret key for Local Key Security (LKS): ServerHalf=4266051befa3e61b322deddc50aecfd3824704470523bbd9423c6cbe0d09979d; clientHalf=0eb09170ba6803df98cadc8ccce9ae54a143e27cccf74fe219cc893fa94b5250
14:49:43.051871 ▶ [DEBU keybase log.go:30] 11a - LKSec::Load() -> ok
14:49:43.052117 ▶ [DEBU keybase log.go:30] 11b - LKSec::Encrypt() -> ok
14:49:43.052424 ▶ [DEBU keybase log.go:30] 11c + Loading session
14:49:43.052639 ▶ [DEBU keybase log.go:30] 11d - Skipped; already loaded
14:49:43.052925 ▶ [DEBU keybase log.go:30] 11e + Checking session
14:49:43.053118 ▶ [DEBU keybase log.go:30] 11f - session is recent, short-circuiting
14:49:43.053321 ▶ [DEBU keybase log.go:30] 120 Config: mapping secret_keyring -> 
14:49:43.053576 ▶ [DEBU keybase log.go:30] 121 Config: mapping home -> 
14:49:43.053832 ▶ [DEBU keybase log.go:30] 122 + Loading SKB keyring: /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.054199 ▶ [DEBU keybase log.go:30] 123 | Keybase secret keyring doesn't exist: /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.054451 ▶ [DEBU keybase log.go:30] 124 - Loaded SKB keyring: /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack -> ERROR: open /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack: no such file or directory
14:49:43.054690 ▶ [DEBU keybase log.go:30] 125 + Writing to /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.054951 ▶ [DEBU keybase log.go:30] 126 | Temporary file generated: /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack.DTSKWMX6GZPTQQLQANDD2FVHPIJK43EW
14:49:43.055145 ▶ [DEBU keybase log.go:30] 127 + WriteTo
14:49:43.055542 ▶ [DEBU keybase log.go:30] 128 - WriteTo
14:49:43.055841 ▶ [DEBU keybase log.go:30] 129 - Wrote to /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack -> ok
14:49:43.056066 ▶ [DEBU keybase log.go:30] 12a Updated keyring /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.056260 ▶ [DEBU keybase log.go:30] 12b + LKsec:Encrypt()
14:49:43.056476 ▶ [DEBU keybase log.go:30] 12c + LKSec::Load()
14:49:43.056663 ▶ [DEBU keybase log.go:30] 12d | Short-circuit; we already know the full secret
14:49:43.056846 ▶ [DEBU keybase log.go:30] 12e - LKSec::Load() -> ok
14:49:43.057027 ▶ [DEBU keybase log.go:30] 12f - LKSec::Encrypt() -> ok
14:49:43.057202 ▶ [DEBU keybase log.go:30] 130 + Loading session
14:49:43.057383 ▶ [DEBU keybase log.go:30] 131 - Skipped; already loaded
14:49:43.057572 ▶ [DEBU keybase log.go:30] 132 + Checking session
14:49:43.057814 ▶ [DEBU keybase log.go:30] 133 - session is recent, short-circuiting
14:49:43.058020 ▶ [DEBU keybase log.go:30] 134 + Writing to /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.058249 ▶ [DEBU keybase log.go:30] 135 | Temporary file generated: /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack.TV4H6ABWCZOEK3HHDYNSDQT72EDFQQ2F
14:49:43.058394 ▶ [DEBU keybase log.go:30] 136 + WriteTo
14:49:43.058706 ▶ [DEBU keybase log.go:30] 137 - WriteTo
14:49:43.058936 ▶ [DEBU keybase log.go:30] 138 - Wrote to /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack -> ok
14:49:43.059100 ▶ [DEBU keybase log.go:30] 139 Updated keyring /home/mark/.config/keybase.staging/secretkeys.kramimus.mpack
14:49:43.059259 ▶ [DEBU keybase log.go:30] 13a - RunEngine(DeviceKeygen) -> ok
14:49:43.060953 ▶ [DEBU keybase log.go:30] 13b + Delegator.Run()
14:49:43.061219 ▶ [DEBU keybase log.go:30] 13c + Delegator::checkArgs()
14:49:43.061734 ▶ [DEBU keybase log.go:30] 13d | Picked passed-in signing key
14:49:43.061956 ▶ [DEBU keybase log.go:30] 13e | Picked key 01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a for signing
14:49:43.062150 ▶ [DEBU keybase log.go:30] 13f - Delegator::checkArgs()
14:49:43.062321 ▶ [DEBU keybase log.go:30] 140 + GetLastKnownSeqno()
14:49:43.062484 ▶ [DEBU keybase log.go:30] 141 + GetLastLoadedSeqno()
14:49:43.062650 ▶ [DEBU keybase log.go:30] 142 | Fetched from main chain
14:49:43.062824 ▶ [DEBU keybase log.go:30] 143 - GetLastLoadedSeqno() -> 22
14:49:43.062959 ▶ [DEBU keybase log.go:30] 144 - GetLastKnownSeqno() -> 22
14:49:43.063122 ▶ [DEBU keybase log.go:30] 145 + MerkleClient.LoadRoot()
14:49:43.063269 ▶ [DEBU keybase log.go:30] 146 + LevelDb.open
14:49:43.063422 ▶ [DEBU keybase log.go:30] 147 - LevelDb.open -> ok
14:49:43.063565 ▶ [DEBU keybase log.go:30] 148 + LevelDb.open
14:49:43.063713 ▶ [DEBU keybase log.go:30] 149 - LevelDb.open -> ok
14:49:43.064079 ▶ [DEBU keybase log.go:30] 14a - MerkleClient.LoadRoot() -> &{{0xc820124420} 292602 [165 69 104 91 61 230 200 247 178 95 52 7 251 250 218 73 174 145 93 134] 0xc82031bd40 {"body":{"key":{"fingerprint":"a545685b3de6c8f7b25f3407fbfada49ae915d86","key_id":"FBFADA49AE915D86"},"legacy_uid_root":"d3450288d233fe9125d0b6f8196dbc93447bca2630300898781a637a44752032","prev":"953a3476896ed36f8d15b6f4f41f07916a118796b6b8dbfbe4e41ac93fd0b0e6c36ee56d05b405d30bfb295c073736a8d2b4de7389fd38507767e53029b84200","root":"337ce86d9d9d6ed87063f33478db51bdc704c6d0f2c0093aeda92ae8526aaabbce448e8e5d4d0cec0fb5e7c4d71cab3379bfc3c2a701f47fa9f4601ff1125188","seqno":292602,"txid":"16136c0a289dacf35e990d6f75059415","type":"merkle_root","version":1},"ctime":1448374075,"tag":"signature"} 0xc82031bf80 [51 124 232 109 157 157 110 216 112 99 243 52 120 219 81 189 199 4 198 208 242 192 9 58 237 169 42 232 82 106 170 187 206 68 142 142 93 77 12 236 15 181 231 196 215 28 171 51 121 191 195 194 167 1 244 127 169 244 96 31 241 18 81 136] [211 69 2 136 210 51 254 145 37 208 182 248 25 109 188 147 68 123 202 38 48 48 8 152 120 26 99 122 68 117 32 50] 1448374075}
14:49:43.064596 ▶ [DEBU keybase log.go:30] 14b + GetLastKnownSeqno()
14:49:43.064756 ▶ [DEBU keybase log.go:30] 14c + GetLastLoadedSeqno()
14:49:43.064918 ▶ [DEBU keybase log.go:30] 14d | Fetched from main chain
14:49:43.065066 ▶ [DEBU keybase log.go:30] 14e - GetLastLoadedSeqno() -> 22
14:49:43.065228 ▶ [DEBU keybase log.go:30] 14f - GetLastKnownSeqno() -> 22
14:49:43.065421 ▶ [DEBU keybase log.go:30] 150 + MerkleClient.LoadRoot()
14:49:43.065591 ▶ [DEBU keybase log.go:30] 151 + LevelDb.open
14:49:43.065737 ▶ [DEBU keybase log.go:30] 152 - LevelDb.open -> ok
14:49:43.065899 ▶ [DEBU keybase log.go:30] 153 + LevelDb.open
14:49:43.066046 ▶ [DEBU keybase log.go:30] 154 - LevelDb.open -> ok
14:49:43.066341 ▶ [DEBU keybase log.go:30] 155 - MerkleClient.LoadRoot() -> &{{0xc820124420} 292602 [165 69 104 91 61 230 200 247 178 95 52 7 251 250 218 73 174 145 93 134] 0xc82055ec90 {"body":{"key":{"fingerprint":"a545685b3de6c8f7b25f3407fbfada49ae915d86","key_id":"FBFADA49AE915D86"},"legacy_uid_root":"d3450288d233fe9125d0b6f8196dbc93447bca2630300898781a637a44752032","prev":"953a3476896ed36f8d15b6f4f41f07916a118796b6b8dbfbe4e41ac93fd0b0e6c36ee56d05b405d30bfb295c073736a8d2b4de7389fd38507767e53029b84200","root":"337ce86d9d9d6ed87063f33478db51bdc704c6d0f2c0093aeda92ae8526aaabbce448e8e5d4d0cec0fb5e7c4d71cab3379bfc3c2a701f47fa9f4601ff1125188","seqno":292602,"txid":"16136c0a289dacf35e990d6f75059415","type":"merkle_root","version":1},"ctime":1448374075,"tag":"signature"} 0xc82055efc0 [51 124 232 109 157 157 110 216 112 99 243 52 120 219 81 189 199 4 198 208 242 192 9 58 237 169 42 232 82 106 170 187 206 68 142 142 93 77 12 236 15 181 231 196 215 28 171 51 121 191 195 194 167 1 244 127 169 244 96 31 241 18 81 136] [211 69 2 136 210 51 254 145 37 208 182 248 25 109 188 147 68 123 202 38 48 48 8 152 120 26 99 122 68 117 32 50] 1448374075}
14:49:43.066610 ▶ [DEBU keybase log.go:30] 156 GPGKey Signing {"body":{"device":{"id":"5487213c241e840e74f24643864a2f18","kid":"01205dce83f14708c22231ded24141ea15af4689fa45cc416f5e95da6021c4b927570a","name":"eddie","status":1,"type":"desktop"},"key":{"eldest_kid":"01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a","host":"keybase.io","kid":"01013df9411e871a4462f4240ea4edb86b1bf56e01e799a98bf3314a5f95ebbf9afc0a","uid":"fb53422d3236dfd34bd73c7c9963c200","username":"kramimus"},"sibkey":{"kid":"01205dce83f14708c22231ded24141ea15af4689fa45cc416f5e95da6021c4b927570a","reverse_sig":"g6Rib2R5hqhkZXRhY2hlZMOpaGFzaF90eXBlCqNrZXnEIwEgXc6D8UcIwiIx3tJBQeoVr0aJ+kXMQW9eldpgIcS5J1cKp3BheWxvYWTFA8d7ImJvZHkiOnsiZGV2aWNlIjp7ImlkIjoiNTQ4NzIxM2MyNDFlODQwZTc0ZjI0NjQzODY0YTJmMTgiLCJraWQiOiIwMTIwNWRjZTgzZjE0NzA4YzIyMjMxZGVkMjQxNDFlYTE1YWY0Njg5ZmE0NWNjNDE2ZjVlOTVkYTYwMjFjNGI5Mjc1NzBhIiwibmFtZSI6ImVkZGllIiwic3RhdHVzIjoxLCJ0eXBlIjoiZGVza3RvcCJ9LCJrZXkiOnsiZWxkZXN0X2tpZCI6IjAxMDEzZGY5NDExZTg3MWE0NDYyZjQyNDBlYTRlZGI4NmIxYmY1NmUwMWU3OTlhOThiZjMzMTRhNWY5NWViYmY5YWZjMGEiLCJob3N0Ijoia2V5YmFzZS5pbyIsImtpZCI6IjAxMDEzZGY5NDExZTg3MWE0NDYyZjQyNDBlYTRlZGI4NmIxYmY1NmUwMWU3OTlhOThiZjMzMTRhNWY5NWViYmY5YWZjMGEiLCJ1aWQiOiJmYjUzNDIyZDMyMzZkZmQzNGJkNzNjN2M5OTYzYzIwMCIsInVzZXJuYW1lIjoia3JhbWltdXMifSwic2lia2V5Ijp7ImtpZCI6IjAxMjA1ZGNlODNmMTQ3MDhjMjIyMzFkZWQyNDE0MWVhMTVhZjQ2ODlmYTQ1Y2M0MTZmNWU5NWRhNjAyMWM0YjkyNzU3MGEiLCJyZXZlcnNlX3NpZyI6bnVsbH0sInR5cGUiOiJzaWJrZXkiLCJ2ZXJzaW9uIjoxfSwiY2xpZW50Ijp7Im5hbWUiOiJrZXliYXNlLmlvIGdvIGNsaWVudCIsInZlcnNpb24iOiIxLjAuMSJ9LCJjdGltZSI6MTQ0ODQwNTM4MywiZXhwaXJlX2luIjo1MDQ1NzYwMDAsIm1lcmtsZV9yb290Ijp7ImN0aW1lIjoxNDQ4Mzc0MDc1LCJoYXNoIjoiMzM3Y2U4NmQ5ZDlkNmVkODcwNjNmMzM0NzhkYjUxYmRjNzA0YzZkMGYyYzAwOTNhZWRhOTJhZTg1MjZhYWFiYmNlNDQ4ZThlNWQ0ZDBjZWMwZmI1ZTdjNGQ3MWNhYjMzNzliZmMzYzJhNzAxZjQ3ZmE5ZjQ2MDFmZjExMjUxODgiLCJzZXFubyI6MjkyNjAyfSwicHJldiI6ImI1ZDU5MWVmNTdlZjY3OTk5NDI3YTRhZjY5MDA4YThiOTAwZjU2ODMzODUxZDQwZTZmYzE3NmQyNjg3ODVjYjgiLCJzZXFubyI6MjMsInRhZyI6InNpZ25hdHVyZSJ9o3NpZ8RADo/E8exwQCZuM3q+SoUs7l9W/QlzyaBc35zQXTjUNgL9oZaSbNhgDn5zP399de+U9bhu7Ip9N1c1pTelVG9tAahzaWdfdHlwZSCjdGFnzQICp3ZlcnNpb24B"},"type":"sibkey","version":1},"client":{"name":"keybase.io go client","version":"1.0.1"},"ctime":1448405383,"expire_in":504576000,"merkle_root":{"ctime":1448374075,"hash":"337ce86d9d9d6ed87063f33478db51bdc704c6d0f2c0093aeda92ae8526aaabbce448e8e5d4d0cec0fb5e7c4d71cab3379bfc3c2a701f47fa9f4601ff1125188","seqno":292602},"prev":"b5d591ef57ef67999427a4af69008a8b900f56833851d40e6fc176d268785cb8","seqno":23,"tag":"signature"}
14:49:43.068817 ▶ [DEBU keybase log.go:30] 157 GPG version:
gpg (GnuPG) 2.0.28
libgcrypt 1.6.3
Copyright (C) 2015 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.

Home: ~/.gnupg
Supported algorithms:
Pubkey: RSA, RSA, RSA, ELG, DSA
Cipher: IDEA, 3DES, CAST5, BLOWFISH, AES, AES192, AES256, TWOFISH,
        CAMELLIA128, CAMELLIA192, CAMELLIA256
Hash: MD5, SHA1, RIPEMD160, SHA256, SHA384, SHA512, SHA224
Compression: Uncompressed, ZIP, ZLIB, BZIP2
14:49:43.069090 ▶ [DEBU keybase log.go:30] 158 | running Gpg: /usr/bin/gpg2 [--armor --sign -u 103ce381391cc7be7f9c9962ef6ed8e7c37b3370]
14:49:43.071851 ▶ [INFO keybase log.go:32] 159 gpg: cannot open `/dev/tty': No such device or address
14:49:43.072129 ▶ [DEBU keybase log.go:30] 15a | Failure in SignJson()
14:49:43.072336 ▶ [DEBU keybase log.go:30] 15b - Delegator.Run() -> ERROR: GPG error: exit status 2
14:49:43.072592 ▶ [DEBU keybase log.go:30] 15c - RunEngine(DeviceWrap) -> ERROR: GPG error: exit status 2
14:49:43.072770 ▶ [DEBU keybase log.go:30] 15d - Login "loginWithPromptHelper"
14:49:43.072935 ▶ [DEBU keybase log.go:30] 15e - LoginWithPrompt -> ERROR: GPG error: exit status 2
14:49:43.073102 ▶ [DEBU keybase log.go:30] 15f an error occurred during provisioning, logging out
14:49:43.073261 ▶ [DEBU keybase log.go:30] 160 + Login "logout"
14:49:43.073412 ▶ [DEBU keybase log.go:30] 161 + Loading session
14:49:43.073559 ▶ [DEBU keybase log.go:30] 162 - Skipped; already loaded
14:49:43.073706 ▶ [DEBU keybase log.go:30] 163 + API Post request to https://stage0.keybase.io/_/api/1.0/logout.json
14:49:43.186518 ▶ [DEBU keybase log.go:30] 164 | Result is: 200 OK
14:49:43.186817 ▶ [DEBU keybase log.go:30] 165 - successful API call
14:49:43.186984 ▶ [DEBU keybase log.go:30] 166 + invalidating session
14:49:43.187127 ▶ [DEBU keybase log.go:30] 167 + Sending logout notfication
14:49:43.187269 ▶ [DEBU keybase log.go:30] 168 - Logout notification sent
14:49:43.187430 ▶ [DEBU keybase log.go:30] 169 - session invalidated
14:49:43.187569 ▶ [DEBU keybase log.go:30] 16a + nuke file /home/mark/.cache/keybase.staging/session.json
14:49:43.187777 ▶ [DEBU keybase log.go:30] 16b - nuke file /home/mark/.cache/keybase.staging/session.json -> ok
14:49:43.187934 ▶ [DEBU keybase log.go:30] 16c clearing cached secret keys
14:49:43.188108 ▶ [DEBU keybase log.go:30] 16d - Login "logout"
14:49:43.188310 ▶ [DEBU keybase log.go:30] 16e + Account "LoginState - Shutdown"
14:49:43.188496 ▶ [DEBU keybase log.go:30] 16f - Account "LoginState - Shutdown"
14:49:43.188661 ▶ [DEBU keybase log.go:30] 170 - RunEngine(LoginProvision) -> ERROR: GPG error: exit status 2
14:49:43.188822 ▶ [DEBU keybase log.go:30] 171 - RunEngine(Login) -> ERROR: GPG error: exit status 2
14:49:43.188982 ▶ [WARN keybase log.go:34] 172 not exportable error: GPG error: exit status 2 (libkb.GpgError)
14:49:43.189147 ▶ [DEBU keybase globals.go:235] 173 Calling shutdown first time through
14:49:43.189174 ▶ [DEBU keybase login_state.go:873] 174 + Account "LoginState - Shutdown"
14:49:43.189202 ▶ [DEBU keybase login_state.go:875] 175 - Account "LoginState - Shutdown"
14:49:43.189223 ▶ [DEBU keybase globals.go:275] 176 exiting shutdown code=0; err=<nil>
14:49:43.189242 ▶ [ERRO keybase main.go:47] 177 GPG error: exit status 2

Which is an odd error...

$ ls -l /dev/tty
crw-rw-rw- 1 root tty 5, 0 Nov 24 14:49 /dev/tty

Maybe something to do with GTK pinentry?

maxtaco commented 8 years ago

Yeah, it's because the service is trying to access that tty. @patrickxb we need to tell GPG which tty we're on. We have to read that from the client process and then set that variable we pass into gpg.

nperkins84 commented 8 years ago

Just wanted to add my S2K information as i'm receiving the same error when I try keybase pgp select.

gpg --export-secret-key xxxxx8c1f7400 | gpg --list-packets | grep -i s2k iter+salt S2K, algo: 3, SHA1 protection, hash: 2, salt: [redacted just because] gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2 gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2 gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2

I can't seem to get back to keybase login to select option 4 as requested to the others above to try that method. It defaults to passphrase. I'm on Mac OS X El Capitain with keybase 1.0.3-0 and gpnupg 2.0.28, libgcrypt 1.6.3.

mszabo commented 8 years ago

I have an OpenPGP card with subkeys, and when I try to run keybase pgp select I also get the S2K error: 20:29:38.343628 ▶ [ERRO keybase main.go:47] 0be ImportKey error: openpgp: unsupported feature: hash for S2K function: 0

For me grepping for S2K outputs this: gnu-dummy S2K, algo: 0, simple checksum, hash: 0 gnu-divert-to-card S2K, algo: 0, simple checksum, hash: 0 gnu-divert-to-card S2K, algo: 0, simple checksum, hash: 0 gnu-divert-to-card S2K, algo: 0, simple checksum, hash: 0 gnu-dummy S2K, algo: 0, simple checksum, hash: 0

maxtaco commented 8 years ago

Which version of keybase?

mszabo commented 8 years ago

I'm on OS X, installed it with brew install --HEAD keybase

$ keybase version Client: 1.0.5-6 Service: 1.0.5-6

maxtaco commented 8 years ago

Yeah, thanks so much for this bug report. We might be SOL with regard to Yubikey and smart cards. I think the whole point of those devices is not to allow the key off the card. We need to be proxying crypto commands to the card/key via GPG. We're going to work on that, it's not ready yet. Thanks @mszabo

Lexicality commented 8 years ago

@maxtaco Are you sure it's the yubikey's fault? I'm getting the same error with gpg --export-secret-key x | keybase pgp import which unless I'm misunderstanding what --export-secret-key does would mean it is leaving the card.

maxtaco commented 8 years ago

Which version are you running?

On Saturday, January 9, 2016, Lex Robinson notifications@github.com wrote:

@maxtaco https://github.com/maxtaco Are you sure it's the yubikey's fault? I'm getting the same error with gpg --export-secret-key x | keybase pgp import which unless I'm misunderstanding what --export-secret-key does would mean it is leaving the card.

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-170260445 .

Lexicality commented 8 years ago 
Lex@GALLIONS-REACH C:\Users\Lex
> keybase version
Client:  1.0.7-0
Service: 1.0.7-0

Lex@GALLIONS-REACH C:\Users\Lex
> gpg --version
gpg (GnuPG) 2.0.29 (Gpg4win 2.3.0)
libgcrypt 1.6.4
Copyright (C) 2015 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.

Home: C:/Users/Lex/AppData/Roaming/gnupg
Supported algorithms:
Pubkey: RSA, RSA, RSA, ELG, DSA
Cipher: IDEA, 3DES, CAST5, BLOWFISH, AES, AES192, AES256, TWOFISH,
        CAMELLIA128, CAMELLIA192, CAMELLIA256
Hash: MD5, SHA1, RIPEMD160, SHA256, SHA384, SHA512, SHA224
Compression: Uncompressed, ZIP, ZLIB, BZIP2

(EDIT)

If it helps, Yubikey Firmware 3.4.6, OpenPGP Applet version 1.0.11

maxtaco commented 8 years ago

Right. Well I haven't started playing around with the yubikey yet but that feature could be getting stubbed out. And/or it is exporting some of the secret key material, but in a format (S2K) that Go's Openpgp library doesn't understand.

On Saturday, January 9, 2016, Lex Robinson notifications@github.com wrote:

Lex@GALLIONS-REACH C:\Users\Lex

keybase version Client: 1.0.7-0 Service: 1.0.7-0

Lex@GALLIONS-REACH C:\Users\Lex

gpg --version gpg (GnuPG) 2.0.29 (Gpg4win 2.3.0) libgcrypt 1.6.4 Copyright (C) 2015 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later http://gnu.org/licenses/gpl.html This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law.

Home: C:/Users/Lex/AppData/Roaming/gnupg Supported algorithms: Pubkey: RSA, RSA, RSA, ELG, DSA Cipher: IDEA, 3DES, CAST5, BLOWFISH, AES, AES192, AES256, TWOFISH, CAMELLIA128, CAMELLIA192, CAMELLIA256 Hash: MD5, SHA1, RIPEMD160, SHA256, SHA384, SHA512, SHA224 Compression: Uncompressed, ZIP, ZLIB, BZIP2

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-170260548 .

maxtaco commented 8 years ago

And btw what is your exact error message?

On Saturday, January 9, 2016, Maxwell Krohn themax@gmail.com wrote:

Right. Well I haven't started playing around with the yubikey yet but that feature could be getting stubbed out. And/or it is exporting some of the secret key material, but in a format (S2K) that Go's Openpgp library doesn't understand.

On Saturday, January 9, 2016, Lex Robinson <notifications@github.com javascript:_e(%7B%7D,'cvml','notifications@github.com');> wrote:

Lex@GALLIONS-REACH C:\Users\Lex

keybase version Client: 1.0.7-0 Service: 1.0.7-0

Lex@GALLIONS-REACH C:\Users\Lex

gpg --version gpg (GnuPG) 2.0.29 (Gpg4win 2.3.0) libgcrypt 1.6.4 Copyright (C) 2015 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later http://gnu.org/licenses/gpl.html This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law.

Home: C:/Users/Lex/AppData/Roaming/gnupg Supported algorithms: Pubkey: RSA, RSA, RSA, ELG, DSA Cipher: IDEA, 3DES, CAST5, BLOWFISH, AES, AES192, AES256, TWOFISH, CAMELLIA128, CAMELLIA192, CAMELLIA256 Hash: MD5, SHA1, RIPEMD160, SHA256, SHA384, SHA512, SHA224 Compression: Uncompressed, ZIP, ZLIB, BZIP2

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-170260548 .

Lexicality commented 8 years ago 
Lex@GALLIONS-REACH C:\Users\Lex                                                               
> gpg --export-secret-key 8C6AE547 | keybase -d pgp import                                    
17:15:36.901961 - [DEBU keybase json.go:48] 001 + loading config file: C:\Users\Lex\AppData\Ro
aming\Keybase\config.json                                                                     
17:15:36.903979 - [DEBU keybase json.go:76] 002 - successfully loaded config file             
17:15:36.904967 - [DEBU keybase config.go:115] 003 Config: mapping server ->                  
17:15:36.905467 - [DEBU keybase config.go:115] 004 Config: mapping socket_file ->             
17:15:36.905967 - [DEBU keybase config.go:115] 005 Config: mapping home ->                    
17:15:36.906467 - [DEBU keybase ui.go:435] 006 Can't set GPG_TTY; discover failed             
17:15:36.906467 - [DEBU keybase config.go:115] 007 Config: mapping timers ->                  
17:15:36.906965 - [DEBU keybase globals.go:193] 008 Keybase CLI 1.0.7-0                       
17:15:36.907490 - [DEBU keybase globals.go:193] 009 - Built with go1.5.1                      
17:15:36.907978 - [DEBU keybase globals.go:193] 00a - Visit https://keybase.io for more detail
s                                                                                             
17:15:36.908467 - [DEBU keybase main.go:101] 00b + configureProcesses                         
17:15:36.908467 - [DEBU keybase fork_server.go:47] 00c Getting flock                          
17:15:36.908966 - [DEBU keybase config.go:115] 00d Config: mapping home ->                    
17:15:36.909466 - [DEBU keybase config.go:115] 00e Config: mapping pid_file ->                
17:15:36.909466 - [DEBU keybase config.go:115] 00f Config: mapping home ->                    
17:15:36.909968 - [DEBU keybase fork_server.go:64] 010 The server is still up                 
17:15:36.910468 - [DEBU keybase main.go:158] 011 | After forks; newProc=false                 
17:15:36.910468 - [DEBU keybase main.go:179] 012 + configureLogging                           
17:15:36.910969 - [DEBU keybase config.go:115] 013 Config: mapping local_rpc_debug ->         
17:15:36.911472 - [DEBU keybase config.go:115] 014 Config: mapping local_rpc_debug ->         
17:15:36.911977 - [DEBU keybase main.go:215] 015 Setting remote log level: 1                  
17:15:36.912476 - [DEBU keybase main.go:181] 016 - configureLogging                           
17:15:36.912476 - [DEBU keybase versionfix.go:21] 017 + FixVersionClash                       
17:15:36.913479 - [DEBU keybase log.go:30] 018 Config: mapping server ->                      
17:15:36.913479 - [DEBU keybase log.go:30] 019 Config: mapping socket_file ->                 
17:15:36.913977 - [DEBU keybase log.go:30] 01a Config: mapping home ->                        
17:15:36.923485 - [DEBU keybase log.go:30] 01b | configured GPG w/ path: C:\Program Files (x86
)\GNU\GnuPG\pub\gpg2.exe                                                                      
17:15:36.930490 - [DEBU keybase versionfix.go:33] 01c | Contacted service; got version: 1.0.7-
0                                                                                             
17:15:36.931490 - [DEBU keybase versionfix.go:55] 020 | version check 1.0.7-0 v 1.0.7-0       
17:15:36.931490 - [DEBU keybase versionfix.go:57] 021 | versions check out                    
17:15:36.932659 - [DEBU keybase versionfix.go:23] 022 - FixVersionClash -> <nil>              
17:15:36.932659 - [DEBU keybase main.go:103] 023 - configureProcesses -> <nil>                
17:15:36.930990 - [DEBU keybase log.go:30] 01f Config: mapping home ->                        
17:15:36.930990 - [DEBU keybase log.go:30] 01d | configured GPG w/ path: C:\Program Files (x86
)\GNU\GnuPG\pub\gpg2.exe                                                                      
17:15:36.930990 - [DEBU keybase log.go:30] 01e Config: mapping config_file ->                 
17:15:36.934669 - [DEBU keybase globals.go:238] 024 Calling shutdown first time through       
17:15:36.935164 - [DEBU keybase login_state.go:887] 025 + Account "LoginState - Shutdown"     
17:15:36.935666 - [DEBU keybase login_state.go:889] 026 - Account "LoginState - Shutdown"     
17:15:36.935666 - [DEBU keybase globals.go:278] 027 exiting shutdown code=0; err=<nil>        
17:15:36.935666 - [ERRO keybase main.go:48] 028 openpgp: unsupported feature: hash for S2K fun
ction: 0
maxtaco commented 8 years ago

Thanks lex. We will have to boot up our yubikeys and figure out WTH they are outputting here.

On Saturday, January 9, 2016, Lex Robinson notifications@github.com wrote:

Lex@GALLIONS-REACH C:\Users\Lex

gpg --export-secret-key 8C6AE547 | keybase -d pgp import 17:15:36.901961 - [DEBU keybase json.go:48] 001 + loading config file: C:\Users\Lex\AppData\Ro aming\Keybase\config.json 17:15:36.903979 - [DEBU keybase json.go:76] 002 - successfully loaded config file 17:15:36.904967 - [DEBU keybase config.go:115] 003 Config: mapping server -> 17:15:36.905467 - [DEBU keybase config.go:115] 004 Config: mapping socket_file -> 17:15:36.905967 - [DEBU keybase config.go:115] 005 Config: mapping home -> 17:15:36.906467 - [DEBU keybase ui.go:435] 006 Can't set GPG_TTY; discover failed 17:15:36.906467 - [DEBU keybase config.go:115] 007 Config: mapping timers -> 17:15:36.906965 - [DEBU keybase globals.go:193] 008 Keybase CLI 1.0.7-0 17:15:36.907490 - [DEBU keybase globals.go:193] 009 - Built with go1.5.1 17:15:36.907978 - [DEBU keybase globals.go:193] 00a - Visit https://keybase.io for more detail s 17:15:36.908467 - [DEBU keybase main.go:101] 00b + configureProcesses 17:15:36.908467 - [DEBU keybase fork_server.go:47] 00c Getting flock 17:15:36.908966 - [DEBU keybase config.go:115] 00d Config: mapping home -> 17:15:36.909466 - [DEBU keybase config.go:115] 00e Config: mapping pid_file -> 17:15:36.909466 - [DEBU keybase config.go:115] 00f Config: mapping home -> 17:15:36.909968 - [DEBU keybase fork_server.go:64] 010 The server is still up 17:15:36.910468 - [DEBU keybase main.go:158] 011 | After forks; newProc=false 17:15:36.910468 - [DEBU keybase main.go:179] 012 + configureLogging 17:15:36.910969 - [DEBU keybase config.go:115] 013 Config: mapping local_rpc_debug -> 17:15:36.911472 - [DEBU keybase config.go:115] 014 Config: mapping local_rpc_debug -> 17:15:36.911977 - [DEBU keybase main.go:215] 015 Setting remote log level: 1 17:15:36.912476 - [DEBU keybase main.go:181] 016 - configureLogging 17:15:36.912476 - [DEBU keybase versionfix.go:21] 017 + FixVersionClash 17:15:36.913479 - [DEBU keybase log.go:30] 018 Config: mapping server -> 17:15:36.913479 - [DEBU keybase log.go:30] 019 Config: mapping socket_file -> 17:15:36.913977 - [DEBU keybase log.go:30] 01a Config: mapping home -> 17:15:36.923485 - [DEBU keybase log.go:30] 01b | configured GPG w/ path: C:\Program Files (x86 )\GNU\GnuPG\pub\gpg2.exe 17:15:36.930490 - [DEBU keybase versionfix.go:33] 01c | Contacted service; got version: 1.0.7- 0 17:15:36.931490 - [DEBU keybase versionfix.go:55] 020 | version check 1.0.7-0 v 1.0.7-0 17:15:36.931490 - [DEBU keybase versionfix.go:57] 021 | versions check out 17:15:36.932659 - [DEBU keybase versionfix.go:23] 022 - FixVersionClash -> 17:15:36.932659 - [DEBU keybase main.go:103] 023 - configureProcesses -> 17:15:36.930990 - [DEBU keybase log.go:30] 01f Config: mapping home -> 17:15:36.930990 - [DEBU keybase log.go:30] 01d | configured GPG w/ path: C:\Program Files (x86 )\GNU\GnuPG\pub\gpg2.exe 17:15:36.930990 - [DEBU keybase log.go:30] 01e Config: mapping config_file -> 17:15:36.934669 - [DEBU keybase globals.go:238] 024 Calling shutdown first time through 17:15:36.935164 - [DEBU keybase login_state.go:887] 025 + Account "LoginState - Shutdown" 17:15:36.935666 - [DEBU keybase login_state.go:889] 026 - Account "LoginState - Shutdown" 17:15:36.935666 - [DEBU keybase globals.go:278] 027 exiting shutdown code=0; err= 17:15:36.935666 - [ERRO keybase main.go:48] 028 openpgp: unsupported feature: hash for S2K fun ction: 0

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-170260843 .

Lexicality commented 8 years ago

Also I'm not sure what you mean by "stubbed out". Is that a positive (method stubs) or negative (extinguishing a cigarette) thing?

maxtaco commented 8 years ago

It means the GPG/yubikey might be exporting something here that isn't your full key or that might be a blank key.

On Saturday, January 9, 2016, Lex Robinson notifications@github.com wrote:

Also I'm not sure what you mean by "stubbed out". Is that a positive (method stubs) or negative (extinguishing a cigarette) thing?

— Reply to this email directly or view it on GitHub https://github.com/keybase/keybase-issues/issues/1822#issuecomment-170261055 .

sujal commented 8 years ago

Yubikeys definitely only output stubs of the key: http://security.stackexchange.com/a/108197 I can't find this in the docs, but this matches what I see coming out of mine.

kramimus commented 8 years ago

At some point along the way, this was fixed for me, pinentry support did the trick.

NeckBeardPrince commented 8 years ago

@kramimus Are you using pinentry for mac or in the shell? I am still having this issue.

kramimus commented 8 years ago

Neither. It is probably pinentry-gtk2 in ubuntu.

pkirkovsky commented 8 years ago

Seeing the same issue here. I use an offline main key along with separate encryption and signing subkeys (stored on a Yubikey Neo). I'd like to be able to use Keybase without having to load the main key onto my daily-use computer, which would defeat the entire purpose of this kind of setup.

$ keybase --version
keybase version 1.0.11-0

$ keybase pgp select 4328CFD67B46A8FB32270F4F0CE4A0B83F3FC81F
#    Algo    Key Id             Created   UserId
=    ====    ======             =======   ======
1    4096R   0CE4A0B83F3FC81F             Pavel Kirkovsky <pavel@kirkovsky.com>, Pavel Kirkovsky <pavel@kirkovsky.com>, Pavel Kirkovsky <pkirkovsky@keybase.io>
Choose a key: 1
▶ ERROR ImportKey error: openpgp: invalid data: subkey signature invalid: openpgp: unsupported feature: unknown S2K GNU protection mode: 2

$ gpg --export-secret-key 4328CFD67B46A8FB32270F4F0CE4A0B83F3FC81F | gpg --list-packets | grep S2K
    gnu-dummy S2K, algo: 3, SHA1 protection, hash: 2
    iter+salt S2K, algo: 3, SHA1 protection, hash: 2, salt: xxxxxxxxxxxxxxxx
    iter+salt S2K, algo: 3, SHA1 protection, hash: 2, salt: xxxxxxxxxxxxxxxx
    gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2
    gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2
    gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2
    gnu-divert-to-card S2K, algo: 3, SHA1 protection, hash: 2

I can wipe my Yubikey and use a new testing keypair if that would help @maxtaco