Looking at SRX flow traces, there are a lot references to internal IDs. Without knowing what all these numbers mean, its hard to tell which configuration or additional services may adversely affect a flow.
Lets use the trace output as an example:
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:<192.168.50.251/46800->216.239.36.10/53;17> matched filter foo:
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:packet [80] ipid = 37701, @423ad69a
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:---- flow_process_pkt: (thd 1): flow_ctxt type 14, common flag 0x0, mbuf 0x423ad480, rtbl_idx = 0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: flow process pak fast ifl 70 in_ifp fe-0/0/1.0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: find flow: table 0x4cbec950, hash 38561(0xffff), sa 192.168.50.251, da 216.239.36.10, sp 46800, dp 53, proto 17, tok 6
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: flow_first_create_session
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: flow_first_in_dst_nat: in <fe-0/0/1.0>, out <N/A> dst_adr 216.239.36.10, sp 46800, dp 53
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: chose interface fe-0/0/1.0 as incoming nat if.
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:flow_first_rule_dst_xlate: DST no-xlate: 0.0.0.0(0) to 216.239.36.10(53)
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:flow_first_routing: vr_id 0, call flow_route_lookup(): src_ip 192.168.50.251, x_dst_ip 216.239.36.10, in ifp fe-0/0/1.0, out ifp N/A sp 46800, dp 53, ip_proto 17, tos 0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:Doing DESTINATION addr route-lookup
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: routed (x_dst_ip 216.239.36.10) from trust (fe-0/0/1.0 in 0) to fe-0/0/0.0, Next-hop: 84.196.0.1
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: policy search from zone trust-> zone untrust (0x0,0xb6d00035,0x35)
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: app 16, timeout 60s, curr ageout 60s
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:flow_first_src_xlate: nat_src_xlated: False, nat_src_xlate_failed: False
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:flow_first_src_xlate: src nat returns status: 1, rule/pool id: 1/2, pst_nat: False.
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: dip id = 2/0, 192.168.50.251/46800->84.196.14.21/22287 protocol 17
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: choose interface fe-0/0/0.0 as outgoing phy if
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:is_loop_pak: No loop: on ifp: fe-0/0/0.0, addr: 216.239.36.10, rtt_idx:0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:jsf sess interest check. regd plugins 19
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: Allocating plugin info block for 20 plugin(s) from OL
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 2, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 3, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 5, svc_req 0x4. rc 3
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:Add plugid:5 to int table at :0, fill hole:0, holes:0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 6, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 7, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 8, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 12, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:+++++++++++jsf_test_plugin_data_evh: 3
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 13, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 14, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 15, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 18, svc_req 0x0. rc 2
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT:-jsf int check: plugin id 19, svc_req 0x0. rc 4
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: Allocating plugin info block for 1 plugin(s) from OL
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: Attaching plugin 5, at index 0
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: Releasing plugin info block for 20 plugin(s) to OL
Feb 19 10:25:28 10:25:27.1062565:CID-0:RT: Plugins enabled for session = 1 (frwk svcs mask 0x0), post_nat cnt 0
...
So this packet is permitted by the policy, but "plugin 5" has been enabled for the session. The question is of course, what is this plugin? To my knowledge this information is not available in the CLI, but luckily we can ask the forwarding deamon directly using the following command:
admin@srx> request pfe execute target fwdd command "show usp plugins"
SENT: Ukern command: show usp plugins
GOT:
GOT: Number of plugins: 19
GOT: Plugin: id: 1, name: junos-syn-term
GOT: Plugin: id: 2, name: junos-screen-adapter
GOT: Plugin: id: 3, name: junos-fwauth-adapter
GOT: Plugin: id: 4, name: junos-syn-init
GOT: Plugin: id: 5, name: junos-appid-packet
GOT: Plugin: id: 6, name: junos-appfw
GOT: Plugin: id: 7, name: junos-idp
GOT: Plugin: id: 8, name: junos-uf
GOT: Plugin: id: 9, name: junos-tcp-svr-emul
GOT: Plugin: id: 10, name: junos-ssl-term
GOT: Plugin: id: 12, name: junos-captive-portal
GOT: Plugin: id: 13, name: junos-test
GOT: Plugin: id: 14, name: junos-alg
GOT: Plugin: id: 15, name: junos-utm
GOT: Plugin: id: 16, name: junos-ssl-init
GOT: Plugin: id: 17, name: junos-tcp-clt-emul
GOT: Plugin: id: 18, name: junos-uac
GOT: Plugin: id: 19, name: junos-utm-udp
LOCAL: End of file
So this mysterious plugin turns out to be appid, which I did indeed activate for testing purposes the other day. In this case it didn't cause any problems but when you see plugins being triggered, it always good to know what they are used for, they could indicate a configuration error.
Recent comments