root@Site-A> show configuration security flow traceoptions | display set set security flow traceoptions file DebugTraffic set security flow traceoptions flag basic-datapath set security flow traceoptions packet-filter MatchTraffic source-prefix 192.168.41.1/32 set security flow traceoptions packet-filter MatchTraffic destination-prefix 192.168.5.102/32 root@Site-A> ping interface reth1.0 192.168.5.102 PING 192.168.5.102 (192.168.5.102): 56 data bytes ^C --- 192.168.5.102 ping statistics --- 6 packets transmitted, 0 packets received, 100% packet loss root@Site-A> file show /var/log/DebugTraffic Feb 23 18:10:14 22:59:10.664686:CID-1:RT:traceflag 0x0 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow0: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow0: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow1: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow1: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow2: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow2: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow3: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow3: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833644:CID-1:CTRL:flow4: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow4: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow5: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow5: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow6: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow6: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow7: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow7: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow8: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow8: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow9: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow9: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow10: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow10: Destination ID set to 2 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow11: Rate limit changed to 0 Feb 23 18:10:14 18:10:12.1833736:CID-1:CTRL:flow11: Destination ID set to 2 Feb 23 18:10:25 18:10:24.1303876:CID-1:RT:<192.168.41.1/0->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:25 18:10:24.1303926:CID-1:RT:packet [84] ipid = 22833, @44ede0ce Feb 23 18:10:25 18:10:24.1303936:CID-1:RT:---- flow_process_pkt: (thd 8): flow_ctxt type 0, common flag 0x0, mbuf 0x44f33680, rtbl_idx = 0 Feb 23 18:10:25 18:10:24.1303936:CID-1:RT: in_ifp Feb 23 18:10:25 18:10:24.1303936:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:25 18:10:24.1303980:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:25 18:10:24.1303988:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:25 18:10:24.1303988:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:25 18:10:24.1303988:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:25 18:10:24.1303988:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:25 18:10:24.1303988:CID-1:RT: find flow: table 0x53a20868, hash 5712(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 0, dp 26607, proto 1, tok 2 Feb 23 18:10:25 18:10:24.1304049:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:25 18:10:24.1304049:CID-1:RT: flow_first_create_session Feb 23 18:10:25 18:10:24.1304100:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:25 18:10:24.1304100:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 0, dp 26607 Feb 23 18:10:25 18:10:24.1304100:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:25 18:10:24.1304100:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:25 18:10:24.1304163:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 0, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:25 18:10:24.1304163:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:25 18:10:24.1304207:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:25 18:10:24.1304214:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x67ef,0x67ef) Feb 23 18:10:25 18:10:24.1304214:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:25 18:10:24.1304252:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:25 18:10:24.1304276:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:25 18:10:24.1304276:CID-1:RT: dip id = 0/0, 192.168.41.1/0->192.168.41.1/0 protocol 0 Feb 23 18:10:25 18:10:24.1304276:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:25 18:10:24.1304321:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: vsd 1 is active Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:25 18:10:24.1304331:CID-1:RT:flow_first_service_lookup(): natp(0x5799e998): app_id, 0(0). Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: service lookup identified service 0. Feb 23 18:10:25 18:10:24.1304331:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:25 18:10:24.1304550:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: Session (id:42099) created for first pak 220 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: flow_first_install_session======> 0x5799e998 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: nsp 0x5799e998, nsp2 0x5799ea18 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:25 18:10:24.1304550:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: flow got session. Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: flow session id 42099 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: vsd 1 is active Feb 23 18:10:25 18:10:24.1304550:CID-1:RT:mbuf 0x44f33680, exit nh 0x45abc1 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f6e68e8 associated with mbuf 0x44f33680 Feb 23 18:10:25 18:10:24.1304550:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:26 18:10:25.1310459:CID-1:RT:<192.168.41.1/1->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:packet [84] ipid = 22837, @44f86cce Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:---- flow_process_pkt: (thd 8): flow_ctxt type 0, common flag 0x0, mbuf 0x44ee1480, rtbl_idx = 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: in_ifp Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: find flow: table 0x53a20868, hash 61696(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 1, dp 26607, proto 1, tok 2 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: flow_first_create_session Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 1, dp 26607 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 1, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x167ef,0x67ef) Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: dip id = 0/0, 192.168.41.1/1->192.168.41.1/1 protocol 0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: vsd 1 is active Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310509:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:flow_first_service_lookup(): natp(0x57a91680): app_id, 0(0). Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: service lookup identified service 0. Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: Session (id:44280) created for first pak 220 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: flow_first_install_session======> 0x57a91680 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: nsp 0x57a91680, nsp2 0x57a91700 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: flow got session. Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: flow session id 44280 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: vsd 1 is active Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:mbuf 0x44ee1480, exit nh 0x45abc1 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f6e68e8 associated with mbuf 0x44ee1480 Feb 23 18:10:26 18:10:25.1310960:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:27 18:10:26.1317666:CID-1:RT:<192.168.41.1/2->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:27 18:10:26.1317706:CID-1:RT:packet [84] ipid = 22839, @44ede0ce Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:---- flow_process_pkt: (thd 11): flow_ctxt type 0, common flag 0x0, mbuf 0x44f33680, rtbl_idx = 0 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: in_ifp Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: find flow: table 0x53a20868, hash 53296(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 2, dp 26607, proto 1, tok 2 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 23 18:10:27 18:10:26.1317711:CID-1:RT: flow_first_create_session Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 2, dp 26607 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 2, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:27 18:10:26.1317711:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x267ef,0x67ef) Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: dip id = 0/0, 192.168.41.1/2->192.168.41.1/2 protocol 0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: vsd 1 is active Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:flow_first_service_lookup(): natp(0x577b46c0): app_id, 0(0). Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: service lookup identified service 0. Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: Session (id:37696) created for first pak 220 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: flow_first_install_session======> 0x577b46c0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: nsp 0x577b46c0, nsp2 0x577b4740 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: flow got session. Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: flow session id 37696 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:27 18:10:26.1317969:CID-1:RT: vsd 1 is active Feb 23 18:10:27 18:10:26.1317969:CID-1:RT:mbuf 0x44f33680, exit nh 0x45abc1 Feb 23 18:10:27 18:10:26.1318470:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f3e38e8 associated with mbuf 0x44f33680 Feb 23 18:10:27 18:10:26.1318470:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:28 18:10:27.1325005:CID-1:RT:<192.168.41.1/3->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:28 18:10:27.1325005:CID-1:RT:packet [84] ipid = 22841, @44ee16ce Feb 23 18:10:28 18:10:27.1325064:CID-1:RT:---- flow_process_pkt: (thd 8): flow_ctxt type 0, common flag 0x0, mbuf 0x44ef1980, rtbl_idx = 0 Feb 23 18:10:28 18:10:27.1325064:CID-1:RT: in_ifp Feb 23 18:10:28 18:10:27.1325064:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:28 18:10:27.1325064:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:28 18:10:27.1325110:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:28 18:10:27.1325110:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:28 18:10:27.1325118:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:28 18:10:27.1325118:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:28 18:10:27.1325118:CID-1:RT: find flow: table 0x53a20868, hash 45920(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 3, dp 26607, proto 1, tok 2 Feb 23 18:10:28 18:10:27.1325180:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:28 18:10:27.1325180:CID-1:RT: flow_first_create_session Feb 23 18:10:28 18:10:27.1325180:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:28 18:10:27.1325180:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 3, dp 26607 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 3, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x367ef,0x67ef) Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: dip id = 0/0, 192.168.41.1/3->192.168.41.1/3 protocol 0 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: vsd 1 is active Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:flow_first_service_lookup(): natp(0x57a79230): app_id, 0(0). Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: service lookup identified service 0. Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:28 18:10:27.1325231:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: Session (id:44062) created for first pak 220 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: flow_first_install_session======> 0x57a79230 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: nsp 0x57a79230, nsp2 0x57a792b0 Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:28 18:10:27.1325231:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:28 18:10:27.1325677:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: flow got session. Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: flow session id 44062 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: vsd 1 is active Feb 23 18:10:28 18:10:27.1325677:CID-1:RT:mbuf 0x44ef1980, exit nh 0x45abc1 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f6e68e8 associated with mbuf 0x44ef1980 Feb 23 18:10:28 18:10:27.1325677:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:29 18:10:28.1332168:CID-1:RT:<192.168.41.1/4->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:29 18:10:28.1332168:CID-1:RT:packet [84] ipid = 22845, @44f3adce Feb 23 18:10:29 18:10:28.1332225:CID-1:RT:---- flow_process_pkt: (thd 9): flow_ctxt type 0, common flag 0x0, mbuf 0x44eaea80, rtbl_idx = 0 Feb 23 18:10:29 18:10:28.1332225:CID-1:RT: in_ifp Feb 23 18:10:29 18:10:28.1332225:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:29 18:10:28.1332269:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:29 18:10:28.1332278:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:29 18:10:28.1332278:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:29 18:10:28.1332278:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:29 18:10:28.1332278:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:29 18:10:28.1332278:CID-1:RT: find flow: table 0x53a20868, hash 37392(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 4, dp 26607, proto 1, tok 2 Feb 23 18:10:29 18:10:28.1332342:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:29 18:10:28.1332342:CID-1:RT: flow_first_create_session Feb 23 18:10:29 18:10:28.1332342:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:29 18:10:28.1332342:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 4, dp 26607 Feb 23 18:10:29 18:10:28.1332342:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:29 18:10:28.1332342:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 4, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x467ef,0x67ef) Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: dip id = 0/0, 192.168.41.1/4->192.168.41.1/4 protocol 0 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: vsd 1 is active Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:flow_first_service_lookup(): natp(0x57a82608): app_id, 0(0). Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: service lookup identified service 0. Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:29 18:10:28.1332410:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: Session (id:44145) created for first pak 220 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: flow_first_install_session======> 0x57a82608 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: nsp 0x57a82608, nsp2 0x57a82688 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:29 18:10:28.1332410:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:29 18:10:28.1332913:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:29 18:10:28.1332913:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:29 18:10:28.1332913:CID-1:RT: flow got session. Feb 23 18:10:29 18:10:28.1332913:CID-1:RT: flow session id 44145 Feb 23 18:10:29 18:10:28.1332913:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:29 18:10:28.1332913:CID-1:RT: vsd 1 is active Feb 23 18:10:29 18:10:28.1332913:CID-1:RT:mbuf 0x44eaea80, exit nh 0x45abc1 Feb 23 18:10:29 18:10:28.1332913:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f5e58e8 associated with mbuf 0x44eaea80 Feb 23 18:10:29 18:10:28.1332913:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:30 18:10:29.1339416:CID-1:RT:<192.168.41.1/5->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:30 18:10:29.1339459:CID-1:RT:packet [84] ipid = 22847, @44ee16ce Feb 23 18:10:30 18:10:29.1339459:CID-1:RT:---- flow_process_pkt: (thd 11): flow_ctxt type 0, common flag 0x0, mbuf 0x44ef1980, rtbl_idx = 0 Feb 23 18:10:30 18:10:29.1339477:CID-1:RT: in_ifp Feb 23 18:10:30 18:10:29.1339477:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:30 18:10:29.1339477:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:30 18:10:29.1339522:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:30 18:10:29.1339522:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:30 18:10:29.1339529:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: find flow: table 0x53a20868, hash 32192(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 5, dp 26607, proto 1, tok 2 Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: flow_first_create_session Feb 23 18:10:30 18:10:29.1339529:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 5, dp 26607 Feb 23 18:10:30 18:10:29.1339529:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:30 18:10:29.1339529:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 5, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x567ef,0x67ef) Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: dip id = 0/0, 192.168.41.1/5->192.168.41.1/5 protocol 0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: vsd 1 is active Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:flow_first_service_lookup(): natp(0x57aef250): app_id, 0(0). Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: service lookup identified service 0. Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: Session (id:45122) created for first pak 220 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: flow_first_install_session======> 0x57aef250 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: nsp 0x57aef250, nsp2 0x57aef2d0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:30 18:10:29.1339668:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:30 18:10:29.1340169:CID-1:RT: flow got session. Feb 23 18:10:30 18:10:29.1340169:CID-1:RT: flow session id 45122 Feb 23 18:10:30 18:10:29.1340169:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:30 18:10:29.1340169:CID-1:RT: vsd 1 is active Feb 23 18:10:30 18:10:29.1340169:CID-1:RT:mbuf 0x44ef1980, exit nh 0x45abc1 Feb 23 18:10:30 18:10:29.1340169:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f3e38e8 associated with mbuf 0x44ef1980 Feb 23 18:10:30 18:10:29.1340169:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:31 18:10:30.1346620:CID-1:RT:<192.168.41.1/6->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:31 18:10:30.1346669:CID-1:RT:packet [84] ipid = 22852, @44f3adce Feb 23 18:10:31 18:10:30.1346679:CID-1:RT:---- flow_process_pkt: (thd 6): flow_ctxt type 0, common flag 0x0, mbuf 0x44eaea80, rtbl_idx = 0 Feb 23 18:10:31 18:10:30.1346679:CID-1:RT: in_ifp Feb 23 18:10:31 18:10:30.1346679:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:31 18:10:30.1346723:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:31 18:10:30.1346730:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:31 18:10:30.1346730:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:31 18:10:30.1346740:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:31 18:10:30.1346740:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:31 18:10:30.1346740:CID-1:RT: find flow: table 0x53a20868, hash 23792(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 6, dp 26607, proto 1, tok 2 Feb 23 18:10:31 18:10:30.1346804:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:31 18:10:30.1346804:CID-1:RT: flow_first_create_session Feb 23 18:10:31 18:10:30.1346804:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:31 18:10:30.1346804:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 6, dp 26607 Feb 23 18:10:31 18:10:30.1346851:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:31 18:10:30.1346851:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:31 18:10:30.1346883:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 6, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:31 18:10:30.1346883:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:31 18:10:30.1346883:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:31 18:10:30.1346947:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x667ef,0x67ef) Feb 23 18:10:31 18:10:30.1346964:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:31 18:10:30.1346964:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:31 18:10:30.1347008:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:31 18:10:30.1347008:CID-1:RT: dip id = 0/0, 192.168.41.1/6->192.168.41.1/6 protocol 0 Feb 23 18:10:31 18:10:30.1347031:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT: vsd 1 is active Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347048:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347133:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:31 18:10:30.1347149:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:31 18:10:30.1347153:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:31 18:10:30.1347153:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:31 18:10:30.1347153:CID-1:RT:flow_first_service_lookup(): natp(0x579c3730): app_id, 0(0). Feb 23 18:10:31 18:10:30.1347153:CID-1:RT: service lookup identified service 0. Feb 23 18:10:31 18:10:30.1347254:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:31 18:10:30.1347254:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:31 18:10:30.1347254:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:31 18:10:30.1347254:CID-1:RT: Session (id:42430) created for first pak 220 Feb 23 18:10:31 18:10:30.1347288:CID-1:RT: flow_first_install_session======> 0x579c3730 Feb 23 18:10:31 18:10:30.1347288:CID-1:RT: nsp 0x579c3730, nsp2 0x579c37b0 Feb 23 18:10:31 18:10:30.1347288:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:31 18:10:30.1347288:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:31 18:10:30.1347288:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:31 18:10:30.1347361:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:31 18:10:30.1347361:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:31 18:10:30.1347361:CID-1:RT: flow got session. Feb 23 18:10:31 18:10:30.1347361:CID-1:RT: flow session id 42430 Feb 23 18:10:31 18:10:30.1347361:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:31 18:10:30.1347414:CID-1:RT: vsd 1 is active Feb 23 18:10:31 18:10:30.1347414:CID-1:RT:mbuf 0x44eaea80, exit nh 0x45abc1 Feb 23 18:10:31 18:10:30.1347414:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f8e88e8 associated with mbuf 0x44eaea80 Feb 23 18:10:31 18:10:30.1347454:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Feb 23 18:10:32 18:10:31.1353881:CID-1:RT:<192.168.41.1/7->192.168.5.102/26607;1> matched filter MatchTraffic: Feb 23 18:10:32 18:10:31.1353921:CID-1:RT:packet [84] ipid = 22854, @44f5edce Feb 23 18:10:32 18:10:31.1353940:CID-1:RT:---- flow_process_pkt: (thd 8): flow_ctxt type 0, common flag 0x0, mbuf 0x44ea2d80, rtbl_idx = 0 Feb 23 18:10:32 18:10:31.1353940:CID-1:RT: in_ifp Feb 23 18:10:32 18:10:31.1353940:CID-1:RT:flow_process_pkt_exception: setting rtt in lpak to 70370958 Feb 23 18:10:32 18:10:31.1353940:CID-1:RT:Using out_ifp from pfe_tag with index 67 Feb 23 18:10:32 18:10:31.1353984:CID-1:RT:Using vr id from pfe_tag with value= 0 Feb 23 18:10:32 18:10:31.1353993:CID-1:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Feb 23 18:10:32 18:10:31.1353993:CID-1:RT:Over-riding lpak->vsys with 0 Feb 23 18:10:32 18:10:31.1353993:CID-1:RT: .local..0:192.168.41.1->192.168.5.102, icmp, (8/0) Feb 23 18:10:32 18:10:31.1353993:CID-1:RT: find flow: table 0x53a20868, hash 15904(0xffff), sa 192.168.41.1, da 192.168.5.102, sp 7, dp 26607, proto 1, tok 2 Feb 23 18:10:32 18:10:31.1354039:CID-1:RT: no session found, start first path. in_tunnel - 0, from_cp_flag - 0 Feb 23 18:10:32 18:10:31.1354068:CID-1:RT: flow_first_create_session Feb 23 18:10:32 18:10:31.1354068:CID-1:RT:(flow_first_create_session) usp_tagged set session as mng session Feb 23 18:10:32 18:10:31.1354068:CID-1:RT: flow_first_in_dst_nat: in <.local..0>, out dst_adr 192.168.5.102, sp 7, dp 26607 Feb 23 18:10:32 18:10:31.1354108:CID-1:RT: chose interface .local..0 as incoming nat if. Feb 23 18:10:32 18:10:31.1354119:CID-1:RT:flow_first_rule_dst_xlate: packet 192.168.41.1->192.168.5.102 nsp2 0.0.0.0->192.168.5.102. Feb 23 18:10:32 18:10:31.1354119:CID-1:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.41.1, x_dst_ip 192.168.5.102, in ifp .local..0, out ifp reth1.0 sp 7, dp 26607, ip_proto 1, tos 0 Feb 23 18:10:32 18:10:31.1354171:CID-1:RT:Doing DESTINATION addr route-lookup Feb 23 18:10:32 18:10:31.1354171:CID-1:RT: routed (x_dst_ip 192.168.5.102) from junos-self (.local..0 in 0) to reth0.0, Next-hop: 115.42.152.65 Feb 23 18:10:32 18:10:31.1354171:CID-1:RT: policy search from zone junos-self-> zone untrust (0x0,0x767ef,0x67ef) Feb 23 18:10:32 18:10:31.1354225:CID-1:RT: app 0, timeout 60s, curr ageout 60s Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:flow_first_src_xlate: src nat returns status: 0, rule/pool id: 0/0, pst_nat: False. Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: dip id = 0/0, 192.168.41.1/7->192.168.41.1/7 protocol 0 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: choose interface reth0.0 as outgoing phy if Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:is_loop_pak: No loop: on ifp: reth0.0, addr: 192.168.5.102, rtt_idx:0 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: check nsrp pak fwd: in_tun=0x0, VSD 1 for out ifp reth0.0 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: vsd 1 is active Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:jsf sess interest check. regd plugins 19 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: Allocating plugin info block for 19 plugin(s) from OL Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 5, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 7, svc_req 0x2. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 11, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:+++++++++++jsf_test_plugin_data_evh: 3 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 17, svc_req 0x0. rc 2 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 4 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: No JSF plugins enabled for session Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: Releasing plugin info block for 19 plugin(s) to OL Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:flow_first_service_lookup(): natp(0x57ab35c8): app_id, 0(0). Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: service lookup identified service 0. Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: flow_first_final_check: in <.local..0>, out Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:construct v4 vector for nsp2 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: existing vector list 220-490c36d0. Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: Session (id:44585) created for first pak 220 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: flow_first_install_session======> 0x57ab35c8 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: nsp 0x57ab35c8, nsp2 0x57ab3648 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: make_nsp_ready_no_resolve() Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: route lookup: dest-ip 192.168.41.1 orig ifp .local..0 output_ifp .local..0 orig-zone 2 out-zone 2 vsd 0 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: route to 192.168.41.1 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:Installing c2s NP session wing Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:Installing s2c NP session wing Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: flow got session. Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: flow session id 44585 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: vector bits 0x220 vector 0x490c36d0 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: vsd 1 is active Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:mbuf 0x44ea2d80, exit nh 0x45abc1 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT:flow_process_pkt_exception: Freeing lpak 3f6e68e8 associated with mbuf 0x44ea2d80 Feb 23 18:10:32 18:10:31.1354241:CID-1:RT: ----- flow_process_pkt rc 0x0 (fp rc 0)