jobs git:(Nov6ws) kubectl logs -f joinchannel-2qlpn joinchannel-org1peer1 2019-11-06 19:51:48.974 UTC [viperutil] getKeysRecursively -> DEBU 001 Found map[string]interface{} value for peer.BCCSP 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 002 Found map[string]interface{} value for peer.BCCSP.SW 2019-11-06 19:51:48.975 UTC [viperutil] unmarshalJSON -> DEBU 003 Unmarshal JSON: value cannot be unmarshalled: invalid character 'S' looking for beginning of value 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 004 Found real value for peer.BCCSP.SW.Hash setting to string SHA2 2019-11-06 19:51:48.975 UTC [viperutil] unmarshalJSON -> DEBU 005 Unmarshal JSON: value is not a string: 256 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 006 Found real value for peer.BCCSP.SW.Security setting to int 256 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 007 Found map[string]interface{} value for peer.BCCSP.SW.FileKeyStore 2019-11-06 19:51:48.975 UTC [viperutil] unmarshalJSON -> DEBU 008 Unmarshal JSON: value cannot be unmarshalled: unexpected end of JSON input 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 009 Found real value for peer.BCCSP.SW.FileKeyStore.KeyStore setting to string 2019-11-06 19:51:48.975 UTC [viperutil] getKeysRecursively -> DEBU 00a Found map[string]interface{} value for peer.BCCSP.PKCS11 2019-11-06 19:51:48.976 UTC [viperutil] unmarshalJSON -> DEBU 00b Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.976 UTC [viperutil] getKeysRecursively -> DEBU 00c Found real value for peer.BCCSP.PKCS11.Pin setting to 2019-11-06 19:51:48.976 UTC [viperutil] unmarshalJSON -> DEBU 00d Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.976 UTC [viperutil] getKeysRecursively -> DEBU 00e Found real value for peer.BCCSP.PKCS11.Hash setting to 2019-11-06 19:51:48.976 UTC [viperutil] unmarshalJSON -> DEBU 00f Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.977 UTC [viperutil] getKeysRecursively -> DEBU 010 Found real value for peer.BCCSP.PKCS11.Security setting to 2019-11-06 19:51:48.977 UTC [viperutil] getKeysRecursively -> DEBU 011 Found map[string]interface{} value for peer.BCCSP.PKCS11.FileKeyStore 2019-11-06 19:51:48.977 UTC [viperutil] unmarshalJSON -> DEBU 012 Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.977 UTC [viperutil] getKeysRecursively -> DEBU 013 Found real value for peer.BCCSP.PKCS11.FileKeyStore.KeyStore setting to 2019-11-06 19:51:48.978 UTC [viperutil] unmarshalJSON -> DEBU 014 Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.978 UTC [viperutil] getKeysRecursively -> DEBU 015 Found real value for peer.BCCSP.PKCS11.Library setting to 2019-11-06 19:51:48.978 UTC [viperutil] unmarshalJSON -> DEBU 016 Unmarshal JSON: value is not a string: 2019-11-06 19:51:48.978 UTC [viperutil] getKeysRecursively -> DEBU 017 Found real value for peer.BCCSP.PKCS11.Label setting to 2019-11-06 19:51:48.979 UTC [viperutil] unmarshalJSON -> DEBU 018 Unmarshal JSON: value cannot be unmarshalled: invalid character 'S' looking for beginning of value 2019-11-06 19:51:48.979 UTC [viperutil] getKeysRecursively -> DEBU 019 Found real value for peer.BCCSP.Default setting to string SW 2019-11-06 19:51:48.979 UTC [viperutil] EnhancedExactUnmarshalKey -> DEBU 01a map[peer.BCCSP:map[SW:map[Hash:SHA2 Security:256 FileKeyStore:map[KeyStore:]] PKCS11:map[Security: FileKeyStore:map[KeyStore:] Library: Label: Pin: Hash:] Default:SW]] 2019-11-06 19:51:48.979 UTC [bccsp_sw] openKeyStore -> DEBU 01b KeyStore opened at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/keystore]...done 2019-11-06 19:51:48.979 UTC [bccsp] initBCCSP -> DEBU 01c Initialize BCCSP [SW] 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 01d Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/signcerts 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 01e Inspecting file /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/signcerts/Admin@org1.example.com-cert.pem 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 01f Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/cacerts 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 020 Inspecting file /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/cacerts/ca.org1.example.com-cert.pem 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 021 Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/admincerts 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 022 Inspecting file /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/admincerts/Admin@org1.example.com-cert.pem 2019-11-06 19:51:48.979 UTC [msp] getPemMaterialFromDir -> DEBU 023 Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/intermediatecerts 2019-11-06 19:51:48.980 UTC [msp] getMspConfig -> DEBU 024 Intermediate certs folder not found at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/intermediatecerts]. Skipping. [stat /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/intermediatecerts: no such file or directory] 2019-11-06 19:51:48.980 UTC [msp] getPemMaterialFromDir -> DEBU 025 Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/tlscacerts 2019-11-06 19:51:48.980 UTC [msp] getPemMaterialFromDir -> DEBU 026 Inspecting file /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/tlscacerts/tlsca.org1.example.com-cert.pem 2019-11-06 19:51:48.980 UTC [msp] getPemMaterialFromDir -> DEBU 027 Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/tlsintermediatecerts 2019-11-06 19:51:48.980 UTC [msp] getMspConfig -> DEBU 028 TLS intermediate certs folder not found at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/tlsintermediatecerts]. Skipping. [stat /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/tlsintermediatecerts: no such file or directory] 2019-11-06 19:51:48.980 UTC [msp] getPemMaterialFromDir -> DEBU 029 Reading directory /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/crls 2019-11-06 19:51:48.980 UTC [msp] getMspConfig -> DEBU 02a crls folder not found at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/crls]. Skipping. [stat /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/crls: no such file or directory] 2019-11-06 19:51:48.980 UTC [msp] getMspConfig -> DEBU 02b MSP configuration file not found at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/config.yaml]: [stat /shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/config.yaml: no such file or directory] 2019-11-06 19:51:48.980 UTC [msp] newBccspMsp -> DEBU 02c Creating BCCSP-based MSP instance 2019-11-06 19:51:48.980 UTC [msp] New -> DEBU 02d Creating Cache-MSP instance 2019-11-06 19:51:48.980 UTC [msp] loadLocaMSP -> DEBU 02e Created new local MSP 2019-11-06 19:51:48.980 UTC [msp] Setup -> DEBU 02f Setting up MSP instance Org1MSP 2019-11-06 19:51:48.981 UTC [msp.identity] newIdentity -> DEBU 030 Creating identity instance for cert -----BEGIN CERTIFICATE----- MIICUjCCAfigAwIBAgIRANyVR3QpqPbJCaDz/erVkmwwCgYIKoZIzj0EAwIwczEL MAkGA1UEBhMCVVMxEzARBgNVBAgTCkNhbGlmb3JuaWExFjAUBgNVBAcTDVNhbiBG cmFuY2lzY28xGTAXBgNVBAoTEG9yZzEuZXhhbXBsZS5jb20xHDAaBgNVBAMTE2Nh Lm9yZzEuZXhhbXBsZS5jb20wHhcNMTkxMTA2MTkzNTAwWhcNMjkxMTAzMTkzNTAw WjBzMQswCQYDVQQGEwJVUzETMBEGA1UECBMKQ2FsaWZvcm5pYTEWMBQGA1UEBxMN U2FuIEZyYW5jaXNjbzEZMBcGA1UEChMQb3JnMS5leGFtcGxlLmNvbTEcMBoGA1UE AxMTY2Eub3JnMS5leGFtcGxlLmNvbTBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IA BB2zxlNzqhcg3RNmxrF6VXFG7OieJptcf/c6NekCDKV35mFNR6XMrRpSchjDKYEA c5XbfqRkGJsPyugPaGJHtQSjbTBrMA4GA1UdDwEB/wQEAwIBpjAdBgNVHSUEFjAU BggrBgEFBQcDAgYIKwYBBQUHAwEwDwYDVR0TAQH/BAUwAwEB/zApBgNVHQ4EIgQg Fgs9TE8qMujnjaA2xCn7c1UIjHrpjkRav9iVHAjuZOYwCgYIKoZIzj0EAwIDSAAw RQIhAJeXdZ+c8Wex/y0MUhJWfx0pse6tG0WQ2/CvU2vHSz7VAiB9ZW7tO5BRXE4P LM2fqsP2oFV8U9jsfD9vdCvbZ74NgQ== -----END CERTIFICATE----- 2019-11-06 19:51:48.981 UTC [msp.identity] newIdentity -> DEBU 031 Creating identity instance for cert -----BEGIN CERTIFICATE----- MIICKjCCAdCgAwIBAgIQLqYwBNhwjGfgrJwNHHD7IzAKBggqhkjOPQQDAjBzMQsw CQYDVQQGEwJVUzETMBEGA1UECBMKQ2FsaWZvcm5pYTEWMBQGA1UEBxMNU2FuIEZy YW5jaXNjbzEZMBcGA1UEChMQb3JnMS5leGFtcGxlLmNvbTEcMBoGA1UEAxMTY2Eu b3JnMS5leGFtcGxlLmNvbTAeFw0xOTExMDYxOTM1MDBaFw0yOTExMDMxOTM1MDBa MGwxCzAJBgNVBAYTAlVTMRMwEQYDVQQIEwpDYWxpZm9ybmlhMRYwFAYDVQQHEw1T YW4gRnJhbmNpc2NvMQ8wDQYDVQQLEwZjbGllbnQxHzAdBgNVBAMMFkFkbWluQG9y ZzEuZXhhbXBsZS5jb20wWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAATicxSghPQA ZDNTttowpUueq+lJDQWwue+alt3PDULR3md1tqqAx6QiLXQUwe9sWZe1iFOF0eh2 9zjz5ElzVxVgo00wSzAOBgNVHQ8BAf8EBAMCB4AwDAYDVR0TAQH/BAIwADArBgNV HSMEJDAigCAWCz1MTyoy6OeNoDbEKftzVQiMeumORFq/2JUcCO5k5jAKBggqhkjO PQQDAgNIADBFAiEA41NKwNHYUKgMV54EkG0z0iSUcocspSfSbMFIy1aupWsCICVG 9YnFSRaiTNbmIIgZXBm+PTBeEp/3B+MEjKHn3Lcv -----END CERTIFICATE----- 2019-11-06 19:51:48.997 UTC [msp.identity] newIdentity -> DEBU 032 Creating identity instance for cert -----BEGIN CERTIFICATE----- MIICKjCCAdCgAwIBAgIQLqYwBNhwjGfgrJwNHHD7IzAKBggqhkjOPQQDAjBzMQsw CQYDVQQGEwJVUzETMBEGA1UECBMKQ2FsaWZvcm5pYTEWMBQGA1UEBxMNU2FuIEZy YW5jaXNjbzEZMBcGA1UEChMQb3JnMS5leGFtcGxlLmNvbTEcMBoGA1UEAxMTY2Eu b3JnMS5leGFtcGxlLmNvbTAeFw0xOTExMDYxOTM1MDBaFw0yOTExMDMxOTM1MDBa MGwxCzAJBgNVBAYTAlVTMRMwEQYDVQQIEwpDYWxpZm9ybmlhMRYwFAYDVQQHEw1T YW4gRnJhbmNpc2NvMQ8wDQYDVQQLEwZjbGllbnQxHzAdBgNVBAMMFkFkbWluQG9y ZzEuZXhhbXBsZS5jb20wWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAATicxSghPQA ZDNTttowpUueq+lJDQWwue+alt3PDULR3md1tqqAx6QiLXQUwe9sWZe1iFOF0eh2 9zjz5ElzVxVgo00wSzAOBgNVHQ8BAf8EBAMCB4AwDAYDVR0TAQH/BAIwADArBgNV HSMEJDAigCAWCz1MTyoy6OeNoDbEKftzVQiMeumORFq/2JUcCO5k5jAKBggqhkjO PQQDAgNIADBFAiEA41NKwNHYUKgMV54EkG0z0iSUcocspSfSbMFIy1aupWsCICVG 9YnFSRaiTNbmIIgZXBm+PTBeEp/3B+MEjKHn3Lcv -----END CERTIFICATE----- 2019-11-06 19:51:48.997 UTC [bccsp_sw] loadPrivateKey -> DEBU 033 Loading private key [0be74596686ea1198bc0124bb813a4e5504c49e2c9507284cb9a246f94dbedc7] at [/shared/artifacts/crypto-config/peerOrganizations/org1.example.com/users/Admin@org1.example.com/msp/keystore/0be74596686ea1198bc0124bb813a4e5504c49e2c9507284cb9a246f94dbedc7_sk]... 2019-11-06 19:51:48.997 UTC [msp.identity] newIdentity -> DEBU 034 Creating identity instance for cert -----BEGIN CERTIFICATE----- MIICKjCCAdCgAwIBAgIQLqYwBNhwjGfgrJwNHHD7IzAKBggqhkjOPQQDAjBzMQsw CQYDVQQGEwJVUzETMBEGA1UECBMKQ2FsaWZvcm5pYTEWMBQGA1UEBxMNU2FuIEZy YW5jaXNjbzEZMBcGA1UEChMQb3JnMS5leGFtcGxlLmNvbTEcMBoGA1UEAxMTY2Eu b3JnMS5leGFtcGxlLmNvbTAeFw0xOTExMDYxOTM1MDBaFw0yOTExMDMxOTM1MDBa MGwxCzAJBgNVBAYTAlVTMRMwEQYDVQQIEwpDYWxpZm9ybmlhMRYwFAYDVQQHEw1T YW4gRnJhbmNpc2NvMQ8wDQYDVQQLEwZjbGllbnQxHzAdBgNVBAMMFkFkbWluQG9y ZzEuZXhhbXBsZS5jb20wWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAATicxSghPQA ZDNTttowpUueq+lJDQWwue+alt3PDULR3md1tqqAx6QiLXQUwe9sWZe1iFOF0eh2 9zjz5ElzVxVgo00wSzAOBgNVHQ8BAf8EBAMCB4AwDAYDVR0TAQH/BAIwADArBgNV HSMEJDAigCAWCz1MTyoy6OeNoDbEKftzVQiMeumORFq/2JUcCO5k5jAKBggqhkjO PQQDAgNIADBFAiEA41NKwNHYUKgMV54EkG0z0iSUcocspSfSbMFIy1aupWsCICVG 9YnFSRaiTNbmIIgZXBm+PTBeEp/3B+MEjKHn3Lcv -----END CERTIFICATE----- 2019-11-06 19:51:48.998 UTC [msp] setupSigningIdentity -> DEBU 035 Signing identity expires at 2029-11-03 19:35:00 +0000 UTC 2019-11-06 19:51:48.998 UTC [msp] Validate -> DEBU 036 MSP Org1MSP validating identity 2019-11-06 19:51:48.999 UTC [msp] GetDefaultSigningIdentity -> DEBU 037 Obtaining default signing identity 2019-11-06 19:51:48.999 UTC [grpc] DialContext -> DEBU 038 parsed scheme: "" 2019-11-06 19:51:49.000 UTC [grpc] DialContext -> DEBU 039 scheme "" not registered, fallback to default scheme 2019-11-06 19:51:49.000 UTC [grpc] watcher -> DEBU 03a ccResolverWrapper: sending new addresses to cc: [{org1peer1:30110 0 }] 2019-11-06 19:51:49.000 UTC [grpc] switchBalancer -> DEBU 03b ClientConn switching balancer to "pick_first" 2019-11-06 19:51:49.000 UTC [grpc] HandleSubConnStateChange -> DEBU 03c pickfirstBalancer: HandleSubConnStateChange: 0xc0002e25f0, CONNECTING 2019-11-06 19:51:49.002 UTC [grpc] HandleSubConnStateChange -> DEBU 03d pickfirstBalancer: HandleSubConnStateChange: 0xc0002e25f0, READY 2019-11-06 19:51:49.002 UTC [channelCmd] InitCmdFactory -> INFO 03e Endorser and orderer connections initialized 2019-11-06 19:51:49.003 UTC [msp.identity] Sign -> DEBU 03f Sign: plaintext: 0AB3070A5B08011A0B08D5C88CEE0510...660A7AC930A61A080A000A000A000A00 2019-11-06 19:51:49.003 UTC [msp.identity] Sign -> DEBU 040 Sign: digest: 71D7C24815D1838A3559307FA34809FDD860E3128F01616A049690A4B7240640 2019-11-06 19:51:49.097 UTC [grpc] infof -> DEBU 041 transport: loopyWriter.run returning. connection error: desc = "transport is closing" 2019-11-06 19:51:49.097 UTC [grpc] HandleSubConnStateChange -> DEBU 042 pickfirstBalancer: HandleSubConnStateChange: 0xc0002e25f0, TRANSIENT_FAILURE 2019-11-06 19:51:49.097 UTC [grpc] HandleSubConnStateChange -> DEBU 043 pickfirstBalancer: HandleSubConnStateChange: 0xc0002e25f0, CONNECTING Error: proposal failed (err: rpc error: code = Unavailable desc = transport is closing)