cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
Announcements

Community Helping Community

233
Views
2
Helpful
5
Replies
Highlighted
Enthusiast

TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

Hello,

I am trying export code from AiO to real hardware and software (c2911,

Cisco IOS Software, C2900 Software (C2900-UNIVERSALK9-M), Version 15.4(AVC_20130910)T, EARLY DEPLOYMENT DEVELOPMENT BUILD, synced to  V153_3_M0_2).

After successfully authorized via TLS to router I tried create ACL and insert ACE to created ACL, but device/(something else) on application side raises exception TTransportException: TSocket read 0 bytes.

On controller side I use AiO image....

debug onep

How to fix it?

*Mar  4 20:22:06.082: [261] [ONEP][Session]: ONEP TLS done accept_fd: 2, pid: 261, context: 212CB210 [onep_al_tls_accept:241]

*Mar  4 20:22:06.786: [261] [ONEP][Message]: Server Done tos 1 [cthrift_recv_main__:2439]

*Mar  4 20:22:06.786: [261] [ONEP][Session]: Gosia-10.10.10.241: Connecting attempt: timeout[0] shandle[0] fd[2] addr[10.10.10.230] port[56448] transport[onep tls server] [NetworkElement_connectIDL:378]

*Mar  4 20:22:06.786: [261] [ONEP][AAA]: Authenticating ONEP Session for appname Gosia [onep_al_aaa_session_authenticate:1472]

*Mar  4 20:22:06.786: [261] [ONEP][AAA]: AAA is not configured, using local database [onep_al_aaa_session_authenticate:1476]

*Mar  4 20:22:06.790: [261] [ONEP][AAA]: Authentication using local database: SUCCESS [onep_al_aaa_session_authenticate:1480]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241: Authentication succeeded for user cisco1 [NetworkElement_connectIDL:390]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Searching for application with AID Gosia-10.10.10.241 resulted in No App Found [NetworkElement_connectIDL:441]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241: FSM: [Disconnected] ==> [Connecting] remote_addr[10.10.10.230] port[56448] [network_app_fsm_connecting:2734]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Fail to find handle [2362] [network_element_find_app_by_handle:548]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Fail to find handle [2362] [network_element_find_app_by_handle:548]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] added [network_element_add_app_internal:383]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: Connecting with handle [0x93A] at Tue Mar 04 20:22:06.790 [network_app_fsm_connecting:2761]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: FSM: [Connecting] ==> [Authenticated] remote_addr[10.10.10.230] port[56448] [network_app_fsm_authenticated:2891]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: entering ... [create_application_process:1977]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: stack size changed from =6000 bytes, to =200% of normal [create_application_process:2036]

*Mar  4 20:22:06.790: [284] [ONEP][Server]: app name Gosia session handle 0x93A [network_application_xdm_init:2277]

*Mar  4 20:22:06.790: [284] [ONEP][Session]: Gosia: attach async stats return retval 0 Unknown error 0 [network_application_xdm_init:2341]

*Mar  4 20:22:06.790: [284] [ONEP][Session]: Gosia: attach timer return retval 0 Unknown error 0 [network_application_xdm_init:2347]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: TLS dup old <2, 261>, new<0, 284> [onep_al_tls_dup:287]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: Cloned fd 2 -> 0 [ne_to_app_fd_clone:2098]

*Mar  4 20:22:06.790: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: cthrift_rb @0x212B08AC status = 0x8 [NetworkElement_connectIDL:685]

*Mar  4 20:22:06.790: [261] [ONEP][Message]: Write cthrift buffer to socket 2: bytes 507 [cthrift_write_entire_buffer__:319]

*Mar  4 20:22:06.790: [261] [ONEP][Message]: cthrift wrote 507 bytes, 0 remaining to send, took 0 usec [cthrift_write_entire_buffer__:392]

*Mar  4 20:22:06.794: [261] [ONEP][Session]: ONEP TLS close fd: 2, pid: 261 [onep_al_tls_close:227]

