2022-10-27 16:46:28:WEBLIB:process_request:Response string(length = 16) = "{"error_code":0}"
2022-10-27 16:46:41:WEBLIB:process_request:Request string(length = 58) = "{"func_name":"get_list_info","params":{"cryptoType":null}}"
2022-10-27 16:46:41:IFC:ifc_get_list_info:STARTED
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [0]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:STARTED
2022-10-27 16:46:41:IFC:list_keys_pkcs11:pkcs11_lib is '/opt/cprocsp/lib/amd64/libcppkcs11.so', i_keys is not set
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:STARTED
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:module path: /opt/cprocsp/lib/amd64/libcppkcs11.so
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:cached PKCS#11 library found
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:C_Initialize already initialized
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:result [0]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:slots count: [1]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:STARTED
2022-10-27 16:46:41:IFC:get_slot_and_token_info:GetSlotInfo [0]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Slot description: "\CryptoPro Slot"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:C_GetTokenInfo [0]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Token Serial Number: "0000000000000000"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Token Model: "CPPKCS 3"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:result [0]
2022-10-27 16:46:41:IFC:check_token_support:STARTED
2022-10-27 16:46:41:IFC:check_token_support:result [0]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [1]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'Crypto-Pro GOST R 34.10-2001 Cryptographic Service Provider', provider type is '75' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider Crypto-Pro GOST R 34.10-2001 Cryptographic Service Provider type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [2]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'GOST R 34.10-2001 Rutoken CSP', provider type is '75' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider GOST R 34.10-2001 Rutoken CSP type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [3]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'Signal-COM CPGOST Cryptographic Provider', provider type is '75' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider Signal-COM CPGOST Cryptographic Provider type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [4]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'Signal-COM GOST R 34.10-2012 (256) Cryptographic Provider', provider type is '80' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider Signal-COM GOST R 34.10-2012 (256) Cryptographic Provider type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [5]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'Signal-COM GOST R 34.10-2012 (512) Cryptographic Provider', provider type is '81' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider Signal-COM GOST R 34.10-2012 (512) Cryptographic Provider type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [6]
2022-10-27 16:46:41:IFC:list_keys_capi:STARTED
2022-10-27 16:46:41:IFC:list_keys_capi:provider name is 'LISSI-CSP', provider type is '75' i_keys is not set
2022-10-27 16:46:41:IFC:list_keys_capi:Provider LISSI-CSP type capi was not acquired. The requested provider does not exist.
2022-10-27 16:46:41:IFC:list_keys_capi:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [7]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:STARTED
2022-10-27 16:46:41:IFC:list_keys_pkcs11:pkcs11_lib is 'libjcPKCS11-2.so.2.4.0', i_keys is not set
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:STARTED
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:module path: libjcPKCS11-2.so.2.4.0
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:No cached library found. Trying to load the new one
2022-10-27 16:46:41:IFC:unix_load_pkcs11_lib:STARTED
2022-10-27 16:46:41:IFC:unix_load_pkcs11_lib:p11_module_path: libjcPKCS11-2.so.2.4.0
2022-10-27 16:46:41:IFC:unix_load_pkcs11_lib:ERROR:dlopen fail:pkcs11_specific.c:144
2022-10-27 16:46:41:IFC:unix_load_pkcs11_lib:result [22]
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:ERROR:load_pkcs11_lib failed:engine.c:56
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:result [22]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:ERROR:ifc_load_pkcs11_lib error: 22:list.c:414
2022-10-27 16:46:41:IFC:list_keys_pkcs11:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:config record [8]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:STARTED
2022-10-27 16:46:41:IFC:list_keys_pkcs11:pkcs11_lib is 'librtpkcs11ecp.so', i_keys is not set
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:STARTED
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:module path: librtpkcs11ecp.so
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:cached PKCS#11 library found
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:C_Initialize already initialized
2022-10-27 16:46:41:IFC:ifc_load_pkcs11_lib:result [0]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:slots count: [1]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:STARTED
2022-10-27 16:46:41:IFC:get_slot_and_token_info:GetSlotInfo [0]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Slot description: "Aktiv Rutoken lite 00 00"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:C_GetTokenInfo [0]
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Token Serial Number: "2edc7006"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:Token Model: "Rutoken lite"
2022-10-27 16:46:41:IFC:get_slot_and_token_info:result [0]
2022-10-27 16:46:41:IFC:check_token_support:STARTED
2022-10-27 16:46:41:IFC:check_token_support:result [17]
2022-10-27 16:46:41:IFC:list_keys_pkcs11:Token is not supported -> skip it
2022-10-27 16:46:41:IFC:list_keys_pkcs11:result [0]
2022-10-27 16:46:41:IFC:ifc_get_list_info:result [0]
2022-10-27 16:46:41:WEBLIB:process_request:Response string(length = 291) = "{"error_code":0,"ifc_list":[{"alg":"gost2001","alias":"cprocsp","description":"\\CryptoPro Slot","model":"CPPKCS 3","name":"CryptoPro CSP","num":"0","path":"/opt/cprocsp/lib/amd64/libcppkcs11.so","serial_number":"0000000000000000","skip_pkcs11_list":"","type":"pkcs11"}],"ifc_list_length":1}"
2022-10-27 16:46:41:WEBLIB:process_request:Request string(length = 178) = "{"func_name":"sign","params":{"containerId":"cprocsp/0/F4C5CB2A0066210A","userPin":"********","inDataType":1,"data":"******","hashType":1,"signType":3,"cspUI":1,"outDataType":1}}"
2022-10-27 16:46:41:IFC:ifc_sign:STARTED
2022-10-27 16:46:41:IFC:ifc_sign:data type: 1, signature type: 3, encode_to_base64: 1
2022-10-27 16:46:41:IFC:ifc_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:p11 lib name: /opt/cprocsp/lib/amd64/libcppkcs11.so, slot: 0, engine lib name: pkcs11_engine
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:cached crypto slot found
2022-10-27 16:46:41:IFC:pkcs11_engine_login:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_login:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_login:PASSED
2022-10-27 16:46:41:IFC:pkcs11_engine_login:pkcs11 login was proceeded
2022-10-27 16:46:41:IFC:pkcs11_engine_login:result [0]
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:result [0]
2022-10-27 16:46:41:IFC:ifc_engine:result [0]
2022-10-27 16:46:41:IFC:do_work_sign_cms:STARTED
2022-10-27 16:46:41:IFC:ifc_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:p11 lib name: /opt/cprocsp/lib/amd64/libcppkcs11.so, slot: 0, engine lib name: pkcs11_engine
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:cached crypto slot found
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:result [0]
2022-10-27 16:46:41:IFC:ifc_engine:result [0]
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:STARTED
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:ID to find: F4C5CB2A0066210A
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_start:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_start:PASSED
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:STORE_list_certificate_start done
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_next:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_object_to_return:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_x509_by_handle:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_x509_by_handle:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_object_to_return:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_next:PASSED
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:STORE_list_certificate_next done
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_end:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_end:PASSED
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:STORE_list_certificate_end done
2022-10-27 16:46:41:IFC:find_cert_in_store_by_id:result [found cert handle]
2022-10-27 16:46:41:IFC:get_priv_key_by_id:STARTED
2022-10-27 16:46:41:IFC:get_priv_key_by_id:ID to find: F4C5CB2A0066210A
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_start:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_start:PASSED
2022-10-27 16:46:41:IFC:get_priv_key_by_id:STORE_list_private_key_start done
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_next:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_object_to_return:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_pkey_by_priv_key_handle:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_pub_key_value_and_sign_oid_and_hash_oid_by_id:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_object_handle_by_id:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_object_handle_by_id:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_pub_key_value_and_sign_oid_and_hash_oid_by_handle:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_pub_key_value_and_sign_oid_and_hash_oid_by_handle:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:get_pub_key_value_and_sign_oid_and_hash_oid_by_id:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_pkey_by_priv_key_handle:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_object_to_return:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_next:PASSED
2022-10-27 16:46:41:IFC:get_priv_key_by_id:STORE_list_private_key_next done
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_end:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_store_list_end:PASSED
2022-10-27 16:46:41:IFC:get_priv_key_by_id:STORE_list_private_key_end done
2022-10-27 16:46:41:IFC:get_priv_key_by_id:result [found key handle]
2022-10-27 16:46:41:IFC:make_cms:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:pub_decode_gost01:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:decode_gost_algor_params:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:decode_gost_algor_params:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:pub_decode_gost01:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_init:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_init:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:
>>>Digest update data
34 30 39 36 31 34
<<<Digest update data
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_copy:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_copy:FROM ctx 0x13f5010 -> TO ctx 0x7ffefffaa150
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_init:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_init:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:
>>>Digest update data
34 30 39 36 31 34
<<<Digest update data
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_update:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_copy:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_final_2012_256:STARTED ctx = 0x7ffefffaa150
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_final_2012_256:ERROR:C_DigestInit failed - CKR_MECHANISM_PARAM_INVALID:gost_md.c:421
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_final_2012_256:FAILED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_cleanup:STARTED ctx = 0x7ffefffaa150
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_cleanup:PASSED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_cleanup:STARTED ctx = 0x13f5010
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:gost_digest_cleanup:PASSED
2022-10-27 16:46:41:IFC:make_cms:ERROR:CMS_final failed:sign_cms.c:548
2022-10-27 16:46:41:IFC:make_cms:result [NULL]
2022-10-27 16:46:41:IFC:do_work_sign_cms:ERROR:make_cms error:sign_cms.c:379
2022-10-27 16:46:41:IFC:do_work_sign_cms:result [1]
2022-10-27 16:46:41:IFC:ifc_p11_logout:STARTED
2022-10-27 16:46:41:IFC:ifc_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:STARTED
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:p11 lib name: /opt/cprocsp/lib/amd64/libcppkcs11.so, slot: 0, engine lib name: pkcs11_engine
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:cached crypto slot found
2022-10-27 16:46:41:IFC:ifc_init_pkcs11_engine:result [0]
2022-10-27 16:46:41:IFC:ifc_engine:result [0]
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_logout:STARTED
2022-10-27 16:46:41:pkcs11_engine-cprocsp-0:make_logout:PASSED
2022-10-27 16:46:41:IFC:ifc_p11_logout:result [0]
2022-10-27 16:46:41:IFC:ifc_sign:result [1]
2022-10-27 16:46:41:WEBLIB:process_request:Response string(length = 16) = "{"error_code":1}"