mDcBmFh2

12018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
22018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
32018/12/06 10:04:34 [INFO] encoded CSR
42018/12/06 10:04:34 [INFO] signed certificate with serial number 22026386950860715202348776049928893286576066981
52018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
62018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
72018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
82018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
92018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
102018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
112018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
122018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
132018/12/06 10:04:34 [INFO] encoded CSR
142018/12/06 10:04:34 [INFO] signed certificate with serial number 289980281046802822298195992894748530234267897673
152018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
162018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
172018/12/06 10:04:34 [INFO] The certificate is at: /tmp/ca-cert.pem
182018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /tmp/fabric-ca-server.db
192018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /tmp/IssuerPublicKey, secret key is at: /tmp/msp/keystore/IssuerSecretKey
202018/12/06 10:04:34 [INFO] The Idemix issuer revocation public and secret key files already exist
212018/12/06 10:04:34 [INFO]    private key file location: /tmp/msp/keystore/IssuerRevocationPrivateKey
222018/12/06 10:04:34 [INFO]    public key file location: /tmp/IssuerRevocationPublicKey
232018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
242018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
252018/12/06 10:04:34 [INFO] encoded CSR
262018/12/06 10:04:34 [INFO] signed certificate with serial number 298037691346284686416201830980129479769445356303
272018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
282018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
292018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
302018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
312018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
322018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
332018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
342018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
352018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
362018/12/06 10:04:34 [INFO] encoded CSR
372018/12/06 10:04:34 [INFO] signed certificate with serial number 274140886615820014413915943541868659747622094785
382018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
392018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
402018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
412018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
422018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
432018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
442018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
452018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
462018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
472018/12/06 10:04:34 [INFO] encoded CSR
482018/12/06 10:04:34 [INFO] signed certificate with serial number 250415697184507230960962320692148980432839687275
492018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
502018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
512018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
522018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
532018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
542018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
552018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
562018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
572018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
582018/12/06 10:04:34 [INFO] encoded CSR
592018/12/06 10:04:34 [INFO] signed certificate with serial number 221427264409369582445872314997993228560687476557
602018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
612018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
622018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
632018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
642018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
652018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
662018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
672018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
682018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
692018/12/06 10:04:34 [INFO] encoded CSR
702018/12/06 10:04:34 [INFO] signed certificate with serial number 175528327836830968920989417876127464441103620941
712018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
722018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
732018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
742018/12/06 10:04:34 [INFO] Successfully initialized LDAP client
752018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
762018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
772018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
782018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
792018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
802018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
812018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
822018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
832018/12/06 10:04:34 [INFO] encoded CSR
842018/12/06 10:04:34 [INFO] signed certificate with serial number 414650584270879844776931250568886008229164970459
852018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
862018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
872018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
882018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
892018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
902018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
912018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
922018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
932018/12/06 10:04:34 [INFO] encoded CSR
942018/12/06 10:04:34 [INFO] signed certificate with serial number 500070938753848920445451788511481828303980024248
952018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
962018/12/06 10:04:34 [INFO] encoded CSR
972018/12/06 10:04:34 [INFO] signed certificate with serial number 600382319092596851579540828553292008651403233665
982018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
992018/12/06 10:04:34 [INFO] encoded CSR
1002018/12/06 10:04:34 [INFO] signed certificate with serial number 42141831833297995629091056160941197151766833349
1012018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
1022018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
1032018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1042018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
1052018/12/06 10:04:34 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
1062018/12/06 10:04:34 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
1072018/12/06 10:04:34 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
1082018/12/06 10:04:34 [INFO] The CA key and certificate already exist
1092018/12/06 10:04:34 [INFO] The key is stored by BCCSP provider 'SW'
1102018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1112018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
1122018/12/06 10:04:34 [INFO] The Idemix issuer public and secret key files already exist
1132018/12/06 10:04:34 [INFO]    secret key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
1142018/12/06 10:04:34 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey
1152018/12/06 10:04:34 [INFO] The Idemix issuer revocation public and secret key files already exist
1162018/12/06 10:04:34 [INFO]    private key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
1172018/12/06 10:04:34 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey
1182018/12/06 10:04:34 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/TestCADBinit041588727/TestCADBinit041588727/ca-cert.pem does not exist}
1192018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
1202018/12/06 10:04:34 [INFO] encoded CSR
1212018/12/06 10:04:34 [INFO] signed certificate with serial number 136920627517788054550158775570491575582610414221
1222018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
1232018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
1242018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/TestCADBinit041588727/TestCADBinit041588727/ca-cert.pem
1252018/12/06 10:04:34 [ERROR] Error occurred initializing database: Failed to create user registry for SQLite: Failed to create SQLite3 database: Error creating users table: unable to open database file
1262018/12/06 10:04:34 [INFO] generating key: &{A:ecdsa S:256}
1272018/12/06 10:04:34 [INFO] encoded CSR
1282018/12/06 10:04:34 [INFO] signed certificate with serial number 576853474287874473450618285144841362057720151295
1292018/12/06 10:04:34 [INFO] The CA key and certificate were generated for CA
1302018/12/06 10:04:34 [INFO] The key was stored by BCCSP provider 'SW'
1312018/12/06 10:04:34 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1322018/12/06 10:04:34 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
1332018/12/06 10:04:35 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
1342018/12/06 10:04:35 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
1352018/12/06 10:04:35 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
1362018/12/06 10:04:35 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
1372018/12/06 10:04:35 [INFO] generating key: &{A:ecdsa S:256}
1382018/12/06 10:04:35 [INFO] encoded CSR
1392018/12/06 10:04:35 [INFO] signed certificate with serial number 55648527394426470357412827612705409897707246359
1402018/12/06 10:04:35 [INFO] The CA key and certificate were generated for CA
1412018/12/06 10:04:35 [INFO] The key was stored by BCCSP provider 'SW'
1422018/12/06 10:04:35 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1432018/12/06 10:04:35 [ERROR] Failed to load identity table: Code: 34 - Configuration Error: Max enrollment in registration request may not be less than -1, but was -10
1442018/12/06 10:04:35 [ERROR] Error occurred initializing database: Failed to load identity table: Code: 34 - Configuration Error: Max enrollment in registration request may not be less than -1, but was -10
1452018/12/06 10:04:35 [INFO] The CA key and certificate already exist
1462018/12/06 10:04:35 [INFO] The key is stored by BCCSP provider 'SW'
1472018/12/06 10:04:35 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1482018/12/06 10:04:35 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
1492018/12/06 10:04:35 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
1502018/12/06 10:04:35 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
1512018/12/06 10:04:35 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
1522018/12/06 10:04:35 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem does not exist}
1532018/12/06 10:04:35 [INFO] generating key: &{A:ecdsa S:256}
1542018/12/06 10:04:35 [INFO] encoded CSR
1552018/12/06 10:04:35 [INFO] signed certificate with serial number 522683778137968389021442728353221122086178522431
1562018/12/06 10:04:35 [INFO] The CA key and certificate were generated for CA
1572018/12/06 10:04:35 [INFO] The key was stored by BCCSP provider 'SW'
1582018/12/06 10:04:35 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/ca-cert.pem
1592018/12/06 10:04:35 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/fabric-ca-server.db
1602018/12/06 10:04:35 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerSecretKey
1612018/12/06 10:04:35 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
1622018/12/06 10:04:35 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/testdata/msp/keystore/IssuerRevocationPrivateKey
1632018/12/06 10:04:35 [INFO] Starting server in home directory: migrationTest
1642018/12/06 10:04:35 [INFO] Server Version: 1.1.0
1652018/12/06 10:04:35 [INFO] Server Levels: &{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}
1662018/12/06 10:04:35 [DEBUG] Making server filenames absolute
1672018/12/06 10:04:35 [DEBUG] Initializing default CA in directory /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest
1682018/12/06 10:04:35 [DEBUG] Init CA with home /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest and config {Version:1.1.0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile: Certfile: Chainfile:} Signing:0xc0003d6c20 CSR:{CN: Names:[] Hosts:[] KeyRequest:<nil> CA:<nil> SerialNumber:} Registry:{MaxEnrollments:-1 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }]} Affiliations:map[org1:<nil> org2dept1:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org2:[dept1]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type: Datasource: TLS:{false [] { }}  } CSP:<nil> Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile: IssuerSecretKeyfile: RevocationPublicKeyfile: RevocationPrivateKeyfile: RHPoolSize:0 NonceExpiration: NonceSweepInterval:}}
1692018/12/06 10:04:35 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest
1702018/12/06 10:04:35 [DEBUG] Checking configuration file version '1.1.0' against server version: '1.1.0'
1712018/12/06 10:04:35 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0002b7e30 PluginOpts:<nil>}
1722018/12/06 10:04:35 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003d76e0 DummyKeystore:<nil>}
1732018/12/06 10:04:35 [DEBUG] Initialize key material
1742018/12/06 10:04:35 [DEBUG] Making CA filenames absolute
1752018/12/06 10:04:35 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/ca-cert.pem does not exist}
1762018/12/06 10:04:35 [DEBUG] Root CA certificate request: {CN:fabric-ca-server Names:[] Hosts:[] KeyRequest:0xc0003d9660 CA:0xc0003d9540 SerialNumber:}
1772018/12/06 10:04:35 [INFO] generating key: &{A:ecdsa S:256}
1782018/12/06 10:04:35 [DEBUG] generate key from request: algo=ecdsa, size=256
1792018/12/06 10:04:35 [INFO] encoded CSR
1802018/12/06 10:04:35 [DEBUG] validating configuration
1812018/12/06 10:04:35 [DEBUG] validate local profile
1822018/12/06 10:04:35 [DEBUG] profile is valid
1832018/12/06 10:04:35 [INFO] signed certificate with serial number 288283841564610606784867982505917598103175374036
1842018/12/06 10:04:35 [INFO] The CA key and certificate were generated for CA
1852018/12/06 10:04:35 [INFO] The key was stored by BCCSP provider 'SW'
1862018/12/06 10:04:35 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/ca-cert.pem
1872018/12/06 10:04:35 [DEBUG] Initializing DB
1882018/12/06 10:04:35 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/fabric-ca-server.db'
1892018/12/06 10:04:35 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/fabric-ca-server.db) directory
1902018/12/06 10:04:35 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/fabric-ca-server.db) if it does not exist...
1912018/12/06 10:04:35 [DEBUG] Creating users table if it does not exist
1922018/12/06 10:04:35 [DEBUG] Creating affiliations table if it does not exist
1932018/12/06 10:04:35 [DEBUG] Creating certificates table if it does not exist
1942018/12/06 10:04:35 [DEBUG] Creating credentials table if it does not exist
1952018/12/06 10:04:35 [DEBUG] Creating revocation_authority_info table if it does not exist
1962018/12/06 10:04:35 [DEBUG] Creating nonces table if it does not exist
1972018/12/06 10:04:35 [DEBUG] Creating properties table if it does not exist
1982018/12/06 10:04:35 [DEBUG] Successfully opened sqlite3 DB
1992018/12/06 10:04:35 [DEBUG] Initializing identity registry
2002018/12/06 10:04:35 [DEBUG] Initialized DB identity registry
2012018/12/06 10:04:35 [DEBUG] Checking database levels '&{Identity:0 Affiliation:0 Certificate:0 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
2022018/12/06 10:04:35 [DEBUG] Getting current levels to check if any tables need to be migrated
2032018/12/06 10:04:35 [DEBUG] Migrating users table...
2042018/12/06 10:04:35 [DEBUG] Upgrade identity table to level 1
2052018/12/06 10:04:35 [DEBUG] Creating users table if it does not exist
2062018/12/06 10:04:35 [DEBUG] Upgrade identity table to level 2
2072018/12/06 10:04:35 [DEBUG] Creating users table if it does not exist
2082018/12/06 10:04:35 [DEBUG] Checking and performing migration of user table data, if needed
2092018/12/06 10:04:35 [DEBUG] Migrating user 'registrar' to level 1
2102018/12/06 10:04:35 [DEBUG] Modify Attributes: [{Name:hf.Registrar.Attributes Value:* ECert:false}]
2112018/12/06 10:04:35 [DEBUG] Attribute request: {Name:hf.Registrar.Attributes Value:* ECert:false}
2122018/12/06 10:04:35 [DEBUG] Adding '{Name:hf.Registrar.Attributes Value:* ECert:false}' as new attribute
2132018/12/06 10:04:35 [DEBUG] Migrating user 'notregistrar' to level 1
2142018/12/06 10:04:35 [DEBUG] Migrating affiliation table...
2152018/12/06 10:04:35 [DEBUG] Upgrade affiliations table to level 1
2162018/12/06 10:04:35 [DEBUG] Creating affiliations table if it does not exist
2172018/12/06 10:04:35 [DEBUG] Upgrade certificates table...
2182018/12/06 10:04:35 [DEBUG] Upgrade certificates table to level 1
2192018/12/06 10:04:35 [DEBUG] Creating certificates table if it does not exist
2202018/12/06 10:04:35 [DEBUG] Loading identity table
2212018/12/06 10:04:35 [DEBUG] Loading identity 'admin'
2222018/12/06 10:04:35 [DEBUG] DB: Getting identity admin
2232018/12/06 10:04:35 [DEBUG] Max enrollment value verification - User specified max enrollment: 0, CA max enrollment: -1
2242018/12/06 10:04:35 [DEBUG] DB: Add identity admin
2252018/12/06 10:04:35 [DEBUG] Successfully added identity admin to the database
2262018/12/06 10:04:35 [DEBUG] Registered identity: { Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:-1 Attrs:map[hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:*]  }
2272018/12/06 10:04:35 [DEBUG] Successfully loaded identity table
2282018/12/06 10:04:35 [DEBUG] Loading affiliations table
2292018/12/06 10:04:35 [DEBUG] DB: Add affiliation org1
2302018/12/06 10:04:35 [DEBUG] Affiliation 'org1' added
2312018/12/06 10:04:35 [DEBUG] DB: Add affiliation org2dept1
2322018/12/06 10:04:35 [DEBUG] Affiliation 'org2dept1' added
2332018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger
2342018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger' added
2352018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.fabric-ca
2362018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.fabric-ca' added
2372018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.sdk
2382018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.sdk' added
2392018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.fabric
2402018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.fabric' added
2412018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.fabric.ledger
2422018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.fabric.ledger' added
2432018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.fabric.orderer
2442018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.fabric.orderer' added
2452018/12/06 10:04:35 [DEBUG] DB: Add affiliation hyperledger.fabric.security
2462018/12/06 10:04:35 [DEBUG] Affiliation 'hyperledger.fabric.security' added
2472018/12/06 10:04:35 [DEBUG] DB: Add affiliation org2
2482018/12/06 10:04:35 [DEBUG] Affiliation 'org2' added
2492018/12/06 10:04:35 [DEBUG] DB: Add affiliation org2.dept1
2502018/12/06 10:04:35 [DEBUG] Affiliation 'org2.dept1' added
2512018/12/06 10:04:35 [DEBUG] Successfully loaded affiliations table
2522018/12/06 10:04:35 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/fabric-ca-server.db
2532018/12/06 10:04:35 [DEBUG] Initializing enrollment signer
2542018/12/06 10:04:35 [DEBUG] validating configuration
2552018/12/06 10:04:35 [DEBUG] validate local profile
2562018/12/06 10:04:35 [DEBUG] profile is valid
2572018/12/06 10:04:35 [DEBUG] validate local profile
2582018/12/06 10:04:35 [DEBUG] profile is valid
2592018/12/06 10:04:35 [DEBUG] validate local profile
2602018/12/06 10:04:35 [DEBUG] profile is valid
2612018/12/06 10:04:35 [DEBUG] CA initialization successful
2622018/12/06 10:04:35 [DEBUG] Initializing Idemix issuer...
2632018/12/06 10:04:35 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/msp/keystore/IssuerSecretKey
2642018/12/06 10:04:35 [DEBUG] Intializing revocation authority for issuer ''
2652018/12/06 10:04:35 [DEBUG] Initialize Idemix issuer revocation key material
2662018/12/06 10:04:35 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
2672018/12/06 10:04:35 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest/msp/keystore/IssuerRevocationPrivateKey
2682018/12/06 10:04:35 [DEBUG] Intializing nonce manager for issuer ''
2692018/12/06 10:04:35 [INFO] Home directory for default CA: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/migrationTest
2702018/12/06 10:04:35 [DEBUG] 1 CA instance(s) running on server
2712018/12/06 10:04:35 [INFO] Listening on http://0.0.0.0:7075
2722018/12/06 10:04:35 [DEBUG] DB: Getting identity registrar
2732018/12/06 10:04:35 [DEBUG] DB: Getting identity notregistrar
2742018/12/06 10:04:35 [ERROR] Server has stopped serving: accept tcp [::]:7075: use of closed network connection
2752018/12/06 10:04:35 [DEBUG] Stop: successfully closed listener on port 7075
2762018/12/06 10:04:35 [DEBUG] Stop: waiting for listener on port 7075 to stop
2772018/12/06 10:04:35 [DEBUG] Stop: listener was already closed on port 7075
2782018/12/06 10:04:35 [DEBUG] Closing server DBs
2792018/12/06 10:04:36 [DEBUG] Stop: successful stop on port 7075
2802018/12/06 10:04:36 [DEBUG] Init CA with home getCertDBTest and config {Version: Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile: Certfile: Chainfile:} Signing:<nil> CSR:{CN: Names:[] Hosts:[] KeyRequest:<nil> CA:<nil> SerialNumber:} Registry:{MaxEnrollments:0 Identities:[]} Affiliations:map[] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type: Datasource: TLS:{false [] { }}  } CSP:<nil> Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile: IssuerSecretKeyfile: RevocationPublicKeyfile: RevocationPrivateKeyfile: RHPoolSize:0 NonceExpiration: NonceSweepInterval:}}
2812018/12/06 10:04:36 [DEBUG] CA Home Directory: getCertDBTest
2822018/12/06 10:04:36 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
2832018/12/06 10:04:36 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0003ba7b0 PluginOpts:<nil>}
2842018/12/06 10:04:36 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003736c0 DummyKeystore:<nil>}
2852018/12/06 10:04:36 [DEBUG] Initialize key material
2862018/12/06 10:04:36 [DEBUG] Making CA filenames absolute
2872018/12/06 10:04:36 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/ca-cert.pem does not exist}
2882018/12/06 10:04:36 [DEBUG] Root CA certificate request: {CN:fabric-ca-server Names:[] Hosts:[] KeyRequest:0xc000198980 CA:0xc0001987e0 SerialNumber:}
2892018/12/06 10:04:36 [INFO] generating key: &{A:ecdsa S:256}
2902018/12/06 10:04:36 [DEBUG] generate key from request: algo=ecdsa, size=256
2912018/12/06 10:04:36 [INFO] encoded CSR
2922018/12/06 10:04:36 [DEBUG] validating configuration
2932018/12/06 10:04:36 [DEBUG] validate local profile
2942018/12/06 10:04:36 [DEBUG] profile is valid
2952018/12/06 10:04:36 [INFO] signed certificate with serial number 282717721818657704425502149580736700213314845027
2962018/12/06 10:04:36 [INFO] The CA key and certificate were generated for CA
2972018/12/06 10:04:36 [INFO] The key was stored by BCCSP provider 'SW'
2982018/12/06 10:04:36 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/ca-cert.pem
2992018/12/06 10:04:36 [DEBUG] Initializing DB
3002018/12/06 10:04:36 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/fabric-ca-server.db'
3012018/12/06 10:04:36 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/fabric-ca-server.db) directory
3022018/12/06 10:04:36 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/fabric-ca-server.db) if it does not exist...
3032018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
3042018/12/06 10:04:36 [DEBUG] Creating affiliations table if it does not exist
3052018/12/06 10:04:36 [DEBUG] Creating certificates table if it does not exist
3062018/12/06 10:04:36 [DEBUG] Creating credentials table if it does not exist
3072018/12/06 10:04:36 [DEBUG] Creating revocation_authority_info table if it does not exist
3082018/12/06 10:04:36 [DEBUG] Creating nonces table if it does not exist
3092018/12/06 10:04:36 [DEBUG] Creating properties table if it does not exist
3102018/12/06 10:04:36 [DEBUG] Successfully opened sqlite3 DB
3112018/12/06 10:04:36 [DEBUG] Initializing identity registry
3122018/12/06 10:04:36 [DEBUG] Initialized DB identity registry
3132018/12/06 10:04:36 [DEBUG] Checking database levels '&{Identity:0 Affiliation:0 Certificate:0 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
3142018/12/06 10:04:36 [DEBUG] Getting current levels to check if any tables need to be migrated
3152018/12/06 10:04:36 [DEBUG] Migrating users table...
3162018/12/06 10:04:36 [DEBUG] Upgrade identity table to level 1
3172018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
3182018/12/06 10:04:36 [DEBUG] Upgrade identity table to level 2
3192018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
3202018/12/06 10:04:36 [DEBUG] Checking and performing migration of user table data, if needed
3212018/12/06 10:04:36 [DEBUG] Migrating affiliation table...
3222018/12/06 10:04:36 [DEBUG] Upgrade affiliations table to level 1
3232018/12/06 10:04:36 [DEBUG] Creating affiliations table if it does not exist
3242018/12/06 10:04:36 [DEBUG] Upgrade certificates table...
3252018/12/06 10:04:36 [DEBUG] Upgrade certificates table to level 1
3262018/12/06 10:04:36 [DEBUG] Creating certificates table if it does not exist
3272018/12/06 10:04:36 [DEBUG] Loading identity table
3282018/12/06 10:04:36 [DEBUG] Successfully loaded identity table
3292018/12/06 10:04:36 [DEBUG] Loading affiliations table
3302018/12/06 10:04:36 [DEBUG] Successfully loaded affiliations table
3312018/12/06 10:04:36 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/fabric-ca-server.db
3322018/12/06 10:04:36 [DEBUG] Initializing enrollment signer
3332018/12/06 10:04:36 [DEBUG] validating configuration
3342018/12/06 10:04:36 [DEBUG] validate local profile
3352018/12/06 10:04:36 [DEBUG] profile is valid
3362018/12/06 10:04:36 [DEBUG] validate local profile
3372018/12/06 10:04:36 [DEBUG] profile is valid
3382018/12/06 10:04:36 [DEBUG] validate local profile
3392018/12/06 10:04:36 [DEBUG] profile is valid
3402018/12/06 10:04:36 [DEBUG] CA initialization successful
3412018/12/06 10:04:36 [DEBUG] Initializing Idemix issuer...
3422018/12/06 10:04:36 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/msp/keystore/IssuerSecretKey
3432018/12/06 10:04:36 [DEBUG] Intializing revocation authority for issuer ''
3442018/12/06 10:04:36 [DEBUG] Initialize Idemix issuer revocation key material
3452018/12/06 10:04:36 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
3462018/12/06 10:04:36 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/getCertDBTest/msp/keystore/IssuerRevocationPrivateKey
3472018/12/06 10:04:36 [DEBUG] Intializing nonce manager for issuer ''
3482018/12/06 10:04:36 [DEBUG] DB: Add identity testCertificate1
3492018/12/06 10:04:36 [DEBUG] Successfully added identity testCertificate1 to the database
3502018/12/06 10:04:36 [DEBUG] DB: Add identity testCertificate2
3512018/12/06 10:04:36 [DEBUG] Successfully added identity testCertificate2 to the database
3522018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3532018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.id = ?);, with args: [testCertificate1]
3542018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3552018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.serial_number = ?);, with args: [1111]
3562018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3572018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.authority_key_identifier = ?);, with args: [9876]
3582018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3592018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.revoked_at = ?);, with args: [0001-01-01 00:00:00 +0000 UTC]
3602018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3612018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.expiry >= ?);, with args: [2018-12-06 10:04:36.88213455 +0000 UTC]
3622018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3632018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates INNER JOIN users ON users.id = certificates.id WHERE ((users.affiliation = ? OR users.affiliation LIKE ?) AND certificates.serial_number = ?);, with args: [dept1 dept1.% 1111]
3642018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3652018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.authority_key_identifier = ?);, with args: [9876ab]
3662018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3672018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.revoked_at >= ?);, with args: [2018-01-01 00:00:00 +0000 UTC]
3682018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3692018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.revoked_at > ? AND certificates.revoked_at <= ?);, with args: [0001-01-01 00:00:00 +0000 UTC 2018-03-01 00:00:00 +0000 UTC]
3702018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3712018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.revoked_at >= ? AND certificates.revoked_at <= ?);, with args: [2017-01-01 00:00:00 +0000 UTC 2017-08-01 00:00:00 +0000 UTC]
3722018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3732018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.expiry >= ?);, with args: [2018-03-02 00:00:00 +0000 UTC]
3742018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3752018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.expiry >= ? AND certificates.expiry <= ?);, with args: [0001-01-01 00:00:00 +0000 UTC 2018-12-10 14:04:36.884103759 +0000 UTC]
3762018/12/06 10:04:36 [DEBUG] DB: Get Certificates
3772018/12/06 10:04:36 [DEBUG] Executing get certificates query: SELECT certificates.pem FROM certificates WHERE (certificates.expiry >= ? AND certificates.expiry <= ?);, with args: [2017-01-01 00:00:00 +0000 UTC 2018-03-01 00:00:00 +0000 UTC]
3782018/12/06 10:04:36 [DEBUG] Register bootstrap user: name=admin, affiliation=
3792018/12/06 10:04:36 [DEBUG] Registered bootstrap identity: { Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }
3802018/12/06 10:04:36 [INFO] Starting server in home directory: testservers/c1
3812018/12/06 10:04:36 [DEBUG] Set log level:
3822018/12/06 10:04:36 [INFO] Server Version: 1.1.0
3832018/12/06 10:04:36 [INFO] Server Levels: &{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}
3842018/12/06 10:04:36 [DEBUG] Making server filenames absolute
3852018/12/06 10:04:36 [DEBUG] Initializing default CA in directory /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1
3862018/12/06 10:04:36 [DEBUG] Init CA with home /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1 and config {Version: Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile: Certfile: Chainfile:} Signing:<nil> CSR:{CN: Names:[] Hosts:[] KeyRequest:<nil> CA:<nil> SerialNumber:} Registry:{MaxEnrollments:1 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric:[ledger orderer security] fabric-ca:<nil> sdk:<nil>] org1:map[department2:<nil> department1:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type: Datasource: TLS:{false [] { }}  } CSP:<nil> Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile: IssuerSecretKeyfile: RevocationPublicKeyfile: RevocationPrivateKeyfile: RHPoolSize:0 NonceExpiration: NonceSweepInterval:}}
3872018/12/06 10:04:36 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1
3882018/12/06 10:04:36 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
3892018/12/06 10:04:36 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0000192c0 PluginOpts:<nil>}
3902018/12/06 10:04:36 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003d7850 DummyKeystore:<nil>}
3912018/12/06 10:04:36 [DEBUG] Initialize key material
3922018/12/06 10:04:36 [DEBUG] Making CA filenames absolute
3932018/12/06 10:04:36 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-cert.pem does not exist}
3942018/12/06 10:04:36 [DEBUG] Root CA certificate request: {CN:fabric-ca-server Names:[] Hosts:[] KeyRequest:0xc0004665a0 CA:0xc000466420 SerialNumber:}
3952018/12/06 10:04:36 [INFO] generating key: &{A:ecdsa S:256}
3962018/12/06 10:04:36 [DEBUG] generate key from request: algo=ecdsa, size=256
3972018/12/06 10:04:36 [INFO] encoded CSR
3982018/12/06 10:04:36 [DEBUG] validating configuration
3992018/12/06 10:04:36 [DEBUG] validate local profile
4002018/12/06 10:04:36 [DEBUG] profile is valid
4012018/12/06 10:04:36 [INFO] signed certificate with serial number 156214739287212446267540611522597442041147253981
4022018/12/06 10:04:36 [INFO] The CA key and certificate were generated for CA
4032018/12/06 10:04:36 [INFO] The key was stored by BCCSP provider 'SW'
4042018/12/06 10:04:36 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-cert.pem
4052018/12/06 10:04:36 [DEBUG] Initializing DB
4062018/12/06 10:04:36 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db'
4072018/12/06 10:04:36 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db) directory
4082018/12/06 10:04:36 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db) if it does not exist...
4092018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
4102018/12/06 10:04:36 [DEBUG] Creating affiliations table if it does not exist
4112018/12/06 10:04:36 [DEBUG] Creating certificates table if it does not exist
4122018/12/06 10:04:36 [DEBUG] Creating credentials table if it does not exist
4132018/12/06 10:04:36 [DEBUG] Creating revocation_authority_info table if it does not exist
4142018/12/06 10:04:36 [DEBUG] Creating nonces table if it does not exist
4152018/12/06 10:04:36 [DEBUG] Creating properties table if it does not exist
4162018/12/06 10:04:36 [DEBUG] Successfully opened sqlite3 DB
4172018/12/06 10:04:36 [DEBUG] Initializing identity registry
4182018/12/06 10:04:36 [DEBUG] Initialized DB identity registry
4192018/12/06 10:04:36 [DEBUG] Checking database levels '&{Identity:0 Affiliation:0 Certificate:0 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
4202018/12/06 10:04:36 [DEBUG] Getting current levels to check if any tables need to be migrated
4212018/12/06 10:04:36 [DEBUG] Migrating users table...
4222018/12/06 10:04:36 [DEBUG] Upgrade identity table to level 1
4232018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
4242018/12/06 10:04:36 [DEBUG] Upgrade identity table to level 2
4252018/12/06 10:04:36 [DEBUG] Creating users table if it does not exist
4262018/12/06 10:04:36 [DEBUG] Checking and performing migration of user table data, if needed
4272018/12/06 10:04:36 [DEBUG] Migrating affiliation table...
4282018/12/06 10:04:36 [DEBUG] Upgrade affiliations table to level 1
4292018/12/06 10:04:36 [DEBUG] Creating affiliations table if it does not exist
4302018/12/06 10:04:36 [DEBUG] Upgrade certificates table...
4312018/12/06 10:04:36 [DEBUG] Upgrade certificates table to level 1
4322018/12/06 10:04:36 [DEBUG] Creating certificates table if it does not exist
4332018/12/06 10:04:36 [DEBUG] Loading identity table
4342018/12/06 10:04:36 [DEBUG] Loading identity 'admin'
4352018/12/06 10:04:36 [DEBUG] DB: Getting identity admin
4362018/12/06 10:04:36 [DEBUG] Max enrollment value verification - User specified max enrollment: 0, CA max enrollment: 1
4372018/12/06 10:04:36 [DEBUG] DB: Add identity admin
4382018/12/06 10:04:36 [DEBUG] Successfully added identity admin to the database
4392018/12/06 10:04:36 [DEBUG] Registered identity: { Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:1 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }
4402018/12/06 10:04:36 [DEBUG] Successfully loaded identity table
4412018/12/06 10:04:36 [DEBUG] Loading affiliations table
4422018/12/06 10:04:36 [DEBUG] DB: Add affiliation org1
4432018/12/06 10:04:36 [DEBUG] Affiliation 'org1' added
4442018/12/06 10:04:36 [DEBUG] DB: Add affiliation org1.department1
4452018/12/06 10:04:36 [DEBUG] Affiliation 'org1.department1' added
4462018/12/06 10:04:36 [DEBUG] DB: Add affiliation org1.department2
4472018/12/06 10:04:36 [DEBUG] Affiliation 'org1.department2' added
4482018/12/06 10:04:36 [DEBUG] DB: Add affiliation org2
4492018/12/06 10:04:36 [DEBUG] Affiliation 'org2' added
4502018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger
4512018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger' added
4522018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.fabric-ca
4532018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.fabric-ca' added
4542018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.sdk
4552018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.sdk' added
4562018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.fabric
4572018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.fabric' added
4582018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.fabric.ledger
4592018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.fabric.ledger' added
4602018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.fabric.orderer
4612018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.fabric.orderer' added
4622018/12/06 10:04:36 [DEBUG] DB: Add affiliation hyperledger.fabric.security
4632018/12/06 10:04:36 [DEBUG] Affiliation 'hyperledger.fabric.security' added
4642018/12/06 10:04:36 [DEBUG] Successfully loaded affiliations table
4652018/12/06 10:04:36 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db
4662018/12/06 10:04:36 [DEBUG] Initializing enrollment signer
4672018/12/06 10:04:36 [DEBUG] validating configuration
4682018/12/06 10:04:36 [DEBUG] validate local profile
4692018/12/06 10:04:36 [DEBUG] profile is valid
4702018/12/06 10:04:36 [DEBUG] validate local profile
4712018/12/06 10:04:36 [DEBUG] profile is valid
4722018/12/06 10:04:36 [DEBUG] validate local profile
4732018/12/06 10:04:36 [DEBUG] profile is valid
4742018/12/06 10:04:36 [DEBUG] CA initialization successful
4752018/12/06 10:04:36 [DEBUG] Initializing Idemix issuer...
4762018/12/06 10:04:37 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerSecretKey
4772018/12/06 10:04:37 [DEBUG] Intializing revocation authority for issuer ''
4782018/12/06 10:04:37 [DEBUG] Initialize Idemix issuer revocation key material
4792018/12/06 10:04:37 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
4802018/12/06 10:04:37 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerRevocationPrivateKey
4812018/12/06 10:04:37 [DEBUG] Intializing nonce manager for issuer ''
4822018/12/06 10:04:37 [INFO] Home directory for default CA: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1
4832018/12/06 10:04:37 [DEBUG] 1 CA instance(s) running on server
4842018/12/06 10:04:37 [INFO] Listening on http://0.0.0.0:7058
4852018/12/06 10:04:37 [DEBUG] Initializing client with config: &{URL:http://localhost:7058 MSPDir: TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  } CSR:{CN: Names:[] Hosts:[]KeyRequest:<nil> CA:<nil> SerialNumber:} ID:{Name: Type: Secret: MaxEnrollments:0 Affiliation: Attributes:[] CAName:} Revoke:{Name: Serial: AKI: Reason: CAName: GenCRL:false} CAInfo:{CAName:} CAName: CSP:<nil> Debug:false LogLevel:}
4862018/12/06 10:04:37 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0003ba6f0 PluginOpts:<nil>}
4872018/12/06 10:04:37 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0004550a0 DummyKeystore:<nil>}
4882018/12/06 10:04:37 [DEBUG] GenCSR <nil>
4892018/12/06 10:04:37 [INFO] generating key: &{A:ecdsa S:256}
4902018/12/06 10:04:37 [DEBUG] generate key from request: algo=ecdsa, size=256
4912018/12/06 10:04:37 [INFO] encoded CSR
4922018/12/06 10:04:37 [DEBUG] Sending request
493POST http://localhost:7058/enroll
494{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
4952018/12/06 10:04:37 [DEBUG] Received request for /enroll
4962018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
4972018/12/06 10:04:37 [DEBUG] Received response
498statusCode=401 (401 Unauthorized)
4992018/12/06 10:04:37 [DEBUG] Sending request
500POST http://localhost:7058/enroll
501{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5022018/12/06 10:04:37 [DEBUG] Received request for /enroll
5032018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
5042018/12/06 10:04:37 [DEBUG] Received response
505statusCode=401 (401 Unauthorized)
5062018/12/06 10:04:37 [DEBUG] Sending request
507POST http://localhost:7058/enroll
508{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5092018/12/06 10:04:37 [DEBUG] Received request for /enroll
5102018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
5112018/12/06 10:04:37 [DEBUG] Received response
512statusCode=401 (401 Unauthorized)
5132018/12/06 10:04:37 [DEBUG] Sending request
514POST http://localhost:7058/enroll
515{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5162018/12/06 10:04:37 [DEBUG] Received request for /enroll
5172018/12/06 10:04:37 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-chain.pem} Signing:0xc0003d75b0 CSR:{CN:fabric-ca-server Names:[] Hosts:[] KeyRequest:0xc000466580 CA:0xc000466420 SerialNumber:} Registry:{MaxEnrollments:1 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:*]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc0004664a0 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
5182018/12/06 10:04:37 [DEBUG] DB: Getting identity admin
5192018/12/06 10:04:37 [DEBUG] DB: Login user admin with max enrollments of 1 and state of 0
5202018/12/06 10:04:37 [DEBUG] Incorrect password entered by user 'admin'
5212018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 24 "Login failure: Password mismatch: crypto/bcrypt: hashedPassword is not the hash of the given password"
5222018/12/06 10:04:37 [DEBUG] Received response
523statusCode=401 (401 Unauthorized)
5242018/12/06 10:04:37 [DEBUG] Sending request
525POST http://localhost:7058/enroll
526{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5272018/12/06 10:04:37 [DEBUG] Received request for /enroll
5282018/12/06 10:04:37 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/ca-chain.pem} Signing:0xc0003d75b0 CSR:{CN:fabric-ca-server Names:[] Hosts:[] KeyRequest:0xc000466580 CA:0xc000466420 SerialNumber:} Registry:{MaxEnrollments:1 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc0004664a0 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testservers/c1/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
5292018/12/06 10:04:37 [DEBUG] DB: Getting identity user
5302018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 23 "Failed to get user: : scode: 404, code: 63, msg: Failed to get User: sql: no rows in result set"
5312018/12/06 10:04:37 [DEBUG] Received response
532statusCode=401 (401 Unauthorized)
5332018/12/06 10:04:37 [DEBUG] Sending request
534POST http://localhost:7058/enroll
535{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5362018/12/06 10:04:37 [DEBUG] Received request for /enroll
5372018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
5382018/12/06 10:04:37 [DEBUG] Received response
539statusCode=401 (401 Unauthorized)
5402018/12/06 10:04:37 [DEBUG] Sending request
541POST http://localhost:7058/enroll
542{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5432018/12/06 10:04:37 [DEBUG] Received request for /enroll
5442018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
5452018/12/06 10:04:37 [DEBUG] Received response
546statusCode=401 (401 Unauthorized)
5472018/12/06 10:04:37 [DEBUG] Sending request
548POST http://localhost:7058/enroll
549{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5502018/12/06 10:04:37 [DEBUG] Received request for /enroll
5512018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 21 "No user/pass in authorization header"
5522018/12/06 10:04:37 [DEBUG] Received response
553statusCode=401 (401 Unauthorized)
5542018/12/06 10:04:37 [DEBUG] Sending request
555POST http://localhost:7058/enroll
556{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGoQwsCTfytzbN96o8r4PDmq5/3Lz7ztaEcRha3Q/tYFiZoS+LSzi9jgu\nhejxSlML1lC+TdfMwIHGY8oUDRdeLKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhALDig4eyKRricVb2lkii\nibyrjPCqYm5UULENdGyOVHdhAiA8VKu92pincJnkzdujx0K+kh+u3Nw1UDd6VbOv\npwtMmw==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z"}
5572018/12/06 10:04:37 [DEBUG] Received request for /enroll
5582018/12/06 10:04:37 [INFO] 127.0.0.1:52024 POST /enroll 401 2 "No authorization header"
5592018/12/06 10:04:37 [DEBUG] Received response
560statusCode=401 (401 Unauthorized)
5612018/12/06 10:04:37 [ERROR] Server has stopped serving: accept tcp [::]:7058: use of closed network connection
5622018/12/06 10:04:37 [DEBUG] Stop: successfully closed listener on port 7058
5632018/12/06 10:04:37 [DEBUG] Stop: waiting for listener on port 7058 to stop
5642018/12/06 10:04:37 [DEBUG] Stop: listener was already closed on port 7058
5652018/12/06 10:04:37 [DEBUG] Closing server DBs
5662018/12/06 10:04:38 [DEBUG] Stop: successful stop on port 7058
5672018/12/06 10:04:38 [DEBUG] Register bootstrap user: name=admin, affiliation=
5682018/12/06 10:04:38 [DEBUG] Registered bootstrap identity: { Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:truehf.GenCRL:true]  }
5692018/12/06 10:04:38 [INFO] Starting server in home directory: testTLSClientAuthDir/server
5702018/12/06 10:04:38 [DEBUG] Set log level:
5712018/12/06 10:04:38 [INFO] Server Version: 1.1.0
5722018/12/06 10:04:38 [INFO] Server Levels: &{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}
5732018/12/06 10:04:38 [DEBUG] Making server filenames absolute
5742018/12/06 10:04:38 [DEBUG] Initializing default CA in directory /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
5752018/12/06 10:04:38 [DEBUG] Init CA with home /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server and config {Version: Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile: Certfile: Chainfile:} Signing:<nil> CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:<nil> CA:<nil> SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:*]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:falseURL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type: Datasource: TLS:{false [] { }}  } CSP:<nil> Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile: IssuerSecretKeyfile: RevocationPublicKeyfile: RevocationPrivateKeyfile: RHPoolSize:0 NonceExpiration: NonceSweepInterval:}}
5762018/12/06 10:04:38 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
5772018/12/06 10:04:38 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
5782018/12/06 10:04:38 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0002962d0 PluginOpts:<nil>}
5792018/12/06 10:04:38 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003fff10 DummyKeystore:<nil>}
5802018/12/06 10:04:38 [DEBUG] Initialize key material
5812018/12/06 10:04:38 [DEBUG] Making CA filenames absolute
5822018/12/06 10:04:38 [WARNING] &{69 The specified CA certificate file /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem does not exist}
5832018/12/06 10:04:38 [DEBUG] Root CA certificate request: {CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db60 CA:0xc00027d9e0 SerialNumber:}
5842018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
5852018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
5862018/12/06 10:04:38 [INFO] encoded CSR
5872018/12/06 10:04:38 [DEBUG] validating configuration
5882018/12/06 10:04:38 [DEBUG] validate local profile
5892018/12/06 10:04:38 [DEBUG] profile is valid
5902018/12/06 10:04:38 [INFO] signed certificate with serial number 52705395098230412052368906941321014057523588036
5912018/12/06 10:04:38 [INFO] The CA key and certificate were generated for CA
5922018/12/06 10:04:38 [INFO] The key was stored by BCCSP provider 'SW'
5932018/12/06 10:04:38 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem
5942018/12/06 10:04:38 [DEBUG] Initializing DB
5952018/12/06 10:04:38 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db'
5962018/12/06 10:04:38 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) directory
5972018/12/06 10:04:38 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) if it does not exist...
5982018/12/06 10:04:38 [DEBUG] Creating users table if it does not exist
5992018/12/06 10:04:38 [DEBUG] Creating affiliations table if it does not exist
6002018/12/06 10:04:38 [DEBUG] Creating certificates table if it does not exist
6012018/12/06 10:04:38 [DEBUG] Creating credentials table if it does not exist
6022018/12/06 10:04:38 [DEBUG] Creating revocation_authority_info table if it does not exist
6032018/12/06 10:04:38 [DEBUG] Creating nonces table if it does not exist
6042018/12/06 10:04:38 [DEBUG] Creating properties table if it does not exist
6052018/12/06 10:04:38 [DEBUG] Successfully opened sqlite3 DB
6062018/12/06 10:04:38 [DEBUG] Initializing identity registry
6072018/12/06 10:04:38 [DEBUG] Initialized DB identity registry
6082018/12/06 10:04:38 [DEBUG] Checking database levels '&{Identity:0 Affiliation:0 Certificate:0 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
6092018/12/06 10:04:38 [DEBUG] Getting current levels to check if any tables need to be migrated
6102018/12/06 10:04:38 [DEBUG] Migrating users table...
6112018/12/06 10:04:38 [DEBUG] Upgrade identity table to level 1
6122018/12/06 10:04:38 [DEBUG] Creating users table if it does not exist
6132018/12/06 10:04:38 [DEBUG] Upgrade identity table to level 2
6142018/12/06 10:04:38 [DEBUG] Creating users table if it does not exist
6152018/12/06 10:04:38 [DEBUG] Checking and performing migration of user table data, if needed
6162018/12/06 10:04:38 [DEBUG] Migrating affiliation table...
6172018/12/06 10:04:38 [DEBUG] Upgrade affiliations table to level 1
6182018/12/06 10:04:38 [DEBUG] Creating affiliations table if it does not exist
6192018/12/06 10:04:38 [DEBUG] Upgrade certificates table...
6202018/12/06 10:04:38 [DEBUG] Upgrade certificates table to level 1
6212018/12/06 10:04:38 [DEBUG] Creating certificates table if it does not exist
6222018/12/06 10:04:38 [DEBUG] Loading identity table
6232018/12/06 10:04:38 [DEBUG] Loading identity 'admin'
6242018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
6252018/12/06 10:04:38 [DEBUG] Max enrollment value verification - User specified max enrollment: 0, CA max enrollment: 2
6262018/12/06 10:04:38 [DEBUG] DB: Add identity admin
6272018/12/06 10:04:38 [DEBUG] Successfully added identity admin to the database
6282018/12/06 10:04:38 [DEBUG] Registered identity: { Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:2 Attrs:map[hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true]  }
6292018/12/06 10:04:38 [DEBUG] Successfully loaded identity table
6302018/12/06 10:04:38 [DEBUG] Loading affiliations table
6312018/12/06 10:04:38 [DEBUG] DB: Add affiliation org1
6322018/12/06 10:04:38 [DEBUG] Affiliation 'org1' added
6332018/12/06 10:04:38 [DEBUG] DB: Add affiliation org1.department1
6342018/12/06 10:04:38 [DEBUG] Affiliation 'org1.department1' added
6352018/12/06 10:04:38 [DEBUG] DB: Add affiliation org1.department2
6362018/12/06 10:04:38 [DEBUG] Affiliation 'org1.department2' added
6372018/12/06 10:04:38 [DEBUG] DB: Add affiliation org2
6382018/12/06 10:04:38 [DEBUG] Affiliation 'org2' added
6392018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger
6402018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger' added
6412018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.fabric
6422018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.fabric' added
6432018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.fabric.ledger
6442018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.fabric.ledger' added
6452018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.fabric.orderer
6462018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.fabric.orderer' added
6472018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.fabric.security
6482018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.fabric.security' added
6492018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.fabric-ca
6502018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.fabric-ca' added
6512018/12/06 10:04:38 [DEBUG] DB: Add affiliation hyperledger.sdk
6522018/12/06 10:04:38 [DEBUG] Affiliation 'hyperledger.sdk' added
6532018/12/06 10:04:38 [DEBUG] Successfully loaded affiliations table
6542018/12/06 10:04:38 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db
6552018/12/06 10:04:38 [DEBUG] Initializing enrollment signer
6562018/12/06 10:04:38 [DEBUG] validating configuration
6572018/12/06 10:04:38 [DEBUG] validate local profile
6582018/12/06 10:04:38 [DEBUG] profile is valid
6592018/12/06 10:04:38 [DEBUG] validate local profile
6602018/12/06 10:04:38 [DEBUG] profile is valid
6612018/12/06 10:04:38 [DEBUG] validate local profile
6622018/12/06 10:04:38 [DEBUG] profile is valid
6632018/12/06 10:04:38 [DEBUG] CA initialization successful
6642018/12/06 10:04:38 [DEBUG] Initializing Idemix issuer...
6652018/12/06 10:04:38 [INFO] The issuer key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey, secret key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey
6662018/12/06 10:04:38 [DEBUG] Intializing revocation authority for issuer ''
6672018/12/06 10:04:38 [DEBUG] Initialize Idemix issuer revocation key material
6682018/12/06 10:04:38 [INFO] Idemix issuer revocation public and secret keys were generated for CA ''
6692018/12/06 10:04:38 [INFO] The revocation key was successfully stored. The public key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey, private key is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey
6702018/12/06 10:04:38 [DEBUG] Intializing nonce manager for issuer ''
6712018/12/06 10:04:38 [INFO] Home directory for default CA: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
6722018/12/06 10:04:38 [DEBUG] 1 CA instance(s) running on server
6732018/12/06 10:04:38 [INFO] Listening on http://0.0.0.0:7058
6742018/12/06 10:04:38 [DEBUG] Enrolling { Name:admin Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }
6752018/12/06 10:04:38 [DEBUG] Initializing client with config: &{URL:http://localhost:7058 MSPDir: TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  } CSR:{CN: Names:[] Hosts:[]KeyRequest:<nil> CA:<nil> SerialNumber:} ID:{Name: Type: Secret: MaxEnrollments:0 Affiliation: Attributes:[] CAName:} Revoke:{Name: Serial: AKI: Reason: CAName: GenCRL:false} CAInfo:{CAName:} CAName: CSP:<nil> Debug:false LogLevel:}
6762018/12/06 10:04:38 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0000b1e90 PluginOpts:<nil>}
6772018/12/06 10:04:38 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc00022b290 DummyKeystore:<nil>}
6782018/12/06 10:04:38 [DEBUG] GenCSR <nil>
6792018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
6802018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
6812018/12/06 10:04:38 [INFO] encoded CSR
6822018/12/06 10:04:38 [DEBUG] Sending request
683POST http://localhost:7058/enroll
684{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEF+o8S1n2TCABIrfQhYD22xLREXKq8XHhcytGSzBOeYLW7HuQcbmQQvRr\nx4R/vH3gZrMk2ZfM+bADsRXOznch56AmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgDjKbe3YpInvdGd2kl2iy\n4y8e19HP3UwgSyIdCs8egaQCIDVp/ft/MbQ4phSKlLCPySstcjtkOs76+t3RFLyq\nXPSE\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
6852018/12/06 10:04:38 [DEBUG] Received request for /enroll
6862018/12/06 10:04:38 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
6872018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
6882018/12/06 10:04:38 [DEBUG] DB: Login user admin with max enrollments of 2 and state of 0
6892018/12/06 10:04:38 [DEBUG] DB: identity admin successfully logged in
6902018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
6912018/12/06 10:04:38 [DEBUG] Processing sign request: id=admin, CommonName=admin, Subject=<nil>
6922018/12/06 10:04:38 [DEBUG] Request is not for a CA signing certificate
6932018/12/06 10:04:38 [DEBUG] Checking CSR fields to make sure that they do not exceed maximum character limits
6942018/12/06 10:04:38 [DEBUG] Finished processing sign request
6952018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
6962018/12/06 10:04:38 [INFO] signed certificate with serial number 56357810222256105140427525668636198571214046800
6972018/12/06 10:04:38 [DEBUG] DB: Insert Certificate
6982018/12/06 10:04:38 [DEBUG] Saved serial number as hex 9df2beeda399bfa10e596d43db67c6bd5e30650
6992018/12/06 10:04:38 [DEBUG] saved certificate with serial number 56357810222256105140427525668636198571214046800
7002018/12/06 10:04:38 [DEBUG] Successfully incremented state for identity admin to 1
7012018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /enroll 201 0 "OK"
7022018/12/06 10:04:38 [DEBUG] Received response
703statusCode=201 (201 Created)
7042018/12/06 10:04:38 [DEBUG] Response body result: map[Cert:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJxekNDQVZLZ0F3SUJBZ0lVQ2Q4cjd0bzVtL29RNVpiVVBiWjhhOVhqQmxBd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERURTVNVEl3TmpFdwpNRFV3TUZvd0lURVBNQTBHQTFVRUN4TUdZMnhwWlc1ME1RNHdEQVlEVlFRREV3VmhaRzFwYmpCWk1CTUdCeXFHClNNNDlBZ0VHQ0NxR1NNNDlBd0VIQTBJQUJCZnFQRXRaOWt3Z0FTSzMwSVdBOXRzUzBSRnlxdkZ4NFhNclJrc3cKVG5tQzF1eDdrSEc1a0VMMGE4ZUVmN3g5NEdhekpObVh6UG13QTdFVnpzNTNJZWVqZFRCek1BNEdBMVVkRHdFQgovd1FFQXdJQkJqQU1CZ05WSFJNQkFmOEVBakFBTUIwR0ExVWREZ1FXQkJRN0kzRlVqalhKcG1jRk5icG1UbkxICndRQWhSVEFmQmdOVkhTTUVHREFXZ0JTRlpFY2JoTUphUE50MFc3UHVsT2x4cXVhYm5qQVRCZ05WSFJFRUREQUsKZ2doc1lYSm5aV0p2ZURBS0JnZ3Foa2pPUFFRREFnTkhBREJFQWlBNFEzYm9yZlQ1RGN4YVRESWcxRkRZeGNseApZdWNHNUFETURLMmJuaTJ2a3dJZ1VOWW9YTm9tTHI5Um51YzRLYVR3MDM4ekVGcDhKYWQ2MS9rL2tiRVpIaDA9Ci0tLS0tRU5EIENFUlRJRklDQVRFLS0tLS0K ServerInfo:map[CAName: CAChain:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJiRENDQVJLZ0F3SUJBZ0lVQ1R0a1EzMVVPQlJwZS82RGh5RWF5MTl0cThRd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERUTXpNVEl3TWpFdwpNREF3TUZvd0ZERVNNQkFHQTFVRUF4TUpiRzlqWVd4b2IzTjBNRmt3RXdZSEtvWkl6ajBDQVFZSUtvWkl6ajBECkFRY0RRZ0FFRFVMaTNDUXhHWVYxWEZCQkxzVzBxb3h3WUpvNDBrbk5UaDUrNVdWaERadVl2OVNqTEZtZHBMNW4KeEhTTzZxdU1YYjVNbFJ5VFBIUEhRcDhIZmpNWkRLTkNNRUF3RGdZRFZSMFBBUUgvQkFRREFnRUdNQThHQTFVZApFd0VCL3dRRk1BTUJBZjh3SFFZRFZSME9CQllFRklWa1J4dUV3bG84MjNSYnMrNlU2WEdxNXB1ZU1Bb0dDQ3FHClNNNDlCQU1DQTBnQU1FVUNJUUM3OEhZSGhHWEVVWFVvQ1V6UHNUTEM2QnkrNFljRGM0cGdJZzFkNFRWeUZRSWcKZDNSSEJTaFJUQWpxSEgxTG1JTWxOMzM2dTduTTR5OFB6K2VTS21zdGVCdz0KLS0tLS1FTkQgQ0VSVElGSUNBVEUtLS0tLQo= IssuerPublicKey:CgJPVQoEUm9sZQoMRW5yb2xsbWVudElEChBSZXZvY2F0aW9uSGFuZGxlEkQKIP5P4KllGDuaukC345yudoOGOgTXjlsHeFOLRJ/APfpxEiDJcB4nNcakuN0B6W12GDL3rtzhDR/T7SigYxFCibM9PBpECiA7ZZfgDTXY27UsB0RJqps+/ACRTwXj4GnKVE9rUnrXixIg0mCGZ2KqEllbHpUgFhe2GSYbAIKi4z6/zeKRuogPiVUiRAogynkPrVAq66UBF7hEYtgLVue1LjqrW3Z2IQO5w58swY0SIAFeIJLy3iE0NjFEPLSHDd7m49bWtXvC/KZFqRoj6TL/IkQKIClBNlOHfCbbBTkFYwlTVAhzkl377vsQxTKc127RXTEmEiAfD4mCH80xX8ooOTq1aqtY8AGJA4nOMGBhS9+F69NzHSJECiBbcZhcTseIvTbk82ojd2pJZrS1WbJK+CCgQrK32w+3ehIgJwvSbAX6LtWckbNXc78UJCJjT5kEPwBgvMlFG6x2JCEiRAog/Qr8SWvXgBNPooFF8doz7vf76vb0s/6i5a807D/zVOYSIGJN/v0HWAJyceJAlu4rVBqBkvExchCf/FiJcFV6X6cuKogBCiCslrjWzCGFlcfpzgrHZRe1JT3Ip091W/3M0gFBo8g0rBIgNP2bU5L+NoDhx5ohyOj8vlx9luBdlJrnB8/Cx1N7qL0aINj9dpdyfI258v0DLCgjL5TIqNalGiKYclOQi5eeMnloIiBTgRIE51TkvU+6ENs6KC+Lo1XYJsmk6trGv35X9t1b4TJECiDdxwD8s45U+sjnme7KcCVkUMPXA6d8oNSZHttyEtlq6xIgkVQR2kdXxn7g26UBzCOcpfOEh7GVJoKlRWoDUt96blk6RAogPr3pA+nFygN0F1es9f5DmtzbHWNnUDcFAE4Ont2cJE8SIF7TzN3Zwjz9HLNEbKB0zhjYLxmL3vFSeoH75c93zCOJQiC5Ov9jAeXytDlquHMwLJK0InsiEBu+RjpfShN8Y12hx0ogS44F/yeU4vNCUtkVfrzIzt7BV/WRdrBpphmBWErJ/7FSIERKXpfpeIpnYNI25K9qkilKjpXWpqY4gfB9EECjblb9 IssuerRevocationPublicKey:LS0tLS1CRUdJTiBQVUJMSUMgS0VZLS0tLS0KTUhZd0VBWUhLb1pJemowQ0FRWUZLNEVFQUNJRFlnQUV2eXo0SkdxOGZKRU9SY2UrMUN4YkhXRnd2QlNvZU9oZgpMeWJ2S0RZNG5hRWJGVUJhaGtoT3htTFRsSXBjQUN3QUhtZ3ZmNnRpR3k4Q003QlZlaDhsVnd0aDVZZ2djVXBoCmRKWU5GSlRxV215Z3V6SGpuQlBuRithcnJ0Wk50WDdQCi0tLS0tRU5EIFBVQkxJQyBLRVktLS0tLQo= Version:]]
7052018/12/06 10:04:38 [DEBUG] newEnrollmentResponse admin
7062018/12/06 10:04:38 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc00038a420 PluginOpts:<nil>}
7072018/12/06 10:04:38 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0001a4930 DummyKeystore:<nil>}
7082018/12/06 10:04:38 [DEBUG] Entering testMasqueradeEnroll
7092018/12/06 10:04:38 [DEBUG] Register { Name:masqueradeUser Type:user Secret:**** MaxEnrollments:2 Affiliation:hyperledger.fabric.security Attributes:[] CAName:  }
7102018/12/06 10:04:38 [DEBUG] Adding token-based authorization header
7112018/12/06 10:04:38 [DEBUG] Sending request
712POST http://localhost:7058/register
713{"id":"masqueradeUser","type":"user","max_enrollments":2,"affiliation":"hyperledger.fabric.security"}
7142018/12/06 10:04:38 [DEBUG] Received request for /register
7152018/12/06 10:04:38 [DEBUG] Caller is using a x509 certificate
7162018/12/06 10:04:38 [DEBUG] Checking for revocation/expiration of certificate owned by 'admin'
7172018/12/06 10:04:38 [DEBUG] DB: Get certificate by serial (9df2beeda399bfa10e596d43db67c6bd5e30650) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
7182018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
7192018/12/06 10:04:38 [DEBUG] Successful token authentication of 'admin'
7202018/12/06 10:04:38 [DEBUG] Received registration request from admin: { Name:masqueradeUser Type:user Secret:**** MaxEnrollments:2 Affiliation:hyperledger.fabric.security Attributes:[] CAName:  }
7212018/12/06 10:04:38 [DEBUG] canRegister - Check to see if user 'admin' can register
7222018/12/06 10:04:38 [DEBUG] Checking to see if caller 'admin' can act on type 'user'
7232018/12/06 10:04:38 [DEBUG] Checking to see if caller 'admin' is a registrar
7242018/12/06 10:04:38 [DEBUG] Validating affiliation: hyperledger.fabric.security
7252018/12/06 10:04:38 [DEBUG] Checking to see if affiliation 'hyperledger.fabric.security' contains caller's affiliation ''
7262018/12/06 10:04:38 [DEBUG] Caller has root affiliation
7272018/12/06 10:04:38 [DEBUG] DB: Get affiliation hyperledger.fabric.security
7282018/12/06 10:04:38 [DEBUG] Registering user id: masqueradeUser
7292018/12/06 10:04:38 [DEBUG] Max enrollment value verification - User specified max enrollment: 2, CA max enrollment: 2
7302018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser
7312018/12/06 10:04:38 [DEBUG] DB: Add identity masqueradeUser
7322018/12/06 10:04:38 [DEBUG] Successfully added identity masqueradeUser to the database
7332018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /register 201 0 "OK"
7342018/12/06 10:04:38 [DEBUG] Received response
735statusCode=201 (201 Created)
7362018/12/06 10:04:38 [DEBUG] Response body result: map[secret:ZacgSRcaGqpk]
7372018/12/06 10:04:38 [DEBUG] The register request completed successfully
7382018/12/06 10:04:38 [DEBUG] GenCSR <nil>
7392018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
7402018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
7412018/12/06 10:04:38 [INFO] encoded CSR
7422018/12/06 10:04:38 [DEBUG] Sending request
743POST http://localhost:7058/enroll
744{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEkovmGXy4R5IayIAps9v127AGOCsNnf2AYblkXKlF3f64jlxBHo+B2PHX\nPTpW/pNhYornGBos6bew1doFEaD4yKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgRrEWydUFW4Zk2cuvL9fC\ndgqGqFPX/uA7Prj6wDly3B4CIBeFlVSzJMOl/b5+RO2+IPpjx44IHw4zh73hw0No\nyoF+\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
7452018/12/06 10:04:38 [DEBUG] Received request for /enroll
7462018/12/06 10:04:38 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
7472018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser
7482018/12/06 10:04:38 [DEBUG] DB: Login user masqueradeUser with max enrollments of 2 and state of 0
7492018/12/06 10:04:38 [DEBUG] DB: identity masqueradeUser successfully logged in
7502018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser
7512018/12/06 10:04:38 [DEBUG] Processing sign request: id=masqueradeUser, CommonName=admin, Subject=<nil>
7522018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /enroll 500 0 "The CSR subject common name must equal the enrollment ID"
7532018/12/06 10:04:38 [DEBUG] Received response
754statusCode=500 (500 Internal Server Error)
7552018/12/06 10:04:38 [DEBUG] testMasqueradeEnroll (false) error: Response from server: Error Code: 0 - The CSR subject common name must equal the enrollment ID
7562018/12/06 10:04:38 [DEBUG] GenCSR <nil>
7572018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
7582018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
7592018/12/06 10:04:38 [INFO] encoded CSR
7602018/12/06 10:04:38 [DEBUG] Sending request
761POST http://localhost:7058/enroll
762{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEmoMxpdvs5zILsu7oErJWIlSwJRpZeh3yliPyVOPWBG6HzehiN7CAcIQ7\neDEWY763d3ThJpM3GJNyeeh/+qH4qqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgSxDZQpYZYa6kYp91IgJu\nJkIGScbs6Qqr73+6ZWqnzzQCIGBQez5tsaaxrbBfLLQk1twatGo3v8JGRWvsrbHs\ncL/j\n-----END CERTIFICATE REQUEST-----\n","subject":{"CN":"admin","names":null,"SerialNumber":""},"profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
7632018/12/06 10:04:38 [DEBUG] Received request for /enroll
7642018/12/06 10:04:38 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
7652018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser
7662018/12/06 10:04:38 [DEBUG] DB: Login user masqueradeUser with max enrollments of 2 and state of 0
7672018/12/06 10:04:38 [DEBUG] DB: identity masqueradeUser successfully logged in
7682018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser
7692018/12/06 10:04:38 [DEBUG] Processing sign request: id=masqueradeUser, CommonName=admin, Subject=&{CN:admin Names:[] SerialNumber:}
7702018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /enroll 500 0 "The CSR subject common name must equal the enrollment ID"
7712018/12/06 10:04:38 [DEBUG] Received response
772statusCode=500 (500 Internal Server Error)
7732018/12/06 10:04:38 [DEBUG] testMasqueradeEnroll (true) error: Response from server: Error Code: 0 - The CSR subject common name must equal the enrollment ID
7742018/12/06 10:04:38 [DEBUG] Register { Name:masqueradeUser2 Type:user Secret:**** MaxEnrollments:2 Affiliation:hyperledger.fabric.security Attributes:[] CAName:  }
7752018/12/06 10:04:38 [DEBUG] Adding token-based authorization header
7762018/12/06 10:04:38 [DEBUG] Sending request
777POST http://localhost:7058/register
778{"id":"masqueradeUser2","type":"user","max_enrollments":2,"affiliation":"hyperledger.fabric.security"}
7792018/12/06 10:04:38 [DEBUG] Received request for /register
7802018/12/06 10:04:38 [DEBUG] Caller is using a x509 certificate
7812018/12/06 10:04:38 [DEBUG] Checking for revocation/expiration of certificate owned by 'admin'
7822018/12/06 10:04:38 [DEBUG] DB: Get certificate by serial (9df2beeda399bfa10e596d43db67c6bd5e30650) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
7832018/12/06 10:04:38 [DEBUG] DB: Getting identity admin
7842018/12/06 10:04:38 [DEBUG] Successful token authentication of 'admin'
7852018/12/06 10:04:38 [DEBUG] Received registration request from admin: { Name:masqueradeUser2 Type:user Secret:**** MaxEnrollments:2 Affiliation:hyperledger.fabric.security Attributes:[] CAName:  }
7862018/12/06 10:04:38 [DEBUG] canRegister - Check to see if user 'admin' can register
7872018/12/06 10:04:38 [DEBUG] Checking to see if caller 'admin' can act on type 'user'
7882018/12/06 10:04:38 [DEBUG] Checking to see if caller 'admin' is a registrar
7892018/12/06 10:04:38 [DEBUG] Validating affiliation: hyperledger.fabric.security
7902018/12/06 10:04:38 [DEBUG] Checking to see if affiliation 'hyperledger.fabric.security' contains caller's affiliation ''
7912018/12/06 10:04:38 [DEBUG] Caller has root affiliation
7922018/12/06 10:04:38 [DEBUG] DB: Get affiliation hyperledger.fabric.security
7932018/12/06 10:04:38 [DEBUG] Registering user id: masqueradeUser2
7942018/12/06 10:04:38 [DEBUG] Max enrollment value verification - User specified max enrollment: 2, CA max enrollment: 2
7952018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
7962018/12/06 10:04:38 [DEBUG] DB: Add identity masqueradeUser2
7972018/12/06 10:04:38 [DEBUG] Successfully added identity masqueradeUser2 to the database
7982018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /register 201 0 "OK"
7992018/12/06 10:04:38 [DEBUG] Received response
800statusCode=201 (201 Created)
8012018/12/06 10:04:38 [DEBUG] Response body result: map[secret:XRdHWIhlxfbB]
8022018/12/06 10:04:38 [DEBUG] The register request completed successfully
8032018/12/06 10:04:38 [DEBUG] Enrolling { Name:masqueradeUser2 Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }
8042018/12/06 10:04:38 [DEBUG] GenCSR <nil>
8052018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
8062018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
8072018/12/06 10:04:38 [INFO] encoded CSR
8082018/12/06 10:04:38 [DEBUG] Sending request
809POST http://localhost:7058/enroll
810{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIH6MIGiAgEAMBoxGDAWBgNVBAMTD21hc3F1ZXJhZGVVc2VyMjBZMBMGByqGSM49\nAgEGCCqGSM49AwEHA0IABACeicNQ8+lXIpOTyYtfoxWOjwsG6yzYsgsEp89Mcbd5\nodxtHXIfdZeziNNSfYMwEEbaI2sxMXHWVsxooGOeYDygJjAkBgkqhkiG9w0BCQ4x\nFzAVMBMGA1UdEQQMMAqCCGxhcmdlYm94MAoGCCqGSM49BAMCA0cAMEQCIDgJTQ74\nxZDbuCTN9jRoujd9OtAJWjk7YyUy/HOUQknVAiBeGamfkQf9HbdiBne+dbRhVar7\nTdn+8qnIcea8vO+m6Q==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
8112018/12/06 10:04:38 [DEBUG] Received request for /enroll
8122018/12/06 10:04:38 [DEBUG] ca.Config: &{Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.AffiliationMgr:true hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:*]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric:[ledger orderer security] fabric-ca:<nil> sdk:<nil>] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
8132018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
8142018/12/06 10:04:38 [DEBUG] DB: Login user masqueradeUser2 with max enrollments of 2 and state of 0
8152018/12/06 10:04:38 [DEBUG] DB: identity masqueradeUser2 successfully logged in
8162018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
8172018/12/06 10:04:38 [DEBUG] Processing sign request: id=masqueradeUser2, CommonName=masqueradeUser2, Subject=<nil>
8182018/12/06 10:04:38 [DEBUG] Request is not for a CA signing certificate
8192018/12/06 10:04:38 [DEBUG] Checking CSR fields to make sure that they do not exceed maximum character limits
8202018/12/06 10:04:38 [DEBUG] Finished processing sign request
8212018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
8222018/12/06 10:04:38 [DEBUG] Attribute extension being added to certificate is: &{ID:[1 2 3 4 5 6 7 8 1] Critical:false Value:7b226174747273223a7b2268662e416666696c696174696f6e223a2268797065726c65646765722e6661627269632e7365637572697479222c2268662e456e726f6c6c6d656e744944223a226d6173717565726164655573657232222c2268662e54797065223a2275736572227d7d}
8232018/12/06 10:04:38 [DEBUG] Adding attribute extension to CSR: &{ID:[1 2 3 4 5 6 7 8 1] Critical:false Value:7b226174747273223a7b2268662e416666696c696174696f6e223a2268797065726c65646765722e6661627269632e7365637572697479222c2268662e456e726f6c6c6d656e744944223a226d6173717565726164655573657232222c2268662e54797065223a2275736572227d7d}
8242018/12/06 10:04:38 [INFO] signed certificate with serial number 499110332413916079299191570649655578195069054057
8252018/12/06 10:04:38 [DEBUG] DB: Insert Certificate
8262018/12/06 10:04:38 [DEBUG] Saved serial number as hex 576ce1a07956d1c9392db607491ea73a03592c69
8272018/12/06 10:04:38 [DEBUG] saved certificate with serial number 499110332413916079299191570649655578195069054057
8282018/12/06 10:04:38 [DEBUG] Successfully incremented state for identity masqueradeUser2 to 1
8292018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /enroll 201 0 "OK"
8302018/12/06 10:04:38 [DEBUG] Received response
831statusCode=201 (201 Created)
8322018/12/06 10:04:38 [DEBUG] Response body result: map[ServerInfo:map[CAName: CAChain:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJiRENDQVJLZ0F3SUJBZ0lVQ1R0a1EzMVVPQlJwZS82RGh5RWF5MTl0cThRd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERUTXpNVEl3TWpFdwpNREF3TUZvd0ZERVNNQkFHQTFVRUF4TUpiRzlqWVd4b2IzTjBNRmt3RXdZSEtvWkl6ajBDQVFZSUtvWkl6ajBECkFRY0RRZ0FFRFVMaTNDUXhHWVYxWEZCQkxzVzBxb3h3WUpvNDBrbk5UaDUrNVdWaERadVl2OVNqTEZtZHBMNW4KeEhTTzZxdU1YYjVNbFJ5VFBIUEhRcDhIZmpNWkRLTkNNRUF3RGdZRFZSMFBBUUgvQkFRREFnRUdNQThHQTFVZApFd0VCL3dRRk1BTUJBZjh3SFFZRFZSME9CQllFRklWa1J4dUV3bG84MjNSYnMrNlU2WEdxNXB1ZU1Bb0dDQ3FHClNNNDlCQU1DQTBnQU1FVUNJUUM3OEhZSGhHWEVVWFVvQ1V6UHNUTEM2QnkrNFljRGM0cGdJZzFkNFRWeUZRSWcKZDNSSEJTaFJUQWpxSEgxTG1JTWxOMzM2dTduTTR5OFB6K2VTS21zdGVCdz0KLS0tLS1FTkQgQ0VSVElGSUNBVEUtLS0tLQo= IssuerPublicKey:CgJPVQoEUm9sZQoMRW5yb2xsbWVudElEChBSZXZvY2F0aW9uSGFuZGxlEkQKIP5P4KllGDuaukC345yudoOGOgTXjlsHeFOLRJ/APfpxEiDJcB4nNcakuN0B6W12GDL3rtzhDR/T7SigYxFCibM9PBpECiA7ZZfgDTXY27UsB0RJqps+/ACRTwXj4GnKVE9rUnrXixIg0mCGZ2KqEllbHpUgFhe2GSYbAIKi4z6/zeKRuogPiVUiRAogynkPrVAq66UBF7hEYtgLVue1LjqrW3Z2IQO5w58swY0SIAFeIJLy3iE0NjFEPLSHDd7m49bWtXvC/KZFqRoj6TL/IkQKIClBNlOHfCbbBTkFYwlTVAhzkl377vsQxTKc127RXTEmEiAfD4mCH80xX8ooOTq1aqtY8AGJA4nOMGBhS9+F69NzHSJECiBbcZhcTseIvTbk82ojd2pJZrS1WbJK+CCgQrK32w+3ehIgJwvSbAX6LtWckbNXc78UJCJjT5kEPwBgvMlFG6x2JCEiRAog/Qr8SWvXgBNPooFF8doz7vf76vb0s/6i5a807D/zVOYSIGJN/v0HWAJyceJAlu4rVBqBkvExchCf/FiJcFV6X6cuKogBCiCslrjWzCGFlcfpzgrHZRe1JT3Ip091W/3M0gFBo8g0rBIgNP2bU5L+NoDhx5ohyOj8vlx9luBdlJrnB8/Cx1N7qL0aINj9dpdyfI258v0DLCgjL5TIqNalGiKYclOQi5eeMnloIiBTgRIE51TkvU+6ENs6KC+Lo1XYJsmk6trGv35X9t1b4TJECiDdxwD8s45U+sjnme7KcCVkUMPXA6d8oNSZHttyEtlq6xIgkVQR2kdXxn7g26UBzCOcpfOEh7GVJoKlRWoDUt96blk6RAogPr3pA+nFygN0F1es9f5DmtzbHWNnUDcFAE4Ont2cJE8SIF7TzN3Zwjz9HLNEbKB0zhjYLxmL3vFSeoH75c93zCOJQiC5Ov9jAeXytDlquHMwLJK0InsiEBu+RjpfShN8Y12hx0ogS44F/yeU4vNCUtkVfrzIzt7BV/WRdrBpphmBWErJ/7FSIERKXpfpeIpnYNI25K9qkilKjpXWpqY4gfB9EECjblb9 IssuerRevocationPublicKey:LS0tLS1CRUdJTiBQVUJMSUMgS0VZLS0tLS0KTUhZd0VBWUhLb1pJemowQ0FRWUZLNEVFQUNJRFlnQUV2eXo0SkdxOGZKRU9SY2UrMUN4YkhXRnd2QlNvZU9oZgpMeWJ2S0RZNG5hRWJGVUJhaGtoT3htTFRsSXBjQUN3QUhtZ3ZmNnRpR3k4Q003QlZlaDhsVnd0aDVZZ2djVXBoCmRKWU5GSlRxV215Z3V6SGpuQlBuRithcnJ0Wk50WDdQCi0tLS0tRU5EIFBVQkxJQyBLRVktLS0tLQo= Version:] Cert:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUNaakNDQWcyZ0F3SUJBZ0lVVjJ6aG9IbFcwY2s1TGJZSFNSNm5PZ05aTEdrd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERURTVNVEl3TmpFdwpNRFV3TUZvd1hURkJNQXNHQTFVRUN4TUVkWE5sY2pBU0JnTlZCQXNUQzJoNWNHVnliR1ZrWjJWeU1BMEdBMVVFCkN4TUdabUZpY21sak1BOEdBMVVFQ3hNSWMyVmpkWEpwZEhreEdEQVdCZ05WQkFNVEQyMWhjM0YxWlhKaFpHVlYKYzJWeU1qQlpNQk1HQnlxR1NNNDlBZ0VHQ0NxR1NNNDlBd0VIQTBJQUJBQ2VpY05ROCtsWElwT1R5WXRmb3hXTwpqd3NHNnl6WXNnc0VwODlNY2JkNW9keHRIWElmZFplemlOTlNmWU13RUViYUkyc3hNWEhXVnN4b29HT2VZRHlqCmdmTXdnZkF3RGdZRFZSMFBBUUgvQkFRREFnRUdNQXdHQTFVZEV3RUIvd1FDTUFBd0hRWURWUjBPQkJZRUZQaUkKY3dHVWcrVjZhMWdNTGlXZEVnVlBCKytoTUI4R0ExVWRJd1FZTUJhQUZJVmtSeHVFd2xvODIzUmJzKzZVNlhHcQo1cHVlTUJNR0ExVWRFUVFNTUFxQ0NHeGhjbWRsWW05NE1Ic0dDQ29EQkFVR0J3Z0JCRzk3SW1GMGRISnpJanA3CkltaG1Ma0ZtWm1sc2FXRjBhVzl1SWpvaWFIbHdaWEpzWldSblpYSXVabUZpY21sakxuTmxZM1Z5YVhSNUlpd2kKYUdZdVJXNXliMnhzYldWdWRFbEVJam9pYldGemNYVmxjbUZrWlZWelpYSXlJaXdpYUdZdVZIbHdaU0k2SW5WegpaWElpZlgwd0NnWUlLb1pJemowRUF3SURSd0F3UkFJZ1BsZDdIcE8wZHZDeCtDWlppZWJ4UXRGUVpqb3NCdm1WCjdMVjE5Nm1IRVJJQ0lHeERzSUxuOE9yb1hScnpOVW5WWjIyVEtYTVRsZlRnckorNzJIeVM1MUVLCi0tLS0tRU5EIENFUlRJRklDQVRFLS0tLS0K]
8332018/12/06 10:04:38 [DEBUG] newEnrollmentResponse masqueradeUser2
8342018/12/06 10:04:38 [DEBUG] Entering testMasqueradeReenroll
8352018/12/06 10:04:38 [DEBUG] GenCSR <nil>
8362018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
8372018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
8382018/12/06 10:04:38 [INFO] encoded CSR
8392018/12/06 10:04:38 [DEBUG] Adding token-based authorization header
8402018/12/06 10:04:38 [DEBUG] Sending request
841POST http://localhost:7058/reenroll
842{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEGu1PJOJEbdfHeMmGLxg6g9CuJRb8sr8HBIQ8PWygodtBWFpXnfDIlqHo\n/TLjw+W75VkTRBrVmNSLdcxTQrIuIqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgMZo7XPm6+oAcEi63+QTC\n45PP7JflUgXTKmWKgO6o9IgCIDS28lZF7sno1ocWWbbQh7YiXNDgY6POGol3c/R5\nOKYi\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
8432018/12/06 10:04:38 [DEBUG] Received request for /reenroll
8442018/12/06 10:04:38 [DEBUG] Caller is using a x509 certificate
8452018/12/06 10:04:38 [DEBUG] Checking for revocation/expiration of certificate owned by 'masqueradeUser2'
8462018/12/06 10:04:38 [DEBUG] DB: Get certificate by serial (576ce1a07956d1c9392db607491ea73a03592c69) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
8472018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
8482018/12/06 10:04:38 [DEBUG] Successful token authentication of 'masqueradeUser2'
8492018/12/06 10:04:38 [DEBUG] Processing sign request: id=masqueradeUser2, CommonName=admin, Subject=<nil>
8502018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /reenroll 500 0 "The CSR subject common name must equal the enrollment ID"
8512018/12/06 10:04:38 [DEBUG] Received response
852statusCode=500 (500 Internal Server Error)
8532018/12/06 10:04:38 [DEBUG] testMasqueradeEnroll (false) error: Response from server: Error Code: 0 - The CSR subject common name must equal the enrollment ID
8542018/12/06 10:04:38 [DEBUG] GenCSR <nil>
8552018/12/06 10:04:38 [INFO] generating key: &{A:ecdsa S:256}
8562018/12/06 10:04:38 [DEBUG] generate key from request: algo=ecdsa, size=256
8572018/12/06 10:04:38 [INFO] encoded CSR
8582018/12/06 10:04:38 [DEBUG] Adding token-based authorization header
8592018/12/06 10:04:38 [DEBUG] Sending request
860POST http://localhost:7058/reenroll
861{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEuIIgVbl9UegnpjSy3v0K6Ukj1jItU0Ju0myR9P+WxAUSRkR9lQnxCpTX\n8/Izy27P2rR91z7kKyPWoefYwrwmbqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgGF0QPXTFXkbk4YOY90jZ\npx1WFRy3Zq/QF7ykSaNq3A4CIEatDGbWkU+Am+CU5tjtAiZYZ7gHx/WxmaDbTURG\n0awN\n-----END CERTIFICATE REQUEST-----\n","subject":{"CN":"admin","names":null,"SerialNumber":""},"profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
8622018/12/06 10:04:38 [DEBUG] Received request for /reenroll
8632018/12/06 10:04:38 [DEBUG] Caller is using a x509 certificate
8642018/12/06 10:04:38 [DEBUG] Checking for revocation/expiration of certificate owned by 'masqueradeUser2'
8652018/12/06 10:04:38 [DEBUG] DB: Get certificate by serial (576ce1a07956d1c9392db607491ea73a03592c69) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
8662018/12/06 10:04:38 [DEBUG] DB: Getting identity masqueradeUser2
8672018/12/06 10:04:38 [DEBUG] Successful token authentication of 'masqueradeUser2'
8682018/12/06 10:04:38 [DEBUG] Processing sign request: id=masqueradeUser2, CommonName=admin, Subject=&{CN:admin Names:[] SerialNumber:}
8692018/12/06 10:04:38 [INFO] 127.0.0.1:52026 POST /reenroll 500 0 "The CSR subject common name must equal the enrollment ID"
8702018/12/06 10:04:38 [DEBUG] Received response
871statusCode=500 (500 Internal Server Error)
8722018/12/06 10:04:38 [DEBUG] testMasqueradeEnroll (true) error: Response from server: Error Code: 0 - The CSR subject common name must equal the enrollment ID
8732018/12/06 10:04:38 [DEBUG] Stopping the server
8742018/12/06 10:04:38 [ERROR] Server has stopped serving: accept tcp [::]:7058: use of closed network connection
8752018/12/06 10:04:38 [DEBUG] Stop: successfully closed listener on port 7058
8762018/12/06 10:04:38 [DEBUG] Stop: waiting for listener on port 7058 to stop
8772018/12/06 10:04:38 [DEBUG] Stop: listener was already closed on port 7058
8782018/12/06 10:04:38 [DEBUG] Closing server DBs
8792018/12/06 10:04:39 [DEBUG] Stop: successful stop on port 7058
8802018/12/06 10:04:39 [DEBUG] Starting the server with TLS
8812018/12/06 10:04:39 [INFO] Starting server in home directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
8822018/12/06 10:04:39 [DEBUG] Set log level:
8832018/12/06 10:04:39 [INFO] Server Version: 1.1.0
8842018/12/06 10:04:39 [INFO] Server Levels: &{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}
8852018/12/06 10:04:39 [DEBUG] Making server filenames absolute
8862018/12/06 10:04:39 [DEBUG] Initializing default CA in directory /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
8872018/12/06 10:04:39 [DEBUG] Init CA with home /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server and config {Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true hf.Registrar.Roles:*]  }]} Affiliations:map[org2:<nil> hyperledger:map[fabric-ca:<nil> sdk:<nil> fabric:[ledger orderer security]] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
8882018/12/06 10:04:39 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
8892018/12/06 10:04:39 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
8902018/12/06 10:04:39 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0002962d0 PluginOpts:<nil>}
8912018/12/06 10:04:39 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003fff10 DummyKeystore:<nil>}
8922018/12/06 10:04:39 [DEBUG] Initialize key material
8932018/12/06 10:04:39 [DEBUG] Making CA filenames absolute
8942018/12/06 10:04:39 [INFO] The CA key and certificate already exist
8952018/12/06 10:04:39 [INFO] The key is stored by BCCSP provider 'SW'
8962018/12/06 10:04:39 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem
8972018/12/06 10:04:39 [DEBUG] Loading CN from existing enrollment information
8982018/12/06 10:04:39 [DEBUG] Initializing DB
8992018/12/06 10:04:39 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db'
9002018/12/06 10:04:39 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) directory
9012018/12/06 10:04:39 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) if it does not exist...
9022018/12/06 10:04:39 [DEBUG] Creating users table if it does not exist
9032018/12/06 10:04:39 [DEBUG] Creating affiliations table if it does not exist
9042018/12/06 10:04:39 [DEBUG] Creating certificates table if it does not exist
9052018/12/06 10:04:39 [DEBUG] Creating credentials table if it does not exist
9062018/12/06 10:04:39 [DEBUG] Creating revocation_authority_info table if it does not exist
9072018/12/06 10:04:39 [DEBUG] Creating nonces table if it does not exist
9082018/12/06 10:04:39 [DEBUG] Creating properties table if it does not exist
9092018/12/06 10:04:39 [DEBUG] Successfully opened sqlite3 DB
9102018/12/06 10:04:39 [DEBUG] Initializing identity registry
9112018/12/06 10:04:39 [DEBUG] Initialized DB identity registry
9122018/12/06 10:04:39 [DEBUG] Checking database levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
9132018/12/06 10:04:39 [DEBUG] Getting current levels to check if any tables need to be migrated
9142018/12/06 10:04:39 [DEBUG] Loading identity table
9152018/12/06 10:04:39 [DEBUG] Loading identity 'admin'
9162018/12/06 10:04:39 [DEBUG] DB: Getting identity admin
9172018/12/06 10:04:39 [DEBUG] Identity 'admin' already registered, loaded identity
9182018/12/06 10:04:39 [DEBUG] Successfully loaded identity table
9192018/12/06 10:04:39 [DEBUG] Loading affiliations table
9202018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger
9212018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger' already exists
9222018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.fabric-ca
9232018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.fabric-ca' already exists
9242018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.sdk
9252018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.sdk' already exists
9262018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.fabric
9272018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.fabric' already exists
9282018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.fabric.ledger
9292018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.fabric.ledger' already exists
9302018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.fabric.orderer
9312018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.fabric.orderer' already exists
9322018/12/06 10:04:39 [DEBUG] DB: Add affiliation hyperledger.fabric.security
9332018/12/06 10:04:39 [DEBUG] Affiliation 'hyperledger.fabric.security' already exists
9342018/12/06 10:04:39 [DEBUG] DB: Add affiliation org1
9352018/12/06 10:04:39 [DEBUG] Affiliation 'org1' already exists
9362018/12/06 10:04:39 [DEBUG] DB: Add affiliation org1.department1
9372018/12/06 10:04:39 [DEBUG] Affiliation 'org1.department1' already exists
9382018/12/06 10:04:39 [DEBUG] DB: Add affiliation org1.department2
9392018/12/06 10:04:39 [DEBUG] Affiliation 'org1.department2' already exists
9402018/12/06 10:04:39 [DEBUG] DB: Add affiliation org2
9412018/12/06 10:04:39 [DEBUG] Affiliation 'org2' already exists
9422018/12/06 10:04:39 [DEBUG] Successfully loaded affiliations table
9432018/12/06 10:04:39 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db
9442018/12/06 10:04:39 [DEBUG] Initializing enrollment signer
9452018/12/06 10:04:39 [DEBUG] validating configuration
9462018/12/06 10:04:39 [DEBUG] validate local profile
9472018/12/06 10:04:39 [DEBUG] profile is valid
9482018/12/06 10:04:39 [DEBUG] validate local profile
9492018/12/06 10:04:39 [DEBUG] profile is valid
9502018/12/06 10:04:39 [DEBUG] validate local profile
9512018/12/06 10:04:39 [DEBUG] profile is valid
9522018/12/06 10:04:39 [DEBUG] CA initialization successful
9532018/12/06 10:04:39 [DEBUG] Initializing Idemix issuer...
9542018/12/06 10:04:39 [INFO] The Idemix issuer public and secret key files already exist
9552018/12/06 10:04:39 [INFO]    secret key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey
9562018/12/06 10:04:39 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey
9572018/12/06 10:04:39 [DEBUG] Intializing revocation authority for issuer ''
9582018/12/06 10:04:39 [DEBUG] Initialize Idemix issuer revocation key material
9592018/12/06 10:04:39 [INFO] The Idemix issuer revocation public and secret key files already exist
9602018/12/06 10:04:39 [INFO]    private key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey
9612018/12/06 10:04:39 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey
9622018/12/06 10:04:39 [DEBUG] Intializing nonce manager for issuer ''
9632018/12/06 10:04:39 [INFO] Home directory for default CA: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
9642018/12/06 10:04:39 [DEBUG] 1 CA instance(s) running on server
9652018/12/06 10:04:39 [DEBUG] TLS is enabled
9662018/12/06 10:04:39 [DEBUG] Client authentication type requested: noclientcert
9672018/12/06 10:04:39 [INFO] Listening on https://0.0.0.0:7058
9682018/12/06 10:04:39 [DEBUG] Reenrolling { Profile: Label: CSR:<nil> CAName: AttrReqs:[]  }
9692018/12/06 10:04:39 [DEBUG] GenCSR <nil>
9702018/12/06 10:04:39 [INFO] generating key: &{A:ecdsa S:256}
9712018/12/06 10:04:39 [DEBUG] generate key from request: algo=ecdsa, size=256
9722018/12/06 10:04:39 [INFO] encoded CSR
9732018/12/06 10:04:39 [DEBUG] Adding token-based authorization header
9742018/12/06 10:04:39 [DEBUG] Sending request
975POST http://localhost:7058/reenroll
976{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEkmtEF9YCKisfdKJA+hhq2NN64YiDOYJu8maTPBSmPHuVqE5RKUNDX3In\njEqcGbs/SFI4AtA2LU8J07u1igUUgqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgAcwrwwImUAsuO88W65i+\nsZNEtrGm1kEUpYJ1ZPhrfVcCIG+HbpjNUHUYG1wV5c+qrgPBJUi7nvLVxvG1NNlK\nt9ep\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
9772018/12/06 10:04:39 http: TLS handshake error from 127.0.0.1:52028: tls: oversized record received with length 21536
9782018/12/06 10:04:39 [INFO] TLS Enabled
9792018/12/06 10:04:39 [DEBUG] CA Files: [/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem]
9802018/12/06 10:04:39 [DEBUG] Client Cert File:
9812018/12/06 10:04:39 [DEBUG] Client Key File:
9822018/12/06 10:04:39 [DEBUG] Client TLS certificate and/or key file not provided
9832018/12/06 10:04:39 [DEBUG] Reenrolling { Profile: Label: CSR:<nil> CAName: AttrReqs:[]  }
9842018/12/06 10:04:39 [DEBUG] GenCSR <nil>
9852018/12/06 10:04:39 [INFO] generating key: &{A:ecdsa S:256}
9862018/12/06 10:04:39 [DEBUG] generate key from request: algo=ecdsa, size=256
9872018/12/06 10:04:39 [INFO] encoded CSR
9882018/12/06 10:04:39 [DEBUG] Adding token-based authorization header
9892018/12/06 10:04:39 [DEBUG] Sending request
990POST https://localhost:7058/reenroll
991{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEBRoaeYQfZUKdx+NrH5cch12G0GNt6ilIi4i+k7X8nRB9NKaZHRCo4SYN\n/+yxB17Pv0gR4Jh2tOUtQsOnF5MzpqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgdl5z/bVOhMDwQPrM9fCJ\nr5OMGI61vHGPJ6xn1S+m7BYCIE48HHE4wtH8OW/xk30ma0tj6HXXIyI2xQ0ZVSPx\nsrpE\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
9922018/12/06 10:04:39 [DEBUG] Received request for /reenroll
9932018/12/06 10:04:39 [DEBUG] Caller is using a x509 certificate
9942018/12/06 10:04:39 [DEBUG] Checking for revocation/expiration of certificate owned by 'admin'
9952018/12/06 10:04:39 [DEBUG] DB: Get certificate by serial (9df2beeda399bfa10e596d43db67c6bd5e30650) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
9962018/12/06 10:04:39 [DEBUG] DB: Getting identity admin
9972018/12/06 10:04:39 [DEBUG] Successful token authentication of 'admin'
9982018/12/06 10:04:39 [DEBUG] Processing sign request: id=admin, CommonName=admin, Subject=<nil>
9992018/12/06 10:04:39 [DEBUG] Request is not for a CA signing certificate
10002018/12/06 10:04:39 [DEBUG] Checking CSR fields to make sure that they do not exceed maximum character limits
10012018/12/06 10:04:39 [DEBUG] Finished processing sign request
10022018/12/06 10:04:39 [DEBUG] DB: Getting identity admin
10032018/12/06 10:04:39 [INFO] signed certificate with serial number 645600440681214629039528044645226462370202180168
10042018/12/06 10:04:39 [DEBUG] DB: Insert Certificate
10052018/12/06 10:04:39 [DEBUG] Saved serial number as hex 7115b99945daaa3bba0eb7b27a75ead91558da48
10062018/12/06 10:04:39 [DEBUG] saved certificate with serial number 645600440681214629039528044645226462370202180168
10072018/12/06 10:04:39 [INFO] 127.0.0.1:52030 POST /reenroll 201 0 "OK"
10082018/12/06 10:04:39 [DEBUG] Received response
1009statusCode=201 (201 Created)
10102018/12/06 10:04:39 [DEBUG] Response body result: map[Cert:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJyRENDQVZLZ0F3SUJBZ0lVY1JXNW1VWGFxanU2RHJleWVuWHEyUlZZMmtnd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERURTVNVEl3TmpFdwpNRFV3TUZvd0lURVBNQTBHQTFVRUN4TUdZMnhwWlc1ME1RNHdEQVlEVlFRREV3VmhaRzFwYmpCWk1CTUdCeXFHClNNNDlBZ0VHQ0NxR1NNNDlBd0VIQTBJQUJBVWFHbm1FSDJWQ25jZmpheCtYSElkZGh0QmpiZW9wU0l1SXZwTzEKL0owUWZUU21tUjBRcU9FbURmL3NzUWRlejc5SUVlQ1lkclRsTFVMRHB4ZVRNNmFqZFRCek1BNEdBMVVkRHdFQgovd1FFQXdJQkJqQU1CZ05WSFJNQkFmOEVBakFBTUIwR0ExVWREZ1FXQkJRYXVKMlZTWFBPMnFCeU9SNmlSZFd0ClZ4VXN5akFmQmdOVkhTTUVHREFXZ0JTRlpFY2JoTUphUE50MFc3UHVsT2x4cXVhYm5qQVRCZ05WSFJFRUREQUsKZ2doc1lYSm5aV0p2ZURBS0JnZ3Foa2pPUFFRREFnTklBREJGQWlFQWcxc0MrZ0xMT0VyZjU0YWdVWHdqZGVCVQpxekNMcUFiUFZyVzd5OWlPQThZQ0lCVWtXUFFDOWNVMDVEMHZxYzUyME4xZnA5ZEhtNHdJcm5LVzVVenRNTjM0Ci0tLS0tRU5EIENFUlRJRklDQVRFLS0tLS0K ServerInfo:map[CAName: CAChain:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJiRENDQVJLZ0F3SUJBZ0lVQ1R0a1EzMVVPQlJwZS82RGh5RWF5MTl0cThRd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERUTXpNVEl3TWpFdwpNREF3TUZvd0ZERVNNQkFHQTFVRUF4TUpiRzlqWVd4b2IzTjBNRmt3RXdZSEtvWkl6ajBDQVFZSUtvWkl6ajBECkFRY0RRZ0FFRFVMaTNDUXhHWVYxWEZCQkxzVzBxb3h3WUpvNDBrbk5UaDUrNVdWaERadVl2OVNqTEZtZHBMNW4KeEhTTzZxdU1YYjVNbFJ5VFBIUEhRcDhIZmpNWkRLTkNNRUF3RGdZRFZSMFBBUUgvQkFRREFnRUdNQThHQTFVZApFd0VCL3dRRk1BTUJBZjh3SFFZRFZSME9CQllFRklWa1J4dUV3bG84MjNSYnMrNlU2WEdxNXB1ZU1Bb0dDQ3FHClNNNDlCQU1DQTBnQU1FVUNJUUM3OEhZSGhHWEVVWFVvQ1V6UHNUTEM2QnkrNFljRGM0cGdJZzFkNFRWeUZRSWcKZDNSSEJTaFJUQWpxSEgxTG1JTWxOMzM2dTduTTR5OFB6K2VTS21zdGVCdz0KLS0tLS1FTkQgQ0VSVElGSUNBVEUtLS0tLQo= IssuerPublicKey:CgJPVQoEUm9sZQoMRW5yb2xsbWVudElEChBSZXZvY2F0aW9uSGFuZGxlEkQKIP5P4KllGDuaukC345yudoOGOgTXjlsHeFOLRJ/APfpxEiDJcB4nNcakuN0B6W12GDL3rtzhDR/T7SigYxFCibM9PBpECiA7ZZfgDTXY27UsB0RJqps+/ACRTwXj4GnKVE9rUnrXixIg0mCGZ2KqEllbHpUgFhe2GSYbAIKi4z6/zeKRuogPiVUiRAogynkPrVAq66UBF7hEYtgLVue1LjqrW3Z2IQO5w58swY0SIAFeIJLy3iE0NjFEPLSHDd7m49bWtXvC/KZFqRoj6TL/IkQKIClBNlOHfCbbBTkFYwlTVAhzkl377vsQxTKc127RXTEmEiAfD4mCH80xX8ooOTq1aqtY8AGJA4nOMGBhS9+F69NzHSJECiBbcZhcTseIvTbk82ojd2pJZrS1WbJK+CCgQrK32w+3ehIgJwvSbAX6LtWckbNXc78UJCJjT5kEPwBgvMlFG6x2JCEiRAog/Qr8SWvXgBNPooFF8doz7vf76vb0s/6i5a807D/zVOYSIGJN/v0HWAJyceJAlu4rVBqBkvExchCf/FiJcFV6X6cuKogBCiCslrjWzCGFlcfpzgrHZRe1JT3Ip091W/3M0gFBo8g0rBIgNP2bU5L+NoDhx5ohyOj8vlx9luBdlJrnB8/Cx1N7qL0aINj9dpdyfI258v0DLCgjL5TIqNalGiKYclOQi5eeMnloIiBTgRIE51TkvU+6ENs6KC+Lo1XYJsmk6trGv35X9t1b4TJECiDdxwD8s45U+sjnme7KcCVkUMPXA6d8oNSZHttyEtlq6xIgkVQR2kdXxn7g26UBzCOcpfOEh7GVJoKlRWoDUt96blk6RAogPr3pA+nFygN0F1es9f5DmtzbHWNnUDcFAE4Ont2cJE8SIF7TzN3Zwjz9HLNEbKB0zhjYLxmL3vFSeoH75c93zCOJQiC5Ov9jAeXytDlquHMwLJK0InsiEBu+RjpfShN8Y12hx0ogS44F/yeU4vNCUtkVfrzIzt7BV/WRdrBpphmBWErJ/7FSIERKXpfpeIpnYNI25K9qkilKjpXWpqY4gfB9EECjblb9 IssuerRevocationPublicKey:LS0tLS1CRUdJTiBQVUJMSUMgS0VZLS0tLS0KTUhZd0VBWUhLb1pJemowQ0FRWUZLNEVFQUNJRFlnQUV2eXo0SkdxOGZKRU9SY2UrMUN4YkhXRnd2QlNvZU9oZgpMeWJ2S0RZNG5hRWJGVUJhaGtoT3htTFRsSXBjQUN3QUhtZ3ZmNnRpR3k4Q003QlZlaDhsVnd0aDVZZ2djVXBoCmRKWU5GSlRxV215Z3V6SGpuQlBuRithcnJ0Wk50WDdQCi0tLS0tRU5EIFBVQkxJQyBLRVktLS0tLQo= Version:]]
10112018/12/06 10:04:39 [DEBUG] newEnrollmentResponse admin
10122018/12/06 10:04:39 [INFO] Stored client certificate at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/client/msp/signcerts/cert.pem
10132018/12/06 10:04:39 [ERROR] Server has stopped serving: accept tcp [::]:7058: use of closed network connection
10142018/12/06 10:04:39 [DEBUG] Stop: successfully closed listener on port 7058
10152018/12/06 10:04:39 [DEBUG] Stop: waiting for listener on port 7058 to stop
10162018/12/06 10:04:39 [DEBUG] Stop: listener was already closed on port 7058
10172018/12/06 10:04:39 [DEBUG] Closing server DBs
10182018/12/06 10:04:40 [DEBUG] Stop: successful stop on port 7058
10192018/12/06 10:04:40 [INFO] Starting server in home directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
10202018/12/06 10:04:40 [DEBUG] Set log level:
10212018/12/06 10:04:40 [INFO] Server Version: 1.1.0
10222018/12/06 10:04:40 [INFO] Server Levels: &{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}
10232018/12/06 10:04:40 [DEBUG] Making server filenames absolute
10242018/12/06 10:04:40 [DEBUG] Initializing default CA in directory /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
10252018/12/06 10:04:40 [DEBUG] Init CA with home /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server and config {Version:0 Cfg:{Identities:{PasswordAttempts:0 AllowRemove:false} Affiliations:{AllowRemove:false}} CA:{Name: Keyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-key.pem Certfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem Chainfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-chain.pem} Signing:0xc0003ffc40 CSR:{CN:localhost Names:[] Hosts:[] KeyRequest:0xc00027db40 CA:0xc00027d9e0 SerialNumber:} Registry:{MaxEnrollments:2 Identities:[{ Name:**** Pass:**** Type:client Affiliation: MaxEnrollments:0 Attrs:map[hf.Registrar.Roles:* hf.Registrar.DelegateRoles:* hf.Revoker:true hf.IntermediateCA:true hf.GenCRL:true hf.Registrar.Attributes:* hf.AffiliationMgr:true]  }]} Affiliations:map[org2:<nil> hyperledger:map[sdk:<nil> fabric:[ledger orderer security] fabric-ca:<nil>] org1:map[department1:<nil> department2:<nil>]] LDAP:{ Enabled:false URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  } DB:{ Type:sqlite3 Datasource:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db TLS:{false [] { }}  } CSP:0xc00027da60 Client:<nil> Intermediate:{ParentServer:{ URL: CAName:  } TLS:{Enabled:false CertFiles:[] Client:{KeyFile: CertFile:}} Enrollment:{ Name: Secret:**** CAName: AttrReqs:[] Profile: Label: CSR:<nil> Type:  }} CRL:{Expiry:0s} Idemix:{IssuerPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey IssuerSecretKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey RevocationPublicKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey RevocationPrivateKeyfile:/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey RHPoolSize:1000 NonceExpiration:15s NonceSweepInterval:15m}}
10262018/12/06 10:04:40 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
10272018/12/06 10:04:40 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
10282018/12/06 10:04:40 [DEBUG] Initializing BCCSP: &{ProviderName:SW SwOpts:0xc0002962d0 PluginOpts:<nil>}
10292018/12/06 10:04:40 [DEBUG] Initializing BCCSP with software options &{SecLevel:256 HashFamily:SHA2 Ephemeral:false FileKeystore:0xc0003fff10 DummyKeystore:<nil>}
10302018/12/06 10:04:40 [DEBUG] Initialize key material
10312018/12/06 10:04:40 [DEBUG] Making CA filenames absolute
10322018/12/06 10:04:40 [INFO] The CA key and certificate already exist
10332018/12/06 10:04:40 [INFO] The key is stored by BCCSP provider 'SW'
10342018/12/06 10:04:40 [INFO] The certificate is at: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem
10352018/12/06 10:04:40 [DEBUG] Loading CN from existing enrollment information
10362018/12/06 10:04:40 [DEBUG] Initializing DB
10372018/12/06 10:04:40 [DEBUG] Initializing 'sqlite3' database at '/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db'
10382018/12/06 10:04:40 [DEBUG] Using sqlite database, connect to database in home (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) directory
10392018/12/06 10:04:40 [DEBUG] Creating SQLite database (/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db) if it does not exist...
10402018/12/06 10:04:40 [DEBUG] Creating users table if it does not exist
10412018/12/06 10:04:40 [DEBUG] Creating affiliations table if it does not exist
10422018/12/06 10:04:40 [DEBUG] Creating certificates table if it does not exist
10432018/12/06 10:04:40 [DEBUG] Creating credentials table if it does not exist
10442018/12/06 10:04:40 [DEBUG] Creating revocation_authority_info table if it does not exist
10452018/12/06 10:04:40 [DEBUG] Creating nonces table if it does not exist
10462018/12/06 10:04:40 [DEBUG] Creating properties table if it does not exist
10472018/12/06 10:04:40 [DEBUG] Successfully opened sqlite3 DB
10482018/12/06 10:04:40 [DEBUG] Initializing identity registry
10492018/12/06 10:04:40 [DEBUG] Initialized DB identity registry
10502018/12/06 10:04:40 [DEBUG] Checking database levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}' against server levels '&{Identity:1 Affiliation:1 Certificate:1 Credential:0 RAInfo:0 Nonce:0}'
10512018/12/06 10:04:40 [DEBUG] Getting current levels to check if any tables need to be migrated
10522018/12/06 10:04:40 [DEBUG] Loading identity table
10532018/12/06 10:04:40 [DEBUG] Loading identity 'admin'
10542018/12/06 10:04:40 [DEBUG] DB: Getting identity admin
10552018/12/06 10:04:40 [DEBUG] Identity 'admin' already registered, loaded identity
10562018/12/06 10:04:40 [DEBUG] Successfully loaded identity table
10572018/12/06 10:04:40 [DEBUG] Loading affiliations table
10582018/12/06 10:04:40 [DEBUG] DB: Add affiliation org2
10592018/12/06 10:04:40 [DEBUG] Affiliation 'org2' already exists
10602018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger
10612018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger' already exists
10622018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.fabric
10632018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.fabric' already exists
10642018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.fabric.ledger
10652018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.fabric.ledger' already exists
10662018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.fabric.orderer
10672018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.fabric.orderer' already exists
10682018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.fabric.security
10692018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.fabric.security' already exists
10702018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.fabric-ca
10712018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.fabric-ca' already exists
10722018/12/06 10:04:40 [DEBUG] DB: Add affiliation hyperledger.sdk
10732018/12/06 10:04:40 [DEBUG] Affiliation 'hyperledger.sdk' already exists
10742018/12/06 10:04:40 [DEBUG] DB: Add affiliation org1
10752018/12/06 10:04:40 [DEBUG] Affiliation 'org1' already exists
10762018/12/06 10:04:40 [DEBUG] DB: Add affiliation org1.department1
10772018/12/06 10:04:40 [DEBUG] Affiliation 'org1.department1' already exists
10782018/12/06 10:04:40 [DEBUG] DB: Add affiliation org1.department2
10792018/12/06 10:04:40 [DEBUG] Affiliation 'org1.department2' already exists
10802018/12/06 10:04:40 [DEBUG] Successfully loaded affiliations table
10812018/12/06 10:04:40 [INFO] Initialized sqlite3 database at /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/fabric-ca-server.db
10822018/12/06 10:04:40 [DEBUG] Initializing enrollment signer
10832018/12/06 10:04:40 [DEBUG] validating configuration
10842018/12/06 10:04:40 [DEBUG] validate local profile
10852018/12/06 10:04:40 [DEBUG] profile is valid
10862018/12/06 10:04:40 [DEBUG] validate local profile
10872018/12/06 10:04:40 [DEBUG] profile is valid
10882018/12/06 10:04:40 [DEBUG] validate local profile
10892018/12/06 10:04:40 [DEBUG] profile is valid
10902018/12/06 10:04:40 [DEBUG] CA initialization successful
10912018/12/06 10:04:40 [DEBUG] Initializing Idemix issuer...
10922018/12/06 10:04:40 [INFO] The Idemix issuer public and secret key files already exist
10932018/12/06 10:04:40 [INFO]    secret key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerSecretKey
10942018/12/06 10:04:40 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerPublicKey
10952018/12/06 10:04:41 [DEBUG] Intializing revocation authority for issuer ''
10962018/12/06 10:04:41 [DEBUG] Initialize Idemix issuer revocation key material
10972018/12/06 10:04:41 [INFO] The Idemix issuer revocation public and secret key files already exist
10982018/12/06 10:04:41 [INFO]    private key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/msp/keystore/IssuerRevocationPrivateKey
10992018/12/06 10:04:41 [INFO]    public key file location: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/IssuerRevocationPublicKey
11002018/12/06 10:04:41 [DEBUG] Intializing nonce manager for issuer ''
11012018/12/06 10:04:41 [INFO] Home directory for default CA: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server
11022018/12/06 10:04:41 [DEBUG] 1 CA instance(s) running on server
11032018/12/06 10:04:41 [DEBUG] TLS is enabled
11042018/12/06 10:04:41 [DEBUG] Client authentication type requested: RequireAndVerifyClientCert
11052018/12/06 10:04:41 [DEBUG] Reading cert file: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem
11062018/12/06 10:04:41 [DEBUG] Appending cert /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem to pool
11072018/12/06 10:04:41 [INFO] Listening on https://0.0.0.0:7058
11082018/12/06 10:04:41 [DEBUG] Reenrolling { Profile: Label: CSR:<nil> CAName: AttrReqs:[]  }
11092018/12/06 10:04:41 [DEBUG] GenCSR <nil>
11102018/12/06 10:04:41 [INFO] generating key: &{A:ecdsa S:256}
11112018/12/06 10:04:41 [DEBUG] generate key from request: algo=ecdsa, size=256
11122018/12/06 10:04:41 [INFO] encoded CSR
11132018/12/06 10:04:41 [DEBUG] Adding token-based authorization header
11142018/12/06 10:04:41 [DEBUG] Sending request
1115POST https://localhost:7058/reenroll
1116{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHxMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAErSQOqWHiRVUbsesXAsgQTgSoaxQK9luAg5G3bcYooq/rh68z2PwPz3bm\nQyYGPCp1zkcBLcudidDgfQkmnPxQRKAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDSAAwRQIhAMPPeiM4QAVChFhhijXP\nsJnOxeVG7ePjzKe7O801gZVCAiA9vYFPLBhAowcwI6G6WZucYcmPCLWdEEffYCxc\nbJuGHg==\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
11172018/12/06 10:04:41 http: TLS handshake error from 127.0.0.1:52032: tls: client didn't provide a certificate
11182018/12/06 10:04:41 [INFO] TLS Enabled
11192018/12/06 10:04:41 [DEBUG] CA Files: [/opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/server/ca-cert.pem]
11202018/12/06 10:04:41 [DEBUG] Client Cert File: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/testTLSClientAuthDir/client/msp/signcerts/cert.pem
11212018/12/06 10:04:41 [DEBUG] Client Key File:
11222018/12/06 10:04:41 [DEBUG] Check client TLS certificate for valid dates
11232018/12/06 10:04:41 [DEBUG] Reenrolling { Profile: Label: CSR:<nil> CAName: AttrReqs:[]  }
11242018/12/06 10:04:41 [DEBUG] GenCSR <nil>
11252018/12/06 10:04:41 [INFO] generating key: &{A:ecdsa S:256}
11262018/12/06 10:04:41 [DEBUG] generate key from request: algo=ecdsa, size=256
11272018/12/06 10:04:41 [INFO] encoded CSR
11282018/12/06 10:04:41 [DEBUG] Adding token-based authorization header
11292018/12/06 10:04:41 [DEBUG] Sending request
1130POST https://localhost:7058/reenroll
1131{"hosts":null,"certificate_request":"-----BEGIN CERTIFICATE REQUEST-----\nMIHwMIGYAgEAMBAxDjAMBgNVBAMTBWFkbWluMFkwEwYHKoZIzj0CAQYIKoZIzj0D\nAQcDQgAEWHWpZn6OAFOh81ypFuvmGnPisDXaGWOJ4Rrvs54ZXvGfWs/1MW3+nB9O\nWZ41RMLQBXvakzm+St4t4al4Ovz5DqAmMCQGCSqGSIb3DQEJDjEXMBUwEwYDVR0R\nBAwwCoIIbGFyZ2Vib3gwCgYIKoZIzj0EAwIDRwAwRAIgOTSmQXWcHw6EWpjMoKw4\n9Zvw2WWMlW2R2a1O9ZsI+R4CIGOMot9VSrWraf4SjX49X5bYky6vNlDkw+II9IvX\nXwYH\n-----END CERTIFICATE REQUEST-----\n","profile":"","crl_override":"","label":"","NotBefore":"0001-01-01T00:00:00Z","NotAfter":"0001-01-01T00:00:00Z","CAName":""}
11322018/12/06 10:04:41 [DEBUG] Received request for /reenroll
11332018/12/06 10:04:41 [DEBUG] Caller is using a x509 certificate
11342018/12/06 10:04:41 [DEBUG] Checking for revocation/expiration of certificate owned by 'admin'
11352018/12/06 10:04:41 [DEBUG] DB: Get certificate by serial (7115b99945daaa3bba0eb7b27a75ead91558da48) and aki (8564471b84c25a3cdb745bb3ee94e971aae69b9e)
11362018/12/06 10:04:41 [DEBUG] DB: Getting identity admin
11372018/12/06 10:04:41 [DEBUG] Successful token authentication of 'admin'
11382018/12/06 10:04:41 [DEBUG] Processing sign request: id=admin, CommonName=admin, Subject=<nil>
11392018/12/06 10:04:41 [DEBUG] Request is not for a CA signing certificate
11402018/12/06 10:04:41 [DEBUG] Checking CSR fields to make sure that they do not exceed maximum character limits
11412018/12/06 10:04:41 [DEBUG] Finished processing sign request
11422018/12/06 10:04:41 [DEBUG] DB: Getting identity admin
11432018/12/06 10:04:41 [INFO] signed certificate with serial number 249758493409239556524545012068804545697704270582
11442018/12/06 10:04:41 [DEBUG] DB: Insert Certificate
11452018/12/06 10:04:41 [DEBUG] Saved serial number as hex 2bbf8ee52e5da7b778ff8a4cba9fe5c32c4b5af6
11462018/12/06 10:04:41 [DEBUG] saved certificate with serial number 249758493409239556524545012068804545697704270582
11472018/12/06 10:04:41 [INFO] 127.0.0.1:52034 POST /reenroll 201 0 "OK"
11482018/12/06 10:04:41 [DEBUG] Received response
1149statusCode=201 (201 Created)
11502018/12/06 10:04:41 [DEBUG] Response body result: map[Cert:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJxekNDQVZLZ0F3SUJBZ0lVSzcrTzVTNWRwN2Q0LzRwTXVwL2x3eXhMV3ZZd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERURTVNVEl3TmpFdwpNRFV3TUZvd0lURVBNQTBHQTFVRUN4TUdZMnhwWlc1ME1RNHdEQVlEVlFRREV3VmhaRzFwYmpCWk1CTUdCeXFHClNNNDlBZ0VHQ0NxR1NNNDlBd0VIQTBJQUJGaDFxV1oramdCVG9mTmNxUmJyNWhwejRyQTEyaGxqaWVFYTc3T2UKR1Y3eG4xclA5VEZ0L3B3ZlRsbWVOVVRDMEFWNzJwTTV2a3JlTGVHcGVEcjgrUTZqZFRCek1BNEdBMVVkRHdFQgovd1FFQXdJQkJqQU1CZ05WSFJNQkFmOEVBakFBTUIwR0ExVWREZ1FXQkJTVDVCMmp6VVNpY3FqZHE4SUIxMlg5Cm5UU2ZyREFmQmdOVkhTTUVHREFXZ0JTRlpFY2JoTUphUE50MFc3UHVsT2x4cXVhYm5qQVRCZ05WSFJFRUREQUsKZ2doc1lYSm5aV0p2ZURBS0JnZ3Foa2pPUFFRREFnTkhBREJFQWlCR2hKS2EwRkFISjZJWEp4YzZmQjgwZHI5RgpZMTJJVy9JNU1hZnJ5dFRyL3dJZ0JQdTRFSExrZGdlY1c5NnVlNWRWTmFsekZLRUl4cnJXUXRTcmhtcitaYlk9Ci0tLS0tRU5EIENFUlRJRklDQVRFLS0tLS0K ServerInfo:map[CAName: CAChain:LS0tLS1CRUdJTiBDRVJUSUZJQ0FURS0tLS0tCk1JSUJiRENDQVJLZ0F3SUJBZ0lVQ1R0a1EzMVVPQlJwZS82RGh5RWF5MTl0cThRd0NnWUlLb1pJemowRUF3SXcKRkRFU01CQUdBMVVFQXhNSmJHOWpZV3hvYjNOME1CNFhEVEU0TVRJd05qRXdNREF3TUZvWERUTXpNVEl3TWpFdwpNREF3TUZvd0ZERVNNQkFHQTFVRUF4TUpiRzlqWVd4b2IzTjBNRmt3RXdZSEtvWkl6ajBDQVFZSUtvWkl6ajBECkFRY0RRZ0FFRFVMaTNDUXhHWVYxWEZCQkxzVzBxb3h3WUpvNDBrbk5UaDUrNVdWaERadVl2OVNqTEZtZHBMNW4KeEhTTzZxdU1YYjVNbFJ5VFBIUEhRcDhIZmpNWkRLTkNNRUF3RGdZRFZSMFBBUUgvQkFRREFnRUdNQThHQTFVZApFd0VCL3dRRk1BTUJBZjh3SFFZRFZSME9CQllFRklWa1J4dUV3bG84MjNSYnMrNlU2WEdxNXB1ZU1Bb0dDQ3FHClNNNDlCQU1DQTBnQU1FVUNJUUM3OEhZSGhHWEVVWFVvQ1V6UHNUTEM2QnkrNFljRGM0cGdJZzFkNFRWeUZRSWcKZDNSSEJTaFJUQWpxSEgxTG1JTWxOMzM2dTduTTR5OFB6K2VTS21zdGVCdz0KLS0tLS1FTkQgQ0VSVElGSUNBVEUtLS0tLQo= IssuerPublicKey:CgJPVQoEUm9sZQoMRW5yb2xsbWVudElEChBSZXZvY2F0aW9uSGFuZGxlEkQKIP5P4KllGDuaukC345yudoOGOgTXjlsHeFOLRJ/APfpxEiDJcB4nNcakuN0B6W12GDL3rtzhDR/T7SigYxFCibM9PBpECiA7ZZfgDTXY27UsB0RJqps+/ACRTwXj4GnKVE9rUnrXixIg0mCGZ2KqEllbHpUgFhe2GSYbAIKi4z6/zeKRuogPiVUiRAogynkPrVAq66UBF7hEYtgLVue1LjqrW3Z2IQO5w58swY0SIAFeIJLy3iE0NjFEPLSHDd7m49bWtXvC/KZFqRoj6TL/IkQKIClBNlOHfCbbBTkFYwlTVAhzkl377vsQxTKc127RXTEmEiAfD4mCH80xX8ooOTq1aqtY8AGJA4nOMGBhS9+F69NzHSJECiBbcZhcTseIvTbk82ojd2pJZrS1WbJK+CCgQrK32w+3ehIgJwvSbAX6LtWckbNXc78UJCJjT5kEPwBgvMlFG6x2JCEiRAog/Qr8SWvXgBNPooFF8doz7vf76vb0s/6i5a807D/zVOYSIGJN/v0HWAJyceJAlu4rVBqBkvExchCf/FiJcFV6X6cuKogBCiCslrjWzCGFlcfpzgrHZRe1JT3Ip091W/3M0gFBo8g0rBIgNP2bU5L+NoDhx5ohyOj8vlx9luBdlJrnB8/Cx1N7qL0aINj9dpdyfI258v0DLCgjL5TIqNalGiKYclOQi5eeMnloIiBTgRIE51TkvU+6ENs6KC+Lo1XYJsmk6trGv35X9t1b4TJECiDdxwD8s45U+sjnme7KcCVkUMPXA6d8oNSZHttyEtlq6xIgkVQR2kdXxn7g26UBzCOcpfOEh7GVJoKlRWoDUt96blk6RAogPr3pA+nFygN0F1es9f5DmtzbHWNnUDcFAE4Ont2cJE8SIF7TzN3Zwjz9HLNEbKB0zhjYLxmL3vFSeoH75c93zCOJQiC5Ov9jAeXytDlquHMwLJK0InsiEBu+RjpfShN8Y12hx0ogS44F/yeU4vNCUtkVfrzIzt7BV/WRdrBpphmBWErJ/7FSIERKXpfpeIpnYNI25K9qkilKjpXWpqY4gfB9EECjblb9 IssuerRevocationPublicKey:LS0tLS1CRUdJTiBQVUJMSUMgS0VZLS0tLS0KTUhZd0VBWUhLb1pJemowQ0FRWUZLNEVFQUNJRFlnQUV2eXo0SkdxOGZKRU9SY2UrMUN4YkhXRnd2QlNvZU9oZgpMeWJ2S0RZNG5hRWJGVUJhaGtoT3htTFRsSXBjQUN3QUhtZ3ZmNnRpR3k4Q003QlZlaDhsVnd0aDVZZ2djVXBoCmRKWU5GSlRxV215Z3V6SGpuQlBuRithcnJ0Wk50WDdQCi0tLS0tRU5EIFBVQkxJQyBLRVktLS0tLQo= Version:]]
11512018/12/06 10:04:41 [DEBUG] newEnrollmentResponse admin
11522018/12/06 10:04:41 [ERROR] Server has stopped serving: accept tcp [::]:7058: use of closed network connection
11532018/12/06 10:04:41 [DEBUG] Stop: successfully closed listener on port 7058
11542018/12/06 10:04:41 [DEBUG] Stop: waiting for listener on port 7058 to stop
11552018/12/06 10:04:41 [DEBUG] Stop: listener was already closed on port 7058
11562018/12/06 10:04:41 [DEBUG] Closing server DBs
11572018/12/06 10:04:42 [DEBUG] Stop: successful stop on port 7058
11582018/12/06 10:04:42 [DEBUG] Initializing DB
11592018/12/06 10:04:42 [DEBUG] Initializing 'postgres' database at ''
11602018/12/06 10:04:42 [DEBUG] Using postgres database, connecting to database...
11612018/12/06 10:04:42 [DEBUG] Database Name:
11622018/12/06 10:04:42 [DEBUG] Connecting to PostgreSQL server, using connection string:
11632018/12/06 10:04:42 [WARNING] Failed to connect to database ''
11642018/12/06 10:04:42 [DEBUG] Connecting to PostgreSQL server, using connection string:
11652018/12/06 10:04:42 [WARNING] Failed to connect to database 'postgres'
11662018/12/06 10:04:42 [DEBUG] Connecting to PostgreSQL server, using connection string:
11672018/12/06 10:04:42 [WARNING] Failed to connect to database 'template1'
11682018/12/06 10:04:42 [DEBUG] Initializing DB
11692018/12/06 10:04:42 [DEBUG] Initializing 'mysql' database at ''
11702018/12/06 10:04:42 [DEBUG] Using MySQL database, connecting to database...
11712018/12/06 10:04:42 [DEBUG] Database Name:
11722018/12/06 10:04:42 [DEBUG] Connecting to MySQL server, using connection string:
11732018/12/06 10:04:42 [DEBUG] Initializing DB
11742018/12/06 10:04:42 [DEBUG] Initializing 'unknown' database at ''
11752018/12/06 10:04:42 [DEBUG] Initializing identity registry
11762018/12/06 10:04:42 [DEBUG] Creating new LDAP client for { Enabled:true URL: UserFilter: GroupFilter: Attribute:{[] [] map[]} TLS:{false [] { }}  }
11772018/12/06 10:04:42 [DEBUG] Initialized LDAP identity registry; err=LDAP configuration requires a 'URL'
11782018/12/06 10:04:42 [WARNING] Failed to initialize LDAP client; err=LDAP configuration requires a 'URL'
11792018/12/06 10:04:42 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib
11802018/12/06 10:04:42 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
11812018/12/06 10:04:42 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib
11822018/12/06 10:04:42 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
11832018/12/06 10:04:42 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib
11842018/12/06 10:04:42 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
11852018/12/06 10:04:42 [DEBUG] CA Home Directory: /opt/gopath/src/github.com/hyperledger/fabric-ca/lib
11862018/12/06 10:04:42 [DEBUG] Checking configuration file version '0' against server version: '1.1.0'
11872018/12/06 10:04:42 [DEBUG] Making server filenames absolute
11882018/12/06 10:04:42 [DEBUG] Initializing DB
11892018/12/06 10:04:42 [DEBUG] Initializing 'sqlite3' database at '/tmp/CAConfigStat415371498/fabric-ca-server.db'
11902018/12/06 10:04:42 [DEBUG] Using sqlite database, connect to database in home (/tmp/CAConfigStat415371498/fabric-ca-server.db) directory
11912018/12/06 10:04:42 [DEBUG] Creating SQLite database (/tmp/CAConfigStat415371498/fabric-ca-server.db) if it does not exist...
11922018/12/06 10:04:42 [DEBUG] Creating users table if it does not exist
11932018/12/06 10:04:42 [DEBUG] Creating affiliations table if it does not exist
11942018/12/06 10:04:42 [DEBUG] Creating certificates table if it does not exist
11952018/12/06 10:04:42 [DEBUG] Creating credentials table if it does not exist
11962018/12/06 10:04:42 [DEBUG] Creating revocation_authority_info table if it does not exist
11972018/12/06 10:04:42 [DEBUG] Creating nonces table if it does not exist
11982018/12/06 10:04:42 [DEBUG] Creating properties table if it does not exist
11992018/12/06 10:04:42 [DEBUG] Successfully opened sqlite3 DB
1200--- FAIL: TestCWBCAConfigStat (0.01s)
1201panic: runtime error: invalid memory address or nil pointer dereference [recovered]
1202        panic: runtime error: invalid memory address or nil pointer dereference
1203[signal SIGSEGV: segmentation violation code=0x1 addr=0x10 pc=0xd85c25]
1204
1205goroutine 274 [running]:
1206testing.tRunner.func1(0xc0001aee00)
1207        /usr/lib/go-1.10/src/testing/testing.go:792 +0x387
1208panic(0xfb5740, 0x18b3ea0)
1209        /usr/lib/go-1.10/src/runtime/panic.go:513 +0x1b9
1210github.com/hyperledger/fabric-ca/lib.(*CA).initDB(0xc00051d1e0, 0x0, 0x0)
1211        /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/ca.go:614 +0x505
1212github.com/hyperledger/fabric-ca/lib.TestCWBCAConfigStat(0xc0001aee00)
1213        /opt/gopath/src/github.com/hyperledger/fabric-ca/lib/client_whitebox_test.go:607 +0x554
1214testing.tRunner(0xc0001aee00, 0x10c3300)
1215        /usr/lib/go-1.10/src/testing/testing.go:827 +0xbf
1216created by testing.(*T).Run
1217        /usr/lib/go-1.10/src/testing/testing.go:878 +0x353
1218FAIL    github.com/hyperledger/fabric-ca/lib    7.746s
1219error: exit status 1
1220panic: EOF