*Mar  4 20:22:07.494: [261] [ONEP][Session]: ONEP TLS done accept_fd: 2, pid: 261, context: 3D202B84 [onep_al_tls_accept:241]

*Mar  4 20:22:08.394: [261] [ONEP][Message]: Server Done tos 1 [cthrift_recv_main__:2439]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: Event channel fd[2] [NetworkElement_evtChannelIDL:790]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: TLS dup old <2, 261>, new<1, 284> [onep_al_tls_dup:287]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: Cloned fd 2 -> 1 [ne_to_app_fd_clone:2098]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: FSM: [Authenticated] ==> [Connected] remote_addr[10.10.10.230] port[56449] [network_app_fsm_connected:2980]

*Mar  4 20:22:08.394: [261] [ONEP][Server]: entering ... [onep_ha_ctx_store:241]

*Mar  4 20:22:08.394: [261] [ONEP][Server]: service=0, table=0, session handle (key)=0x93A cidl_onep_ha_netapp_ctx_size_hint: 2178 [onep_ha_ctx_store:248]

*Mar  4 20:22:08.394: [261] [ONEP][Server]: stored app name Gosia session handle 0x93A [onep_ha_ctx_store:259]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: Connected with handle [93A] at Tue Mar 04 20:22:08.394 [network_app_fsm_connected:3020]

*Mar  4 20:22:08.394: [261] [ONEP][Message]: Write cthrift buffer to socket 2: bytes 48 [cthrift_write_entire_buffer__:319]

*Mar  4 20:22:08.394: [261] [ONEP][Message]: cthrift wrote 48 bytes, 0 remaining to send, took 0 usec [cthrift_write_entire_buffer__:392]

*Mar  4 20:22:08.394: [261] [ONEP][Session]: ONEP TLS close fd: 2, pid: 261 [onep_al_tls_close:227]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Starting keepalive timer for 60 secs [network_application_process:1718]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: session_init [onep_session_manager_session_init:299]

*Mar  4 20:22:08.394: [284] [ONEP][Event]: Session init for handle 2362 [onep_async_session_init:946]

*Mar  4 20:22:08.394: [284] [ONEP][Event]: store async session handle=2362 successfully [onep_event_async_session_store:1554]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Async session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][Event]: SESSION_INIT: session handle 2362 [onep_event_session_init:1036]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:08.394: [284] [ONEP][Event]: init new context pid 284 handle: 2362 [fh_first_time_init:639]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Event session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][Policy]: Async thread already created [create_async_policy_thread:669]

*Mar  4 20:22:08.394: [284] [ONEP][Policy]: Binding to XOS for client 2362 [policy_bulk_session_init:289]

*Mar  4 20:22:08.394: [284] [ONEP][Policy]: Binding to XOS - xos_async_wait retured successfully [policy_bulk_session_init:304]

*Mar  4 20:22:08.394: [284] [ONEP][Policy]: Unknown error 0 in bind_result.status [policy_bulk_session_init:316]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:08.394: [284] [ONEP][Policy]: Session init 2362 [onep_policy_session_init:483]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Policy session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][VTY]: onep_vty_session_init: Session init 2362l [onep_vty_session_init:2073]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: VTY session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Topology session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][MEDIATRACE]: ONEP Mediatrace: Ignoring session init

[onep_pathtrace_event_session_init:795]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Mediatrace session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.394: [284] [ONEP][ROUTING]: ONEP Routing: Session init sh: 2362 [onep_rtg_svc_session_init:129]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:08.394: [284] [ONEP][ROUTING]: session_init, rtg_client_handle 0 [onep_rtg_svc_session_init:136]

*Mar  4 20:22:08.394: [284] [ONEP][ROUTING]: ONEP Routing: Session init sh: 2362, app: 0x212C70C0 [onep_rtg_svc_session_init:152]

