Nov 14 22:31:21 22:31:03.451480:CID-2:RT:<10.200.1.96/9195->10.100.200.13/1;1> matched filter f0: Nov 14 22:31:21 22:31:03.451480:CID-2:RT:packet [60] ipid = 30952, @423c551c Nov 14 22:31:21 22:31:03.451480:CID-2:RT:---- flow_process_pkt: (thd 2): flow_ctxt type 14, common flag 0x0, mbuf 0x423c5300, rtbl_idx = 0 Nov 14 22:31:21 22:31:03.451480:CID-2:RT: flow process pak fast ifl 68 in_ifp reth2.0 Nov 14 22:31:21 22:31:03.451480:CID-2:RT: reth2.0:10.200.1.96->10.100.200.13, icmp, (8/0) Nov 14 22:31:21 22:31:03.451480:CID-2:RT: find flow: table 0x495baf60, hash 12655(0xffff), sa 10.200.1.96, da 10.100.200.13, sp 9195, dp 1, proto 1, tok 6 Nov 14 22:31:21 22:31:03.451480:CID-2:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Nov 14 22:31:21 22:31:03.451480:CID-2:RT: flow_first_create_session Nov 14 22:31:21 22:31:03.451480:CID-2:RT: flow_first_in_dst_nat: in , out dst_adr 10.100.200.13, sp 9195, dp 1 Nov 14 22:31:21 22:31:03.451480:CID-2:RT: chose interface reth2.0 as incoming nat if. Nov 14 22:31:21 22:31:03.451480:CID-2:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 10.100.200.13(1) Nov 14 22:31:21 22:31:03.451480:CID-2:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 10.200.1.96, x_dst_ip 10.100.200.13, in ifp reth2.0, out ifp N/A sp 9195, dp 1, ip_proto 1, tos 0 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:Doing DESTINATION addr route-lookup Nov 14 22:31:21 22:31:03.451821:CID-2:RT: routed (x_dst_ip 10.100.200.13) from trust (reth2.0 in 1) to reth15.0, Next-hop: 91.213.133.14 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: policy search from zone trust-> zone untrust (0x0,0x23eb0001,0x1) Nov 14 22:31:21 22:31:03.451821:CID-2:RT: app 0, timeout 60s, curr ageout 60s Nov 14 22:31:21 22:31:03.451821:CID-2:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Nov 14 22:31:21 22:31:03.451821:CID-2:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/0, pst_nat: False. Nov 14 22:31:21 22:31:03.451821:CID-2:RT: dip id = 0/0, 10.200.1.96/9195->10.200.1.96/9195 protocol 0 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:flow_first_get_out_ifp: IN! Nov 14 22:31:21 22:31:03.451821:CID-2:RT: choose interface reth15.0 as outgoing phy if Nov 14 22:31:21 22:31:03.451821:CID-2:RT:is_loop_pak: No loop: on ifp: reth15.0, addr: 10.100.200.13, rtt_idx:0 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth15.0 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: vsd 1 is active Nov 14 22:31:21 22:31:03.451821:CID-2:RT:jsf sess interest check. regd plugins 19 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: Allocating plugin info block for 20 plugin(s) from OL Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 7, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:+++++++++++jsf_test_plugin_data_evh: 3 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 15, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 2 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:-jsf int check: plugin id 19, svc_req 0x0. rc 4 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: No JSF plugins enabled for session Nov 14 22:31:21 22:31:03.451821:CID-2:RT: Releasing plugin info block for 20 plugin(s) to OL Nov 14 22:31:21 22:31:03.451821:CID-2:RT:flow_first_service_lookup(): natp(0x4f2bcf90): app_id, 0(0). Nov 14 22:31:21 22:31:03.451821:CID-2:RT: service lookup identified service 0. Nov 14 22:31:21 22:31:03.451821:CID-2:RT: flow_first_final_check: in , out Nov 14 22:31:21 22:31:03.451821:CID-2:RT:flow_first_complete_session, pak_ptr: 0x3fcecc90, nsp: 0x4f2bcf90, in_tunnel: 0x0 Nov 14 22:31:21 22:31:03.451821:CID-2:RT:construct v4 vector for nsp2 Nov 14 22:31:21 22:31:03.451821:CID-2:RT: existing vector list 220-458e2610. Nov 14 22:31:21 22:31:03.451821:CID-2:RT: Session (id:101291) created for first pak 220 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: flow_first_install_session======> 0x4f2bcf90 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: nsp 0x4f2bcf90, nsp2 0x4f2bd010 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: make_nsp_ready_no_resolve() Nov 14 22:31:21 22:31:03.452321:CID-2:RT: route lookup: dest-ip 10.200.1.96 orig ifp reth2.0 output_ifp reth2.0 orig-zone 6 out-zone 6 vsd 1 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: route to 10.200.1.96 Nov 14 22:31:21 22:31:03.452321:CID-2:RT:Installing c2s NP session wing Nov 14 22:31:21 22:31:03.452321:CID-2:RT:Installing s2c NP session wing Nov 14 22:31:21 22:31:03.452321:CID-2:RT: flow got session. Nov 14 22:31:21 22:31:03.452321:CID-2:RT: flow session id 101291 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: vector bits 0x220 vector 0x458e2610 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: vsd 1 is active Nov 14 22:31:21 22:31:03.452321:CID-2:RT:mbuf 0x423c5300, exit nh 0x5e23c2 Nov 14 22:31:21 22:31:03.452321:CID-2:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Nov 14 22:31:26 22:31:08.400640:CID-2:RT:<10.200.1.96/9196->10.100.200.13/1;1> matched filter f0: Nov 14 22:31:26 22:31:08.400640:CID-2:RT:packet [60] ipid = 31094, @4239d79c Nov 14 22:31:26 22:31:08.400640:CID-2:RT:---- flow_process_pkt: (thd 3): flow_ctxt type 14, common flag 0x0, mbuf 0x4239d580, rtbl_idx = 0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: flow process pak fast ifl 68 in_ifp reth2.0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: reth2.0:10.200.1.96->10.100.200.13, icmp, (8/0) Nov 14 22:31:26 22:31:08.400640:CID-2:RT: find flow: table 0x495baf60, hash 53375(0xffff), sa 10.200.1.96, da 10.100.200.13, sp 9196, dp 1, proto 1, tok 6 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: flow_first_create_session Nov 14 22:31:26 22:31:08.400640:CID-2:RT: flow_first_in_dst_nat: in , out dst_adr 10.100.200.13, sp 9196, dp 1 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: chose interface reth2.0 as incoming nat if. Nov 14 22:31:26 22:31:08.400640:CID-2:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 10.100.200.13(1) Nov 14 22:31:26 22:31:08.400640:CID-2:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 10.200.1.96, x_dst_ip 10.100.200.13, in ifp reth2.0, out ifp N/A sp 9196, dp 1, ip_proto 1, tos 0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT:Doing DESTINATION addr route-lookup Nov 14 22:31:26 22:31:08.400640:CID-2:RT: routed (x_dst_ip 10.100.200.13) from trust (reth2.0 in 1) to reth15.0, Next-hop: 91.213.133.14 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: policy search from zone trust-> zone untrust (0x0,0x23ec0001,0x1) Nov 14 22:31:26 22:31:08.400640:CID-2:RT: app 0, timeout 60s, curr ageout 60s Nov 14 22:31:26 22:31:08.400640:CID-2:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Nov 14 22:31:26 22:31:08.400640:CID-2:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/0, pst_nat: False. Nov 14 22:31:26 22:31:08.400640:CID-2:RT: dip id = 0/0, 10.200.1.96/9196->10.200.1.96/9196 protocol 0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT:flow_first_get_out_ifp: IN! Nov 14 22:31:26 22:31:08.400640:CID-2:RT: choose interface reth15.0 as outgoing phy if Nov 14 22:31:26 22:31:08.400640:CID-2:RT:is_loop_pak: No loop: on ifp: reth15.0, addr: 10.100.200.13, rtt_idx:0 Nov 14 22:31:26 22:31:08.400640:CID-2:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth15.0 Nov 14 22:31:26 22:31:08.401140:CID-2:RT: vsd 1 is active Nov 14 22:31:26 22:31:08.401140:CID-2:RT:jsf sess interest check. regd plugins 19 Nov 14 22:31:26 22:31:08.401140:CID-2:RT: Allocating plugin info block for 20 plugin(s) from OL Nov 14 22:31:26 22:31:08.401140:CID-2:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401140:CID-2:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401140:CID-2:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401140:CID-2:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401140:CID-2:RT:-jsf int check: plugin id 7, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:+++++++++++jsf_test_plugin_data_evh: 3 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 15, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401237:CID-2:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 2 Nov 14 22:31:26 22:31:08.401317:CID-2:RT:-jsf int check: plugin id 19, svc_req 0x0. rc 4 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: No JSF plugins enabled for session Nov 14 22:31:26 22:31:08.401317:CID-2:RT: Releasing plugin info block for 20 plugin(s) to OL Nov 14 22:31:26 22:31:08.401317:CID-2:RT:flow_first_service_lookup(): natp(0x4f2a70a8): app_id, 0(0). Nov 14 22:31:26 22:31:08.401317:CID-2:RT: service lookup identified service 0. Nov 14 22:31:26 22:31:08.401317:CID-2:RT: flow_first_final_check: in , out Nov 14 22:31:26 22:31:08.401317:CID-2:RT:flow_first_complete_session, pak_ptr: 0x3fbebc90, nsp: 0x4f2a70a8, in_tunnel: 0x0 Nov 14 22:31:26 22:31:08.401317:CID-2:RT:construct v4 vector for nsp2 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: existing vector list 220-458e2610. Nov 14 22:31:26 22:31:08.401317:CID-2:RT: Session (id:101094) created for first pak 220 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: flow_first_install_session======> 0x4f2a70a8 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: nsp 0x4f2a70a8, nsp2 0x4f2a7128 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: make_nsp_ready_no_resolve() Nov 14 22:31:26 22:31:08.401317:CID-2:RT: route lookup: dest-ip 10.200.1.96 orig ifp reth2.0 output_ifp reth2.0 orig-zone 6 out-zone 6 vsd 1 Nov 14 22:31:26 22:31:08.401317:CID-2:RT: route to 10.200.1.96 Nov 14 22:31:26 22:31:08.401317:CID-2:RT:Installing c2s NP session wing Nov 14 22:31:26 22:31:08.401317:CID-2:RT:Installing s2c NP session wing Nov 14 22:31:26 22:31:08.401641:CID-2:RT: flow got session. Nov 14 22:31:26 22:31:08.401641:CID-2:RT: flow session id 101094 Nov 14 22:31:26 22:31:08.401641:CID-2:RT: vector bits 0x220 vector 0x458e2610 Nov 14 22:31:26 22:31:08.401641:CID-2:RT: vsd 1 is active Nov 14 22:31:26 22:31:08.401641:CID-2:RT:mbuf 0x4239d580, exit nh 0x5e23c2 Nov 14 22:31:26 22:31:08.401641:CID-2:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Nov 14 22:31:31 22:31:13.399757:CID-2:RT:<10.200.1.96/9197->10.100.200.13/1;1> matched filter f0: Nov 14 22:31:31 22:31:13.399757:CID-2:RT:packet [60] ipid = 31145, @4238591c Nov 14 22:31:31 22:31:13.399757:CID-2:RT:---- flow_process_pkt: (thd 3): flow_ctxt type 14, common flag 0x0, mbuf 0x42385700, rtbl_idx = 0 Nov 14 22:31:31 22:31:13.399757:CID-2:RT: flow process pak fast ifl 68 in_ifp reth2.0 Nov 14 22:31:31 22:31:13.399757:CID-2:RT: reth2.0:10.200.1.96->10.100.200.13, icmp, (8/0) Nov 14 22:31:31 22:31:13.399757:CID-2:RT: find flow: table 0x495baf60, hash 62287(0xffff), sa 10.200.1.96, da 10.100.200.13, sp 9197, dp 1, proto 1, tok 6 Nov 14 22:31:31 22:31:13.399757:CID-2:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Nov 14 22:31:31 22:31:13.399757:CID-2:RT: flow_first_create_session Nov 14 22:31:31 22:31:13.399757:CID-2:RT: flow_first_in_dst_nat: in , out dst_adr 10.100.200.13, sp 9197, dp 1 Nov 14 22:31:31 22:31:13.399757:CID-2:RT: chose interface reth2.0 as incoming nat if. Nov 14 22:31:31 22:31:13.399757:CID-2:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 10.100.200.13(1) Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 10.200.1.96, x_dst_ip 10.100.200.13, in ifp reth2.0, out ifp N/A sp 9197, dp 1, ip_proto 1, tos 0 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:Doing DESTINATION addr route-lookup Nov 14 22:31:31 22:31:13.400072:CID-2:RT: routed (x_dst_ip 10.100.200.13) from trust (reth2.0 in 1) to reth15.0, Next-hop: 91.213.133.14 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: policy search from zone trust-> zone untrust (0x0,0x23ed0001,0x1) Nov 14 22:31:31 22:31:13.400072:CID-2:RT: app 0, timeout 60s, curr ageout 60s Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/0, pst_nat: False. Nov 14 22:31:31 22:31:13.400072:CID-2:RT: dip id = 0/0, 10.200.1.96/9197->10.200.1.96/9197 protocol 0 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_get_out_ifp: IN! Nov 14 22:31:31 22:31:13.400072:CID-2:RT: choose interface reth15.0 as outgoing phy if Nov 14 22:31:31 22:31:13.400072:CID-2:RT:is_loop_pak: No loop: on ifp: reth15.0, addr: 10.100.200.13, rtt_idx:0 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth15.0 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: vsd 1 is active Nov 14 22:31:31 22:31:13.400072:CID-2:RT:jsf sess interest check. regd plugins 19 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: Allocating plugin info block for 20 plugin(s) from OL Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 7, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:+++++++++++jsf_test_plugin_data_evh: 3 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 15, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 2 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:-jsf int check: plugin id 19, svc_req 0x0. rc 4 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: No JSF plugins enabled for session Nov 14 22:31:31 22:31:13.400072:CID-2:RT: Releasing plugin info block for 20 plugin(s) to OL Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_service_lookup(): natp(0x4f1dec30): app_id, 0(0). Nov 14 22:31:31 22:31:13.400072:CID-2:RT: service lookup identified service 0. Nov 14 22:31:31 22:31:13.400072:CID-2:RT: flow_first_final_check: in , out Nov 14 22:31:31 22:31:13.400072:CID-2:RT:flow_first_complete_session, pak_ptr: 0x3fbebc90, nsp: 0x4f1dec30, in_tunnel: 0x0 Nov 14 22:31:31 22:31:13.400072:CID-2:RT:construct v4 vector for nsp2 Nov 14 22:31:31 22:31:13.400072:CID-2:RT: existing vector list 220-458e2610. Nov 14 22:31:31 22:31:13.400573:CID-2:RT: Session (id:99295) created for first pak 220 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: flow_first_install_session======> 0x4f1dec30 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: nsp 0x4f1dec30, nsp2 0x4f1decb0 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: make_nsp_ready_no_resolve() Nov 14 22:31:31 22:31:13.400573:CID-2:RT: route lookup: dest-ip 10.200.1.96 orig ifp reth2.0 output_ifp reth2.0 orig-zone 6 out-zone 6 vsd 1 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: route to 10.200.1.96 Nov 14 22:31:31 22:31:13.400573:CID-2:RT:Installing c2s NP session wing Nov 14 22:31:31 22:31:13.400573:CID-2:RT:Installing s2c NP session wing Nov 14 22:31:31 22:31:13.400573:CID-2:RT: flow got session. Nov 14 22:31:31 22:31:13.400573:CID-2:RT: flow session id 99295 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: vector bits 0x220 vector 0x458e2610 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: vsd 1 is active Nov 14 22:31:31 22:31:13.400573:CID-2:RT:mbuf 0x42385700, exit nh 0x5e23c2 Nov 14 22:31:31 22:31:13.400573:CID-2:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Nov 14 22:31:34 22:31:16.261173:CID-2:RT:SPU invalid session id 00000000 Nov 14 22:31:36 22:31:18.271861:CID-2:RT:SPU invalid session id 00000000 Nov 14 22:31:36 22:31:18.400068:CID-2:RT:<10.200.1.96/9198->10.100.200.13/1;1> matched filter f0: Nov 14 22:31:36 22:31:18.400068:CID-2:RT:packet [60] ipid = 31212, @42372f9c Nov 14 22:31:36 22:31:18.400068:CID-2:RT:---- flow_process_pkt: (thd 3): flow_ctxt type 14, common flag 0x0, mbuf 0x42372d80, rtbl_idx = 0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: flow process pak fast ifl 68 in_ifp reth2.0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: reth2.0:10.200.1.96->10.100.200.13, icmp, (8/0) Nov 14 22:31:36 22:31:18.400068:CID-2:RT: find flow: table 0x495baf60, hash 37471(0xffff), sa 10.200.1.96, da 10.100.200.13, sp 9198, dp 1, proto 1, tok 6 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: flow_first_create_session Nov 14 22:31:36 22:31:18.400068:CID-2:RT: flow_first_in_dst_nat: in , out dst_adr 10.100.200.13, sp 9198, dp 1 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: chose interface reth2.0 as incoming nat if. Nov 14 22:31:36 22:31:18.400068:CID-2:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 10.100.200.13(1) Nov 14 22:31:36 22:31:18.400068:CID-2:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 10.200.1.96, x_dst_ip 10.100.200.13, in ifp reth2.0, out ifp N/A sp 9198, dp 1, ip_proto 1, tos 0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT:Doing DESTINATION addr route-lookup Nov 14 22:31:36 22:31:18.400068:CID-2:RT: routed (x_dst_ip 10.100.200.13) from trust (reth2.0 in 1) to reth15.0, Next-hop: 91.213.133.14 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: policy search from zone trust-> zone untrust (0x0,0x23ee0001,0x1) Nov 14 22:31:36 22:31:18.400068:CID-2:RT: app 0, timeout 60s, curr ageout 60s Nov 14 22:31:36 22:31:18.400068:CID-2:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Nov 14 22:31:36 22:31:18.400068:CID-2:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/0, pst_nat: False. Nov 14 22:31:36 22:31:18.400068:CID-2:RT: dip id = 0/0, 10.200.1.96/9198->10.200.1.96/9198 protocol 0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT:flow_first_get_out_ifp: IN! Nov 14 22:31:36 22:31:18.400068:CID-2:RT: choose interface reth15.0 as outgoing phy if Nov 14 22:31:36 22:31:18.400068:CID-2:RT:is_loop_pak: No loop: on ifp: reth15.0, addr: 10.100.200.13, rtt_idx:0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth15.0 Nov 14 22:31:36 22:31:18.400068:CID-2:RT: vsd 1 is active Nov 14 22:31:36 22:31:18.400068:CID-2:RT:jsf sess interest check. regd plugins 19 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: Allocating plugin info block for 20 plugin(s) from OL Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 7, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:+++++++++++jsf_test_plugin_data_evh: 3 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 15, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 2 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:-jsf int check: plugin id 19, svc_req 0x0. rc 4 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: No JSF plugins enabled for session Nov 14 22:31:36 22:31:18.400569:CID-2:RT: Releasing plugin info block for 20 plugin(s) to OL Nov 14 22:31:36 22:31:18.400569:CID-2:RT:flow_first_service_lookup(): natp(0x4ef79028): app_id, 0(0). Nov 14 22:31:36 22:31:18.400569:CID-2:RT: service lookup identified service 0. Nov 14 22:31:36 22:31:18.400569:CID-2:RT: flow_first_final_check: in , out Nov 14 22:31:36 22:31:18.400569:CID-2:RT:flow_first_complete_session, pak_ptr: 0x3fbebc90, nsp: 0x4ef79028, in_tunnel: 0x0 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:construct v4 vector for nsp2 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: existing vector list 220-458e2610. Nov 14 22:31:36 22:31:18.400569:CID-2:RT: Session (id:93782) created for first pak 220 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: flow_first_install_session======> 0x4ef79028 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: nsp 0x4ef79028, nsp2 0x4ef790a8 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: make_nsp_ready_no_resolve() Nov 14 22:31:36 22:31:18.400569:CID-2:RT: route lookup: dest-ip 10.200.1.96 orig ifp reth2.0 output_ifp reth2.0 orig-zone 6 out-zone 6 vsd 1 Nov 14 22:31:36 22:31:18.400569:CID-2:RT: route to 10.200.1.96 Nov 14 22:31:36 22:31:18.400569:CID-2:RT:Installing c2s NP session wing Nov 14 22:31:36 22:31:18.400569:CID-2:RT:Installing s2c NP session wing Nov 14 22:31:36 22:31:18.401073:CID-2:RT: flow got session. Nov 14 22:31:36 22:31:18.401073:CID-2:RT: flow session id 93782 Nov 14 22:31:36 22:31:18.401073:CID-2:RT: vector bits 0x220 vector 0x458e2610 Nov 14 22:31:36 22:31:18.401073:CID-2:RT: vsd 1 is active Nov 14 22:31:36 22:31:18.401073:CID-2:RT:mbuf 0x42372d80, exit nh 0x5e23c2 Nov 14 22:31:36 22:31:18.401073:CID-2:RT: ----- flow_process_pkt rc 0x0 (fp rc 0)