Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.1.9, x_dst_ip 8.8.8.8, in ifp vlan.0, out ifp N/A sp 21, dp 5069, ip_proto 1, tos 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:Doing DESTINATION addr route-lookup Aug 21 05:19:30 05:19:30.068727:CID-0:RT: routed (x_dst_ip 8.8.8.8) from trust (vlan.0 in 0) to pp0.0, Next-hop: 8.8.8.8 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_policy_search: policy search from zone trust-> zone untrust (0x0,0x1513cd,0x13cd) Aug 21 05:19:30 05:19:30.068727:CID-0:RT:Policy lkup: vsys 0 zone(6:trust) -> zone(7:untrust) scope:0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: 192.168.1.9/2048 -> 8.8.8.8/60581 proto 1 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: app 0, timeout 60s, curr ageout 60s Aug 21 05:19:30 05:19:30.068727:CID-0:RT: permitted by policy default-permit(6) Aug 21 05:19:30 05:19:30.068727:CID-0:RT: packet passed, Permitted by policy. Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp 192.168.1.9/21 -> 8.8.8.8/5069 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/21 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.9, dst-ip 8.8.8.8, dst-port 5069 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 7 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_src_rule_match: src nat rule found: id 1, pos-id 1, pool id 2 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/2, pst_nat: False. Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp 192.168.1.9/21 -> 8.8.8.8/5069 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/21 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_dip_by_host: pst_nat = False, lsys_id = 0, platform = 1, dip_id = 0x2,dst_port = 5069, ptr = 0x4fa2a290, sess_id = 0x0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_dip_by_host:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_local_dip_by_host: src nat ip/port is allocated locally. src_port 21 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_dip_by_host_cp: lsys id: 0, src_port 0, dip id: 0x2 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_dip_by_host_cp:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_dip_by_host_cp: get xlated ip/port (115.64.136.32/21638), xlation flag (1), xlation pool id (0x2) from JSF Aug 21 05:19:30 05:19:30.068727:CID-0:RT: dip id = 2/0, 192.168.1.9/21->115.64.136.32/21638 protocol 58 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: choose interface pp0.0 as outgoing phy if Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:is_loop_pak: No loop: on ifp: pp0.0, addr: 8.8.8.8, rtt_idx:0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf : Alloc sess plugin info for session 127378 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:[JSF]Normal interest check. regd plugins 19, enabled impl mask 0x0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 2, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 3, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 5, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 6, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 7, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 8, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 12, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 15, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:+++++++++++jsf_test_plugin_data_evh: 3 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 16, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 22, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 23, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 26, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 27, svc_req 0x0, impl mask 0x0. rc 2 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf int check: plugin id 28, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:[JSF]Plugins(0x0, count 0) enabled for session = 0, impli mask(0x0), post_nat cnt 127378 svc req(0x0) Aug 21 05:19:30 05:19:30.068727:CID-0:RT:-jsf : no plugin interested for session 127378, free sess plugin info Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_service_lookup(): natp(0x56eefec8): app_id, 0(0). Aug 21 05:19:30 05:19:30.068727:CID-0:RT: service lookup identified service 0. Aug 21 05:19:30 05:19:30.068727:CID-0:RT: flow_first_final_check: in , out Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_final_check: flow_set_xlate_vector. Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_first_complete_session, pak_ptr: 0x4fa2a290, nsp: 0x56eefec8, in_tunnel: 0x0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:construct v4 vector for nsp2 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: existing vector list 0x1200-0x48cf5910. Aug 21 05:19:30 05:19:30.068727:CID-0:RT: Session (id:127378) created for first pak 1200 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: flow_first_install_session======> 0x56eefec8 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: nsp 0x56eefec8, nsp2 0x56eeff48 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: make_nsp_ready_no_resolve() Aug 21 05:19:30 05:19:30.068727:CID-0:RT: route lookup: dest-ip 192.168.1.9 orig ifp vlan.0 output_ifp vlan.0 orig-zone 6 out-zone 6 vsd 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: route to 192.168.1.9 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:no need update ha Aug 21 05:19:30 05:19:30.068727:CID-0:RT:Installing c2s NP session wing Aug 21 05:19:30 05:19:30.068727:CID-0:RT:Installing s2c NP session wing Aug 21 05:19:30 05:19:30.068727:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.068727:CID-0:RT: flow session id 127378 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: vector bits 0x1200 vector 0x48cf5910 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_xlate_pak Aug 21 05:19:30 05:19:30.068727:CID-0:RT:flow_handle_icmp_xlate Aug 21 05:19:30 05:19:30.068727:CID-0:RT:xlate_icmp_pak Aug 21 05:19:30 05:19:30.068727:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:30 05:19:30.068727:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:30 05:19:30.068727:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:mbuf 0x4368bf00, exit nh 0xfffa0006 Aug 21 05:19:30 05:19:30.068727:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/21638 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp2 115.64.136.32/21638 -> 0.0.0.0/5069 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 8.8.8.8, dst-ip 115.64.136.32, dst-port 21638 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 2, to-id 2 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/21638 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat xlate nsp2 115.64.136.32/21638 -> 0.0.0.0/5069 Aug 21 05:19:30 05:19:30.068727:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:jsf sess close notify Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126905, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126905, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:jsf sess close notify Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126903, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126903, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:jsf sess close notify Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126899, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126899, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:jsf sess close notify Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126902, in hash 32 Aug 21 05:19:30 05:19:30.203476:CID-0:RT:flow_ipv4_del_flow: sess 126902, in hash 32 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:<192.168.1.9/49831->99.198.107.205/80;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.588625:CID-0:RT:packet [64] ipid = 13092, @0x4369739a Aug 21 05:19:30 05:19:30.588625:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43697180, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: vlan.0:192.168.1.9/49831->99.198.107.205/80, tcp, flag 2 syn Aug 21 05:19:30 05:19:30.588625:CID-0:RT: find flow: table 0x4f9a9078, hash 39086(0xffff), sa 192.168.1.9, da 99.198.107.205, sp 49831, dp 80, proto 6, tok 6 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: no session found, start first path. in_tunnel - 0x0, from_cp_flag - 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow_first_create_session Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow_first_in_dst_nat: in , out dst_adr 99.198.107.205, sp 49831, dp 80 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: chose interface vlan.0 as incoming nat if. Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 99.198.107.205(80) Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.1.9, x_dst_ip 99.198.107.205, in ifp vlan.0, out ifp N/A sp 49831, dp 80, ip_proto 6, tos 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:Doing DESTINATION addr route-lookup Aug 21 05:19:30 05:19:30.588625:CID-0:RT: routed (x_dst_ip 99.198.107.205) from trust (vlan.0 in 0) to pp0.0, Next-hop: 99.198.107.205 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_policy_search: policy search from zone trust-> zone untrust (0x0,0xc2a70050,0x50) Aug 21 05:19:30 05:19:30.588625:CID-0:RT:Policy lkup: vsys 0 zone(6:trust) -> zone(7:untrust) scope:0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: 192.168.1.9/49831 -> 99.198.107.205/80 proto 6 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: app 6, timeout 300s, curr ageout 20s Aug 21 05:19:30 05:19:30.588625:CID-0:RT: permitted by policy default-permit(6) Aug 21 05:19:30 05:19:30.588625:CID-0:RT: packet passed, Permitted by policy. Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat xlate nsp 192.168.1.9/49831 -> 99.198.107.205/80 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat xlate nsp2 99.198.107.205/80 -> 0.0.0.0/49831 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.9, dst-ip 99.198.107.205, dst-port 80 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_rule_match_ctx_n_port: protocol 6 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 7 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_src_rule_match: src nat rule found: id 1, pos-id 1, pool id 2 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/2, pst_nat: False. Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat xlate nsp 192.168.1.9/49831 -> 99.198.107.205/80 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat xlate nsp2 99.198.107.205/80 -> 0.0.0.0/49831 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_dip_by_host: pst_nat = False, lsys_id = 0, platform = 1, dip_id = 0x2,dst_port = 80, ptr = 0x4fa2a290, sess_id = 0x0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_dip_by_host:src_ip 192.168.1.9 dst_ip 99.198.107.205 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_local_dip_by_host: src nat ip/port is allocated locally. src_port 49831 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_dip_by_host_cp: lsys id: 0, src_port 0, dip id: 0x2 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_dip_by_host_cp:src_ip 192.168.1.9 dst_ip 99.198.107.205 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_dip_by_host_cp: get xlated ip/port (115.64.136.32/7851), xlation flag (1), xlation pool id (0x2) from JSF Aug 21 05:19:30 05:19:30.588625:CID-0:RT: dip id = 2/0, 192.168.1.9/49831->115.64.136.32/7851 protocol 6 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: choose interface pp0.0 as outgoing phy if Aug 21 05:19:30 05:19:30.588625:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:is_loop_pak: No loop: on ifp: pp0.0, addr: 99.198.107.205, rtt_idx:0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf : Alloc sess plugin info for session 127380 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:[JSF]Normal interest check. regd plugins 19, enabled impl mask 0x0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 2, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 3, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 5, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 6, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 7, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 8, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 12, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 15, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:+++++++++++jsf_test_plugin_data_evh: 3 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 16, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 22, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 23, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 26, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 27, svc_req 0x0, impl mask 0x0. rc 2 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf int check: plugin id 28, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:[JSF]Plugins(0x0, count 0) enabled for session = 0, impli mask(0x0), post_nat cnt 127380 svc req(0x0) Aug 21 05:19:30 05:19:30.588625:CID-0:RT:-jsf : no plugin interested for session 127380, free sess plugin info Aug 21 05:19:30 05:19:30.588625:CID-0:RT: service lookup identified service 6. Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow_first_final_check: in , out Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_final_check: flow_set_xlate_vector. Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_first_complete_session, pak_ptr: 0x4fa2a290, nsp: 0x56ef0258, in_tunnel: 0x0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:construct v4 vector for nsp2 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: existing vector list 0x1002-0x48cd7d28. Aug 21 05:19:30 05:19:30.588625:CID-0:RT: Session (id:127380) created for first pak 1002 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow_first_install_session======> 0x56ef0258 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: nsp 0x56ef0258, nsp2 0x56ef02d8 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: make_nsp_ready_no_resolve() Aug 21 05:19:30 05:19:30.588625:CID-0:RT: route lookup: dest-ip 192.168.1.9 orig ifp vlan.0 output_ifp vlan.0 orig-zone 6 out-zone 6 vsd 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: route to 192.168.1.9 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:no need update ha Aug 21 05:19:30 05:19:30.588625:CID-0:RT:Installing c2s NP session wing Aug 21 05:19:30 05:19:30.588625:CID-0:RT:Installing s2c NP session wing Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.588625:CID-0:RT: flow session id 127380 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: vector bits 0x1002 vector 0x48cd7d28 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: tcp 3way refresh, is_half_open:0, is_fwauth:0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: tcp flags 0x2, flag 0x2 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: Got syn, 192.168.1.9(49831)->99.198.107.205(80), nspflag 0x1021, 0x20 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:flow_xlate_pak Aug 21 05:19:30 05:19:30.588625:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.588625:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.588625:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:30 05:19:30.588625:CID-0:RT:mbuf 0x43697180, exit nh 0xfffa0006 Aug 21 05:19:30 05:19:30.588625:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat xlate nsp 192.168.1.13/47838 -> 192.168.1.1/53 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/47838 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.13, dst-ip 192.168.1.1, dst-port 53 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_rule_match_ctx_n_port: protocol 17 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 2 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat xlate nsp 192.168.1.13/47838 -> 192.168.1.1/53 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/47838 Aug 21 05:19:30 05:19:30.715873:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:30 05:19:30.748000:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.748000:CID-0:RT:packet [100] ipid = 24516, @0x43687d1a Aug 21 05:19:30 05:19:30.748000:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43687b00, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 18 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.748000:CID-0:RT: flow session id 111854 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: refreshing session Aug 21 05:19:30 05:19:30.748000:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:30 05:19:30.748000:CID-0:RT:mbuf 0x43687b00, exit nh 0xfffb0006 Aug 21 05:19:30 05:19:30.748000:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.751685:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.751685:CID-0:RT:packet [212] ipid = 65436, @0x446a97d2 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9580, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: in_ifp Aug 21 05:19:30 05:19:30.751685:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.751685:CID-0:RT: flow session id 111854 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:mbuf 0x446a9580, exit nh 0x110010 Aug 21 05:19:30 05:19:30.751685:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9580 Aug 21 05:19:30 05:19:30.751685:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.753443:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.753443:CID-0:RT:packet [52] ipid = 63679, @0x436a9d1a Aug 21 05:19:30 05:19:30.753443:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x436a9b00, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.753443:CID-0:RT: flow session id 111854 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:30 05:19:30.753443:CID-0:RT:mbuf 0x436a9b00, exit nh 0xfffb0006 Aug 21 05:19:30 05:19:30.753443:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.823641:CID-0:RT:<192.168.1.9/49831->99.198.107.205/80;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.823641:CID-0:RT:packet [52] ipid = 53120, @0x4369e21a Aug 21 05:19:30 05:19:30.823641:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369e000, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: vlan.0:192.168.1.9/49831->99.198.107.205/80, tcp, flag 10 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: find flow: table 0x4f9a9078, hash 39086(0xffff), sa 192.168.1.9, da 99.198.107.205, sp 49831, dp 80, proto 6, tok 6 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.823641:CID-0:RT: flow session id 127380 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: vector bits 0x1002 vector 0x48cd7d28 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: tcp seq check. Aug 21 05:19:30 05:19:30.823641:CID-0:RT: tcp 3way refresh, is_half_open:0, is_fwauth:0 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: tcp flags 0x10, flag 0x10 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: refreshing session Aug 21 05:19:30 05:19:30.823641:CID-0:RT: Got ack, 192.168.1.9(49831)->99.198.107.205(80), natpflag 0x0, nspflag 0x21, 0x20, timeout=150 Aug 21 05:19:30 05:19:30.823641:CID-0:RT:flow_xlate_pak Aug 21 05:19:30 05:19:30.823641:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.823641:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.823641:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:30 05:19:30.823641:CID-0:RT:mbuf 0x4369e000, exit nh 0xfffa0006 Aug 21 05:19:30 05:19:30.823641:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:30 05:19:30.825044:CID-0:RT:<192.168.1.9/49831->99.198.107.205/80;6> matched filter MatchTraffic: Aug 21 05:19:30 05:19:30.825044:CID-0:RT:packet [949] ipid = 51766, @0x4368c11a Aug 21 05:19:30 05:19:30.825044:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4368bf00, rtbl_idx = 0 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: vlan.0:192.168.1.9/49831->99.198.107.205/80, tcp, flag 18 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: find flow: table 0x4f9a9078, hash 39086(0xffff), sa 192.168.1.9, da 99.198.107.205, sp 49831, dp 80, proto 6, tok 6 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: flow got session. Aug 21 05:19:30 05:19:30.825044:CID-0:RT: flow session id 127380 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: vector bits 0x1002 vector 0x48cd7d28 Aug 21 05:19:30 05:19:30.825044:CID-0:RT: tcp seq check. Aug 21 05:19:30 05:19:30.825044:CID-0:RT:flow_xlate_pak Aug 21 05:19:30 05:19:30.825044:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.825044:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:30 05:19:30.825044:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:31 05:19:30.825044:CID-0:RT:mbuf 0x4368bf00, exit nh 0xfffa0006 Aug 21 05:19:31 05:19:30.825044:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.008766:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.008766:CID-0:RT:packet [100] ipid = 29849, @0x4368969a Aug 21 05:19:31 05:19:31.008766:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43689480, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 18 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.008766:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.008766:CID-0:RT:mbuf 0x43689480, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.008766:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.069329:CID-0:RT:<192.168.1.9/22->8.8.8.8/5069;1> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.069329:CID-0:RT:packet [84] ipid = 40214, @0x4369af1a Aug 21 05:19:31 05:19:31.069329:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369ad00, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: vlan.0:192.168.1.9->8.8.8.8, icmp, (8/0) Aug 21 05:19:31 05:19:31.069329:CID-0:RT: find flow: table 0x4f9a9078, hash 18343(0xffff), sa 192.168.1.9, da 8.8.8.8, sp 22, dp 5069, proto 1, tok 6 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: no session found, start first path. in_tunnel - 0x0, from_cp_flag - 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow_first_create_session Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow_first_in_dst_nat: in , out dst_adr 8.8.8.8, sp 22, dp 5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: chose interface vlan.0 as incoming nat if. Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 8.8.8.8(5069) Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.1.9, x_dst_ip 8.8.8.8, in ifp vlan.0, out ifp N/A sp 22, dp 5069, ip_proto 1, tos 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:Doing DESTINATION addr route-lookup Aug 21 05:19:31 05:19:31.069329:CID-0:RT: routed (x_dst_ip 8.8.8.8) from trust (vlan.0 in 0) to pp0.0, Next-hop: 8.8.8.8 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_policy_search: policy search from zone trust-> zone untrust (0x0,0x1613cd,0x13cd) Aug 21 05:19:31 05:19:31.069329:CID-0:RT:Policy lkup: vsys 0 zone(6:trust) -> zone(7:untrust) scope:0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: 192.168.1.9/2048 -> 8.8.8.8/59304 proto 1 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: app 0, timeout 60s, curr ageout 60s Aug 21 05:19:31 05:19:31.069329:CID-0:RT: permitted by policy default-permit(6) Aug 21 05:19:31 05:19:31.069329:CID-0:RT: packet passed, Permitted by policy. Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp 192.168.1.9/22 -> 8.8.8.8/5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/22 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.9, dst-ip 8.8.8.8, dst-port 5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 7 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_src_rule_match: src nat rule found: id 1, pos-id 1, pool id 2 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/2, pst_nat: False. Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp 192.168.1.9/22 -> 8.8.8.8/5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/22 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_dip_by_host: pst_nat = False, lsys_id = 0, platform = 1, dip_id = 0x2,dst_port = 5069, ptr = 0x4fa2a290, sess_id = 0x0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_dip_by_host:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_local_dip_by_host: src nat ip/port is allocated locally. src_port 22 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_dip_by_host_cp: lsys id: 0, src_port 0, dip id: 0x2 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_dip_by_host_cp:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_dip_by_host_cp: get xlated ip/port (115.64.136.32/31589), xlation flag (1), xlation pool id (0x2) from JSF Aug 21 05:19:31 05:19:31.069329:CID-0:RT: dip id = 2/0, 192.168.1.9/22->115.64.136.32/31589 protocol 58 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: choose interface pp0.0 as outgoing phy if Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:is_loop_pak: No loop: on ifp: pp0.0, addr: 8.8.8.8, rtt_idx:0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf : Alloc sess plugin info for session 127382 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:[JSF]Normal interest check. regd plugins 19, enabled impl mask 0x0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 2, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 3, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 5, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 6, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 7, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 8, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 12, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 15, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:+++++++++++jsf_test_plugin_data_evh: 3 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 16, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 22, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 23, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 26, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 27, svc_req 0x0, impl mask 0x0. rc 2 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf int check: plugin id 28, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:[JSF]Plugins(0x0, count 0) enabled for session = 0, impli mask(0x0), post_nat cnt 127382 svc req(0x0) Aug 21 05:19:31 05:19:31.069329:CID-0:RT:-jsf : no plugin interested for session 127382, free sess plugin info Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_service_lookup(): natp(0x56ef05e8): app_id, 0(0). Aug 21 05:19:31 05:19:31.069329:CID-0:RT: service lookup identified service 0. Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow_first_final_check: in , out Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_final_check: flow_set_xlate_vector. Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_first_complete_session, pak_ptr: 0x4fa2a290, nsp: 0x56ef05e8, in_tunnel: 0x0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:construct v4 vector for nsp2 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: existing vector list 0x1200-0x48cf5910. Aug 21 05:19:31 05:19:31.069329:CID-0:RT: Session (id:127382) created for first pak 1200 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow_first_install_session======> 0x56ef05e8 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: nsp 0x56ef05e8, nsp2 0x56ef0668 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: make_nsp_ready_no_resolve() Aug 21 05:19:31 05:19:31.069329:CID-0:RT: route lookup: dest-ip 192.168.1.9 orig ifp vlan.0 output_ifp vlan.0 orig-zone 6 out-zone 6 vsd 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: route to 192.168.1.9 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:no need update ha Aug 21 05:19:31 05:19:31.069329:CID-0:RT:Installing c2s NP session wing Aug 21 05:19:31 05:19:31.069329:CID-0:RT:Installing s2c NP session wing Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.069329:CID-0:RT: flow session id 127382 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: vector bits 0x1200 vector 0x48cf5910 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_xlate_pak Aug 21 05:19:31 05:19:31.069329:CID-0:RT:flow_handle_icmp_xlate Aug 21 05:19:31 05:19:31.069329:CID-0:RT:xlate_icmp_pak Aug 21 05:19:31 05:19:31.069329:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:31 05:19:31.069329:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:31 05:19:31.069329:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:mbuf 0x4369ad00, exit nh 0xfffa0006 Aug 21 05:19:31 05:19:31.069329:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/31589 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp2 115.64.136.32/31589 -> 0.0.0.0/5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 8.8.8.8, dst-ip 115.64.136.32, dst-port 31589 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 2, to-id 2 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/31589 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat xlate nsp2 115.64.136.32/31589 -> 0.0.0.0/5069 Aug 21 05:19:31 05:19:31.069329:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:31 05:19:31.120280:CID-0:RT:<192.168.1.9/49831->99.198.107.205/80;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.120280:CID-0:RT:packet [52] ipid = 48304, @0x4369739a Aug 21 05:19:31 05:19:31.120280:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43697180, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: vlan.0:192.168.1.9/49831->99.198.107.205/80, tcp, flag 10 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: find flow: table 0x4f9a9078, hash 39086(0xffff), sa 192.168.1.9, da 99.198.107.205, sp 49831, dp 80, proto 6, tok 6 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.120280:CID-0:RT: flow session id 127380 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: vector bits 0x1002 vector 0x48cd7d28 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: tcp seq check. Aug 21 05:19:31 05:19:31.120280:CID-0:RT:flow_xlate_pak Aug 21 05:19:31 05:19:31.120280:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:31 05:19:31.120280:CID-0:RT: post addr xlation: 115.64.136.32->99.198.107.205. Aug 21 05:19:31 05:19:31.120280:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:31 05:19:31.120280:CID-0:RT:mbuf 0x43697180, exit nh 0xfffa0006 Aug 21 05:19:31 05:19:31.120280:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.127842:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.127842:CID-0:RT:packet [100] ipid = 65438, @0x446a22d2 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a2080, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.127842:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.127842:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:mbuf 0x446a2080, exit nh 0x110010 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a2080 Aug 21 05:19:31 05:19:31.127842:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat xlate nsp 192.168.1.1/51667 -> 192.168.1.13/21 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat xlate nsp2 192.168.1.13/21 -> 0.0.0.0/51667 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.1, dst-ip 192.168.1.13, dst-port 21 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_rule_match_ctx_n_port: protocol 6 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 2, to-id 6 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat xlate nsp 192.168.1.1/51667 -> 192.168.1.13/21 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat xlate nsp2 192.168.1.13/21 -> 0.0.0.0/51667 Aug 21 05:19:31 05:19:31.127842:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:31 05:19:31.129536:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.129536:CID-0:RT:packet [52] ipid = 43740, @0x4369a69a Aug 21 05:19:31 05:19:31.129536:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369a480, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.129536:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.129536:CID-0:RT:mbuf 0x4369a480, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.129536:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.392721:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.408507:CID-0:RT:packet [148] ipid = 65457, @0x446aa0d2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9e80, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:mbuf 0x446a9e80, exit nh 0x110010 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9e80 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.408507:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.408507:CID-0:RT:packet [116] ipid = 65458, @0x446a97d2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9580, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:mbuf 0x446a9580, exit nh 0x110010 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9580 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.408507:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.408507:CID-0:RT:packet [100] ipid = 65459, @0x446a22d2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a2080, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.408507:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:mbuf 0x446a2080, exit nh 0x110010 Aug 21 05:19:31 05:19:31.408507:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a2080 Aug 21 05:19:31 05:19:31.408507:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.409924:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.409924:CID-0:RT:packet [148] ipid = 65461, @0x446a97d2 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9580, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.409924:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.409924:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:mbuf 0x446a9580, exit nh 0x110010 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9580 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.409924:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.409924:CID-0:RT:packet [116] ipid = 65462, @0x446aa0d2 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9e80, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.409924:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.409924:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:mbuf 0x446a9e80, exit nh 0x110010 Aug 21 05:19:31 05:19:31.409924:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9e80 Aug 21 05:19:31 05:19:31.409924:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.410868:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.410868:CID-0:RT:packet [100] ipid = 65463, @0x446ab2d2 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446ab080, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.410868:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.410868:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:mbuf 0x446ab080, exit nh 0x110010 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446ab080 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.410868:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.410868:CID-0:RT:packet [100] ipid = 65464, @0x446aa0d2 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9e80, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.410868:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.410868:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:mbuf 0x446a9e80, exit nh 0x110010 Aug 21 05:19:31 05:19:31.410868:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9e80 Aug 21 05:19:31 05:19:31.410868:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.431258:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.431258:CID-0:RT:packet [100] ipid = 65486, @0x446ab2d2 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446ab080, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.431258:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.431258:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:mbuf 0x446ab080, exit nh 0x110010 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446ab080 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.431258:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.431258:CID-0:RT:packet [116] ipid = 65487, @0x446a97d2 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a9580, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: in_ifp Aug 21 05:19:31 05:19:31.431258:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.431258:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:mbuf 0x446a9580, exit nh 0x110010 Aug 21 05:19:31 05:19:31.431258:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a9580 Aug 21 05:19:31 05:19:31.431258:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.469657:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.469657:CID-0:RT:packet [52] ipid = 17617, @0x436a619a Aug 21 05:19:31 05:19:31.469657:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x436a5f80, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.469657:CID-0:RT:mbuf 0x436a5f80, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.469657:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.469657:CID-0:RT:packet [52] ipid = 34883, @0x43688e1a Aug 21 05:19:31 05:19:31.469657:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43688c00, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.469657:CID-0:RT:mbuf 0x43688c00, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.469657:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.469657:CID-0:RT:packet [52] ipid = 47134, @0x4369fb9a Aug 21 05:19:31 05:19:31.469657:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369f980, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.469657:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.469657:CID-0:RT:mbuf 0x4369f980, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.469657:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.471001:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.471001:CID-0:RT:packet [52] ipid = 64685, @0x4369629a Aug 21 05:19:31 05:19:31.471001:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43696080, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.471001:CID-0:RT:mbuf 0x43696080, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.471001:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.471001:CID-0:RT:packet [52] ipid = 47339, @0x4368859a Aug 21 05:19:31 05:19:31.471001:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43688380, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.471001:CID-0:RT:mbuf 0x43688380, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.471001:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.471001:CID-0:RT:packet [52] ipid = 44505, @0x4368969a Aug 21 05:19:31 05:19:31.471001:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x43689480, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.471001:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.471001:CID-0:RT:mbuf 0x43689480, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.471001:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.472216:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.472216:CID-0:RT:packet [52] ipid = 26094, @0x436a151a Aug 21 05:19:31 05:19:31.472216:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x436a1300, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.472216:CID-0:RT:mbuf 0x436a1300, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.472216:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.472216:CID-0:RT:packet [52] ipid = 15863, @0x4368c11a Aug 21 05:19:31 05:19:31.472216:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4368bf00, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.472216:CID-0:RT:mbuf 0x4368bf00, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:31 05:19:31.472216:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:31 05:19:31.472216:CID-0:RT:packet [52] ipid = 17853, @0x4369e21a Aug 21 05:19:31 05:19:31.472216:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369e000, rtbl_idx = 0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow got session. Aug 21 05:19:31 05:19:31.472216:CID-0:RT: flow session id 111854 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:31 05:19:31.472216:CID-0:RT:mbuf 0x4369e000, exit nh 0xfffb0006 Aug 21 05:19:31 05:19:31.472216:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat xlate nsp 192.168.1.13/39182 -> 192.168.1.1/53 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/39182 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.13, dst-ip 192.168.1.1, dst-port 53 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_rule_match_ctx_n_port: protocol 17 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 2 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat xlate nsp 192.168.1.13/39182 -> 192.168.1.1/53 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/39182 Aug 21 05:19:32 05:19:31.985572:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat xlate nsp 192.168.1.13/41014 -> 192.168.1.1/53 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/41014 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.13, dst-ip 192.168.1.1, dst-port 53 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_rule_match_ctx_n_port: protocol 17 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 2 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat xlate nsp 192.168.1.13/41014 -> 192.168.1.1/53 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat xlate nsp2 192.168.1.1/53 -> 0.0.0.0/41014 Aug 21 05:19:32 05:19:31.991548:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:<192.168.1.9/23->8.8.8.8/5069;1> matched filter MatchTraffic: Aug 21 05:19:32 05:19:32.071170:CID-0:RT:packet [84] ipid = 23238, @0x436ad89a Aug 21 05:19:32 05:19:32.071170:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x436ad680, rtbl_idx = 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: vlan.0:192.168.1.9->8.8.8.8, icmp, (8/0) Aug 21 05:19:32 05:19:32.071170:CID-0:RT: find flow: table 0x4f9a9078, hash 26327(0xffff), sa 192.168.1.9, da 8.8.8.8, sp 23, dp 5069, proto 1, tok 6 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: no session found, start first path. in_tunnel - 0x0, from_cp_flag - 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow_first_create_session Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow_first_in_dst_nat: in , out dst_adr 8.8.8.8, sp 23, dp 5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: chose interface vlan.0 as incoming nat if. Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_dst_xlate_ip_port: nat obj not found or no rule configured for lsys with id 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 8.8.8.8(5069) Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.1.9, x_dst_ip 8.8.8.8, in ifp vlan.0, out ifp N/A sp 23, dp 5069, ip_proto 1, tos 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:Doing DESTINATION addr route-lookup Aug 21 05:19:32 05:19:32.071170:CID-0:RT: routed (x_dst_ip 8.8.8.8) from trust (vlan.0 in 0) to pp0.0, Next-hop: 8.8.8.8 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_policy_search: policy search from zone trust-> zone untrust (0x0,0x1713cd,0x13cd) Aug 21 05:19:32 05:19:32.071170:CID-0:RT:Policy lkup: vsys 0 zone(6:trust) -> zone(7:untrust) scope:0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: 192.168.1.9/2048 -> 8.8.8.8/58147 proto 1 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: app 0, timeout 60s, curr ageout 60s Aug 21 05:19:32 05:19:32.071170:CID-0:RT: permitted by policy default-permit(6) Aug 21 05:19:32 05:19:32.071170:CID-0:RT: packet passed, Permitted by policy. Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp 192.168.1.9/23 -> 8.8.8.8/5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/23 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 192.168.1.9, dst-ip 8.8.8.8, dst-port 5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 6, to-id 7 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_src_rule_match: src nat rule found: id 1, pos-id 1, pool id 2 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/2, pst_nat: False. Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp 192.168.1.9/23 -> 8.8.8.8/5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp2 8.8.8.8/5069 -> 0.0.0.0/23 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_dip_by_host: pst_nat = False, lsys_id = 0, platform = 1, dip_id = 0x2,dst_port = 5069, ptr = 0x4fa2a290, sess_id = 0x0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_dip_by_host:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_local_dip_by_host: src nat ip/port is allocated locally. src_port 23 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_dip_by_host_cp: lsys id: 0, src_port 0, dip id: 0x2 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_dip_by_host_cp:src_ip 192.168.1.9 dst_ip 8.8.8.8 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_dip_by_host_cp: get xlated ip/port (115.64.136.32/15714), xlation flag (1), xlation pool id (0x2) from JSF Aug 21 05:19:32 05:19:32.071170:CID-0:RT: dip id = 2/0, 192.168.1.9/23->115.64.136.32/15714 protocol 58 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: choose interface pp0.0 as outgoing phy if Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:is_loop_pak: No loop: on ifp: pp0.0, addr: 8.8.8.8, rtt_idx:0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf : Alloc sess plugin info for session 127388 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:[JSF]Normal interest check. regd plugins 19, enabled impl mask 0x0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 2, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 3, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 5, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 6, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 7, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 8, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 12, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 15, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:+++++++++++jsf_test_plugin_data_evh: 3 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 16, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 22, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 23, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 26, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 27, svc_req 0x0, impl mask 0x0. rc 2 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf int check: plugin id 28, svc_req 0x0, impl mask 0x0. rc 4 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:[JSF]Plugins(0x0, count 0) enabled for session = 0, impli mask(0x0), post_nat cnt 127388 svc req(0x0) Aug 21 05:19:32 05:19:32.071170:CID-0:RT:-jsf : no plugin interested for session 127388, free sess plugin info Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_service_lookup(): natp(0x56ef1098): app_id, 0(0). Aug 21 05:19:32 05:19:32.071170:CID-0:RT: service lookup identified service 0. Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow_first_final_check: in , out Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_final_check: flow_set_xlate_vector. Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_first_complete_session, pak_ptr: 0x4fa2a290, nsp: 0x56ef1098, in_tunnel: 0x0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:construct v4 vector for nsp2 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: existing vector list 0x1200-0x48cf5910. Aug 21 05:19:32 05:19:32.071170:CID-0:RT: Session (id:127388) created for first pak 1200 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow_first_install_session======> 0x56ef1098 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: nsp 0x56ef1098, nsp2 0x56ef1118 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: make_nsp_ready_no_resolve() Aug 21 05:19:32 05:19:32.071170:CID-0:RT: route lookup: dest-ip 192.168.1.9 orig ifp vlan.0 output_ifp vlan.0 orig-zone 6 out-zone 6 vsd 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: route to 192.168.1.9 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:no need update ha Aug 21 05:19:32 05:19:32.071170:CID-0:RT:Installing c2s NP session wing Aug 21 05:19:32 05:19:32.071170:CID-0:RT:Installing s2c NP session wing Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow got session. Aug 21 05:19:32 05:19:32.071170:CID-0:RT: flow session id 127388 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: vector bits 0x1200 vector 0x48cf5910 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_xlate_pak Aug 21 05:19:32 05:19:32.071170:CID-0:RT:flow_handle_icmp_xlate Aug 21 05:19:32 05:19:32.071170:CID-0:RT:xlate_icmp_pak Aug 21 05:19:32 05:19:32.071170:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:32 05:19:32.071170:CID-0:RT: post addr xlation: 115.64.136.32->8.8.8.8. Aug 21 05:19:32 05:19:32.071170:CID-0:RT:skip pre-frag: is_tunnel_if- 0, is_if_mtu_configured- 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:mbuf 0x436ad680, exit nh 0xfffa0006 Aug 21 05:19:32 05:19:32.071170:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/15714 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp2 115.64.136.32/15714 -> 0.0.0.0/5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 8.8.8.8, dst-ip 115.64.136.32, dst-port 15714 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_rule_match_ctx_n_port: protocol 1 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 2, to-id 2 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp 8.8.8.8/5069 -> 115.64.136.32/15714 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat xlate nsp2 115.64.136.32/15714 -> 0.0.0.0/5069 Aug 21 05:19:32 05:19:32.071170:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:jsf sess close notify Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_ipv4_del_flow: sess 126898, in hash 32 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_ipv4_del_flow: sess 126898, in hash 32 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: sid 126905, src dip id 2, dst dip id 0, pst nat: 0, src pst nat: 0, dst pst nat:0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: Normal dip release: sid 126905, dip id 2, pst dst dip id 0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session: release source nat [lsysid:0]: pst_nat = 0x0, nat_info = 0x56ebb5a8, did = 2, pport = 29990, port-num 1flag = 0x0, on platform 1, lsys 0, Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session: Release source nat [0]: did=2 pport=29990 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: sid 126903, src dip id 2, dst dip id 0, pst nat: 0, src pst nat: 0, dst pst nat:0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: Normal dip release: sid 126903, dip id 2, pst dst dip id 0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session: release source nat [lsysid:0]: pst_nat = 0x0, nat_info = 0x56ebb218, did = 2, pport = 8689, port-num 1flag = 0x0, on platform 1, lsys 0, Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session: Release source nat [0]: did=2 pport=8689 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: sid 126899, src dip id 2, dst dip id 0, pst nat: 0, src pst nat: 0, dst pst nat:0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: Normal dip release: sid 126899, dip id 2, pst dst dip id 0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session: release source nat [lsysid:0]: pst_nat = 0x0, nat_info = 0x56ebaaf8, did = 2, pport = 7020, port-num 1flag = 0x0, on platform 1, lsys 0, Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session: Release source nat [0]: did=2 pport=7020 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: sid 126902, src dip id 2, dst dip id 0, pst nat: 0, src pst nat: 0, dst pst nat:0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:flow_nat_release_dip_by_session_with_natp: Normal dip release: sid 126902, dip id 2, pst dst dip id 0 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session: release source nat [lsysid:0]: pst_nat = 0x0, nat_info = 0x56ebb050, did = 2, pport = 28014, port-num 1flag = 0x0, on platform 1, lsys 0, Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session: Release source nat [0]: did=2 pport=28014 Aug 21 05:19:32 05:19:32.205439:CID-0:RT:nat_release_local_dip_by_session:src_ip 192.168.1.9 dip 115.64.136.32 dst_ip 37.48.66.130 Aug 21 05:19:32 05:19:32.748695:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:32 05:19:32.748695:CID-0:RT:packet [100] ipid = 27835, @0x436a9d1a Aug 21 05:19:32 05:19:32.748695:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x436a9b00, rtbl_idx = 0 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 18 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: flow got session. Aug 21 05:19:32 05:19:32.748695:CID-0:RT: flow session id 111854 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: refreshing session Aug 21 05:19:32 05:19:32.748695:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:32 05:19:32.748695:CID-0:RT:mbuf 0x436a9b00, exit nh 0xfffb0006 Aug 21 05:19:32 05:19:32.748695:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:32 05:19:32.752192:CID-0:RT:<192.168.1.1/22->192.168.1.9/64804;6> matched filter MatchTraffic: Aug 21 05:19:32 05:19:32.752192:CID-0:RT:packet [212] ipid = 65498, @0x446a3dd2 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 0, common flag 0x0, mbuf 0x446a3b80, rtbl_idx = 0 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: in_ifp Aug 21 05:19:32 05:19:32.752192:CID-0:RT:flow_process_pkt_exception: setting rtt in lpak to 0x66a25c50 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:Using vr id from pfe_tag with value= 0 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:Changing lpak->in_ifp from:.local..0 -> to:.local..0 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:Over-riding lpak->vsys with 0 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: .local..0:192.168.1.1/22->192.168.1.9/64804, tcp, flag 18 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: find flow: table 0x4f9a9078, hash 10008(0xffff), sa 192.168.1.1, da 192.168.1.9, sp 22, dp 64804, proto 6, tok 2 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: flow got session. Aug 21 05:19:32 05:19:32.752192:CID-0:RT: flow session id 111854 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:mbuf 0x446a3b80, exit nh 0x110010 Aug 21 05:19:32 05:19:32.752192:CID-0:RT:flow_process_pkt_exception: Freeing lpak 0x4fa29e98 associated with mbuf 0x446a3b80 Aug 21 05:19:32 05:19:32.752192:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:32 05:19:32.753803:CID-0:RT:<192.168.1.9/64804->192.168.1.1/22;6> matched filter MatchTraffic: Aug 21 05:19:32 05:19:32.753803:CID-0:RT:packet [52] ipid = 29539, @0x4369af1a Aug 21 05:19:32 05:19:32.753803:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 15, common flag 0x0, mbuf 0x4369ad00, rtbl_idx = 0 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: flow process pak fast ifl 82 in_ifp vlan.0 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: vlan.0:192.168.1.9/64804->192.168.1.1/22, tcp, flag 10 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: find flow: table 0x4f9a9078, hash 41130(0xffff), sa 192.168.1.9, da 192.168.1.1, sp 64804, dp 22, proto 6, tok 6 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: flow got session. Aug 21 05:19:32 05:19:32.753803:CID-0:RT: flow session id 111854 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: vector bits 0x2 vector 0x48cae120 Aug 21 05:19:32 05:19:32.753803:CID-0:RT:mbuf 0x4369ad00, exit nh 0xfffb0006 Aug 21 05:19:32 05:19:32.753803:CID-0:RT: ----- flow_process_pkt rc 0x0 (fp rc 0) Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_get_mapped_or_incoming_dip: no rule configured with lsys id 0 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_get_mapped_or_incoming_dip: diff 0, calls 0 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_get_rule_number: type 2, rule counter 0 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_get_hipped_ip: no rule configured Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat xlate nsp 115.64.136.32/22 -> 190.85.232.148/33748 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat xlate nsp2 190.85.232.148/33748 -> 0.0.0.0/22 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_src_rule_match: lsys 0, src-ip 115.64.136.32, dst-ip 190.85.232.148, dst-port 33748 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_proc_sorted_lists: src_min 1073741825, dst_min 1073741825 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_rule_match_ctx_n_port: protocol 6 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_rule_match_ctx_n_port: ctx-type 4, from-id 2, to-id 7 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_src_get_dip_id: rule NULL Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat xlate nsp 115.64.136.32/22 -> 190.85.232.148/33748 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat xlate nsp2 190.85.232.148/33748 -> 0.0.0.0/22 Aug 21 05:19:32 05:19:32.796321:CID-0:RT:nat_get_mipped_ip: no rule configured for lsys 0