*Mar  4 20:22:08.394: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Routing session_init done [onep_session_manager_session_init:310]

*Mar  4 20:22:08.410: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Session event [0x1] occured [network_app_session_handler:1432]

*Mar  4 20:22:08.410: [284] [ONEP][Session]: TLS reset ioref fd: 0 [onep_tls_reset_ioref:210]

*Mar  4 20:22:08.410: [284] [ONEP][Session]: TLS reset ioref fd: 1 [onep_tls_reset_ioref:210]

*Mar  4 20:22:08.810: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Session event [0x1] occured [network_app_session_handler:1432]

*Mar  4 20:22:08.810: [284] [ONEP][Message]: Server Done tos 1 [cthrift_recv_main__:2439]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: Received createAcl t=1 AF=1 l=0 [onep_create_acl:5468]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: REGULAR ACL

[onep_create_acl:5492]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: Create ACE List and Interface List for the ACL.

[onep_create_acl:5510]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: L3 ACL name=onep-acl-10 AF=1 [onep_al_acl_create_l3_acl:147]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: Transient L3 ACL name=onep-acl-10 [onep_al_acl_create_l3_acl:152]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: L3 ACL created=onep-acl-10 [onep_al_acl_create_l3_acl:202]

*Mar  4 20:22:08.810: [284] [ONEP][Policy]: Created ACL aH=10 [onep_create_acl:5561]

*Mar  4 20:22:08.810: [284] [ONEP][Message]: Write cthrift buffer to socket 0: bytes 33 [cthrift_write_entire_buffer__:319]

*Mar  4 20:22:08.810: [284] [ONEP][Message]: cthrift wrote 33 bytes, 0 remaining to send, took 0 usec [cthrift_write_entire_buffer__:392]

*Mar  4 20:22:08.810: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: API served - done [network_app_process_cthrift_msg:1367]

*Mar  4 20:22:08.814: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Session event [0x1] occured [network_app_session_handler:1432]

*Mar  4 20:22:09.014: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Session event [0x1] occured [network_app_session_handler:1432]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: cthrift error: -65551 'invalid type' [na_rx_fsm_do_cthrift_read:1147]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: NA_RX_FSM_STATE_READ error (1) - generating NA_RX_FSM_STATE_CLEANUP [network_app_process_cthrift_msg:1323]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: NA_RX_FSM_STATE_CLEANUP - generating NETWORK_APP_STATE_DISCONNECTED [network_app_process_cthrift_msg:1371]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: FSM: [Connected] ==> [Disconnected] remote_addr[10.10.10.230] port[56448] [network_app_fsm_disconnected:3126]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Disconnected with handle [93A] at Tue Mar 04 20:22:09.218 [network_app_fsm_disconnected:3238]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: caller pc 0x0x3288A714 [network_application_final_cleanup:2495]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: session_exit [onep_session_manager_session_exit:373]

*Mar  4 20:22:09.218: [284] [ONEP][Event]: Session exit for handle 2362 [onep_async_session_exit:981]

*Mar  4 20:22:09.218: [284] [ONEP][Event]: delete async tbl elem session handle= 2362 successfully [onep_event_async_session_remove:1575]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Async session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.218: [284] [ONEP][Event]: SESSION_EXIT: session handle 2362 [onep_event_session_exit:1058]

*Mar  4 20:22:09.218: [284] [ONEP][Event]: get by session_handle looking for: 2362 [fh_get_ctx_block_by_session_handle:275]

*Mar  4 20:22:09.218: [284] [ONEP][Event]: get by session_handle found: 2362 [fh_get_ctx_block_by_session_handle:278]

*Mar  4 20:22:09.218: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Event session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Session exit 2362 [onep_policy_session_exit:504]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Deleting Classes [onep_al_policy_delete_all_classes:424]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: No policy created [onep_al_policy_delete_all_policies:164]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Deleting ACLs [onep_al_acl_delete_all_acls:230]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Deleting ACL=10 [onep_al_acl_delete_all_acls:235]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Delete ACL onep-acl-10 [onep_al_acl_delete_all_acls:249]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Transient L3 ACL name=onep-acl-10 [onep_al_acl_delete_l3_acl:247]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Deleted ACL onep-acl-10 [onep_al_acl_delete_all_acls:292]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: Deleting ACEs [onep_al_acl_delete_all_acls:302]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: @@@calling xos_plc_unbind id : 11 [policy_bulk_session_cleanup:367]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: @@@policy_bulk_get_client_handle: 11 [policy_bulk_get_client_handle:122]

*Mar  4 20:22:09.218: [284] [ONEP][Policy]: @@@unbind is successful [policy_bulk_session_cleanup:373]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Policy session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [284] [ONEP][VTY]: Session exit 2362l [onep_vty_session_exit:2089]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: VTY session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Topology session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [284] [ONEP][MEDIATRACE]: ONEP Mediatrace: session exit

[onep_pathtrace_event_session_exit:809]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Mediatrace session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [284] [ONEP][ROUTING]: ONEP Routing: session exit sh: 2362 [onep_rtg_svc_session_exit:166]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] found [network_element_find_app_by_handle:543]

*Mar  4 20:22:09.222: [284] [ONEP][ROUTING]: session exit: app handle 0, rtg_session_id 0, session_handle 2362 [onep_rtg_svc_session_exit:177]

*Mar  4 20:22:09.222: [284] [ONEP][ROUTING]: ONEP Routing: session exit sh: 2362 app: 0x212C70C0 [onep_rtg_svc_session_exit:196]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Routing session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [284] [ONEP][DATAPATH]: Subblock is NULL for session - 2362 [onep_datapath_session_exit:63]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Datapath session_exit done [onep_session_manager_session_exit:390]

*Mar  4 20:22:09.222: [261] [ONEP][Session]: Gosia-10.10.10.241-2362: [0x212C70C0][93A] removed [network_element_remove_app_cb:226]

*Mar  4 20:22:09.222: [261] [ONEP][Server]: service=0, table=0, session handle (key)=0x93A [onep_ha_ctx_remove:271]

*Mar  4 20:22:09.222: [261] [ONEP][Server]: removed app name Gosia session handle 0x93A [onep_ha_ctx_remove:282]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: session_update thread [-1] [onep_session_manager_session_update:333]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Fail to find handle [2362] [network_element_find_app_by_handle:548]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: session_update fail [2362] [onep_session_manager_session_update:341]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: ONEP TLS close fd: 1, pid: 284 [onep_al_tls_close:227]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: IOS: close_ctxt_fd [close_ctxt_fd:61]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: ONEP TLS close fd: 0, pid: 284 [onep_al_tls_close:227]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: IOS: close_ctxt_fd [close_ctxt_fd:61]

*Mar  4 20:22:09.222: [284] [ONEP][Session]: Gosia-10.10.10.241-2362: Session history archived, Count = 11 [onep_app_history_archive:271]

Everyone's tags (3)
1 ACCEPTED SOLUTION

Accepted Solutions
Enthusiast

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

5 REPLIES 5
Enthusiast

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

I will try it in with ACL tutorial...

Enthusiast

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

Hall of Fame Cisco Employee

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

Yes.  You need a crypto image for TLS now.  The NPE stands for "no payload encryption," which is a problem for TLS.

Enthusiast

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

But I really don't understand how to is possible do something like create ACE, but is not possible create ACL (or something like that)?

Hall of Fame Cisco Employee

Re: TTransportException, Unknown error 0 in bind_result.status [policy_bulk_session_init]

Creating an ACE doesn't need an RPC.  You can do that entirely in the client API until you try and push the ACL (with the ACE) back to the device.

Content for Community-Ad
FusionCharts will render here
This widget could not be displayed.