Firewall rules ignored or overridden?
-
According to the logs, the rules causing the blocks are as follows:
The rule that triggered this action is:
@8(1000000106) block drop out log inet6 all label "Default deny rule IPv6"AND
The rule that triggered this action is:
@5(1000000103) block drop in log inet all label "Default deny rule IPv4"There are no floating rules except for some VOIP QoS rules created by the Traffic Shaper wizard which are completely unrelated. I removed the previous floating rule because I think we can all agree that this is not an Asymmetric Routing issue. The previous rule I created was the one listed in the document that was linked to which said to create a floating rule on the LAN for outbound traffic for IPv4 TCP 993 traffic with ANY flags and Sloppy State. I have also reverted the pass rule on the LAN for TCP 993 so that the advanced option ANY flags is removed and Sloppy State is back to keep.
-
If you think those are log spam, go to Status > System Logs, Settings tab and uncheck Log firewall default blocks.
-
While I agree that disabling logging of the default rule would remove these packets from the log, that doesn't really help. I would like to be able to see what packets are being blocked by the firewall and hiding all blocked packets just to get rid of the ones from port 993 is overkill. If the solution is to hide these packets from the log instead of passing them through the firewall, then I would want to create a more specific block rule that only matched these packets with no logging so that I could continue to see packets blocked by the default rule.
-
Your IMAP client is trying to use a connection after the state has been deleted for inactivity or it is otherwise misbehaving.
What isn't working other than the logs you are seeing?
The default timeout for an established TCP state is:
tcp.established 86400s
One whole day. With zero activity.
Not sure how long you think the states should be kept around but feel free to adjust that.
-
I'm fine with 1day but I suspect that sessions are closed after 1hr or less.
Where do you see that setting? I do not see an entry for tcp.established in /tmp/rules.debug. Also, is that the default setting when "Firewall Optimization Options" = Normal? Or is that for a different setting like conservative?
-
That is the setting for Normal.
This is an existing IMAP state for my mail client:
igb0_vlan223 tcp 192.0.2.96:143 <- 192.168.223.6:52466 ESTABLISHED:ESTABLISHED
[3857059653 + 131008] wscale 1 [3105376859 + 66608] wscale 5
age 94:39:32, expires in 23:59:54, 64046:44625 pkts, 11286281:32760196 bytes, rule 283
id: 00000000585fc42a creatorid: 5297d028
igb1 tcp 192.51.100.226:13887 (192.168.223.6:52466) -> 192.0.2.96:143 ESTABLISHED:ESTABLISHED
[3105376859 + 66608] wscale 5 [3857059653 + 131008] wscale 1
age 94:39:32, expires in 23:59:54, 64046:44625 pkts, 11286281:32760196 bytes, rule 211You can get the same thing with:
pfctl -vvss | grep -a2 mailserverip:993
Existing state timeouts:
pfctl -st
-
Immediately after seeing blocked packets in the log, I search for the server that was blocked using the command you provided.
pfctl -vvss | grep -a2 207.46.10.10:993igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65410 TIME_WAIT:TIME_WAIT
[1970684899 + 130688] wscale 0 [2546679215 + 5346] wscale 5
age 00:03:58, expires in 00:00:10, 24:19 pkts, 2348:5296 bytes, rule 143
id: 010000005822dc19 creatorid: fe76c013
igb0 tcp X.X.X.X:46700 (192.168.1.40:65410) -> 207.46.10.10:993 TIME_WAIT:TIME_WAIT
[2546679215 + 5346] wscale 5 [1970684899 + 130688] wscale 0
age 00:03:58, expires in 00:00:10, 24:19 pkts, 2348:5296 bytes, rule 88
id: 010000005822dc1a creatorid: fe76c013
igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65412 TIME_WAIT:TIME_WAIT
[3526826672 + 130731] wscale 0 [4281023330 + 5256] wscale 5
age 00:03:58, expires in 00:00:08, 21:16 pkts, 2102:4714 bytes, rule 143
id: 010000005822dc1b creatorid: fe76c013
igb0 tcp X.X.X.X:39701 (192.168.1.40:65412) -> 207.46.10.10:993 TIME_WAIT:TIME_WAIT
[4281023330 + 5256] wscale 5 [3526826672 + 130731] wscale 0
age 00:03:58, expires in 00:00:08, 21:16 pkts, 2102:4714 bytes, rule 88
–
age 00:07:20, expires in 23:52:41, 9:9 pkts, 1607:1079 bytes, rule 87
id: 0000000058236060 creatorid: fe76c013
igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65411 TIME_WAIT:TIME_WAIT
[3710722489 + 129846] wscale 0 [766408712 + 5526] wscale 5
age 00:03:58, expires in 00:00:07, 27:22 pkts, 2684:6934 bytes, rule 143
id: 00000000582360ae creatorid: fe76c013
igb0 tcp X.X.X.X:13185 (192.168.1.40:65411) -> 207.46.10.10:993 TIME_WAIT:TIME_WAIT
[766408712 + 5526] wscale 5 [3710722489 + 129846] wscale 0
age 00:03:58, expires in 00:00:07, 27:22 pkts, 2684:6934 bytes, rule 88
id: 00000000582360af creatorid: fe76c013
igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65413 TIME_WAIT:TIME_WAIT
[2772107354 + 130731] wscale 0 [1219956310 + 5256] wscale 5
age 00:03:58, expires in 00:00:11, 21:16 pkts, 2102:4714 bytes, rule 143
id: 00000000582360b0 creatorid: fe76c013
igb0 tcp X.X.X.X:49628 (192.168.1.40:65413) -> 207.46.10.10:993 TIME_WAIT:TIME_WAIT
[1219956310 + 5256] wscale 5 [2772107354 + 130731] wscale 0
age 00:03:58, expires in 00:00:11, 21:16 pkts, 2102:4714 bytes, rule 88
–
age 00:02:10, expires in 00:00:07, 11:10 pkts, 1193:1059 bytes, rule 88
id: 00000000582360d3 creatorid: fe76c013
igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65417 ESTABLISHED:ESTABLISHED
[3804055570 + 130731] wscale 0 [4282722200 + 5256] wscale 5
age 00:02:02, expires in 23:58:01, 21:16 pkts, 2102:4726 bytes, rule 143
id: 00000000582360d6 creatorid: fe76c013
igb0 tcp X.X.X.X:31046 (192.168.1.40:65417) -> 207.46.10.10:993 ESTABLISHED:ESTABLISHED
[4282722200 + 5256] wscale 5 [3804055570 + 130731] wscale 0
age 00:02:02, expires in 23:58:01, 21:16 pkts, 2102:4726 bytes, rule 88The established connections have the expected 24hr session time. The waiting connections have about 4min. Several minutes later if I check the state again with the command, all of the sessions are closed except for a few sessions about to time out.
igb1 tcp 207.46.10.10:993 <- 192.168.1.40:65417 TIME_WAIT:TIME_WAIT
[3804055570 + 130731] wscale 0 [4282722200 + 5256] wscale 5
age 00:03:59, expires in 00:00:05, 21:17 pkts, 2102:4766 bytes, rule 143
id: 00000000582360d6 creatorid: fe76c013
igb0 tcp X.X.X.X:31046 (192.168.1.40:65417) -> 207.46.10.10:993 TIME_WAIT:TIME_WAIT
[4282722200 + 5256] wscale 5 [3804055570 + 130731] wscale 0
age 00:03:59, expires in 00:00:05, 21:17 pkts, 2102:4766 bytes, rule 88 -
There is no explanation but that your client or the server is closing them.
You will have to packet capture to see what's actually happening.
-
There only two reason states get closed short of a reboot or someone killing them via PFSense management or custom package. Time out or a packet that tells the connection to end, RST or FIN. It seems the timeout is not the case. I could guess at what the issue is, but I wouldn't want to be wrong.
-
After pouring over the logs I can now confirm that it is not just one MUA client or host that is exhibiting this issue.
Device 1: OS X 10.12.1 using Thunderbird 45.4.0 for the mail client connecting to several IMAP servers including gmail.
Device 2: iOS 10.1.1 using the native Mail application for the client connecting to several IMAP servers including gmail.The host OS's are different, the mail clients are different, and the mail servers are different. The only common denominator for these blocked packets are the pfsense firewall.
I'm not sure how the packet capture is providing insight into why pfsense is blocking these packets. I see TCP 993 connections being opened and closed. But only pfsense knows why it decided to drop some of the packets. Unfortunately pfsense only logs that the "Default deny rule IPv6" (or IPv4) rule was applied. That doesn't make it clear why the explicit pass rules for TCP 993 aren't being applied and I'm not sure what I'm looking for in the packet captures to tell me that. Perhaps there is more aggressive logging that can be enabled?
As for blaming something outside of pfsense, it seems unlikely now that I have two different devices with the same issue. If we are saying the issue is not pfsense, then that means that two separate mail servers such as google's gmail and microsoft's office365 both have the same protocol flaw showing up in their TCP sessions. Or that both Thunderbird and iOS Mail with two different code bases have the same flaw. Similarly that could mean both OS X and iOS having the same networking flaw, however I will grant that this last theory might be possible since OS X and iOS do share some code. It is far more likely though that the one firewall filtering all of the traffic for these two stacks has some aggressive setting or edge case bug that is dropping packets.
Any suggestions are appreciated.
-
No, only the client and server know why the connection is closed. All the firewall cares about is that the two parties on either side decided to close the connection.
pfSense is only logging the firewall exceptions because the client and server decided to close the connection then one of them decided to try to pass more traffic over the closed state.
Packet capture. Who is closing the connection?
-
" I see TCP 993 connections being opened and closed."
Post up this sniff.. As Derelict stated if client or server is sending fin?? Did the other ack with a fin as well.. Fin does not mean the connection has to be closed, it is just stating hey I am done, are you done too?
You really need to see the sniff of the conversation to figure out what is going on. If you have conversation being closed and then still trying to talk on it that is a problem. Because yes when the firewall see's that devices closed their conversation he will remove the state, and until his sees a new conversation with syn, those packets would be out of state and dropped.
-
Okay, I've made some progress but the issue is still not resolved.
From the pfsense terminal:
telnet imap.gmail.com 993; //Successful connection
telnet imap-mail.outlook.com 993; //Successful connection
telnet imap.mail.yahoo.com 993; //Successful connection
telent imap.comcast.net 993; //Successful connection
telnet imap.aol.com 993; //Successful connectionFrom any workstation:
telnet imap.gmail.com 993; //Successful connection
telnet imap-mail.outlook.com 993; //Connection fails
telnet imap.mail.yahoo.com 993; //Connection fails
telent imap.comcast.net 993; //Successful connection
telnet imap.aol.com 993; //Connection failsFor IMAP servers that fail, a packet capture on the LAN shows the following:
1. Initial Syn packet from the workstation
2. Followed by a tcp retransmission to the same IMAP server 1sec later
3. Every 1sec another retransmission occursIt looks like pfsense silently drops a packet so the connection never succeeds. The strange thing is that this doesn't occur for all IMAP servers.
-
What magical packages like pfblocker, snort, suricata, squid, and squidguard are you running?
-
So your saying the packet never goes out the wan? But you see it on the lan of pfsense..
-
No relevant packages installed. Just Status_Traffic_Totals for bandwidth stats.
I just performed a packet capture from the WAN interface and I am seeing tcp retransmissions from the IMAP server to m public IP. It looks like only the SYN packet makes it out. After that the SYN/ACK gets dropped so both sides keep retransmitting. The workstation sends SYNs and the IMAP server sends SYN/ACKs.
Also, pfsense logs the blocked packet sometimes. When it does, it is listed as:
The rule that triggered this action is:
@5(1000000103) block drop in log inet all label "Default deny rule IPv4"My LAN Firewall rule to pass IPv4+6 TCP out to port 993 should implicitly let this traffic back in. It is letting the SYN out but the implied pass for the SYN/ACK back in is not being respected.
-
Note that I did have packages installed in the past however I have since removed them and they reported that the removal was successful. So unless package removal is totally broken, then there should be no package filtering. This should be purely a pfsense filtering issue.
-
Get the IP address of the server and while all that is going on, what states do you have in Diagnostics > States?. You can filter on the IMAP server IP address there. That will catch both WAN and LAN states.
No, packages removed should be OK.
-
See image.
-
If pfsense does not see the syn,ack back the state would never go into established and would time out in by default 30 seconds. Then packets after that would be dropped by the default rule because there would be no state.
It could be less than 30 sec if you messed with the setting on the firewall..
"After that the SYN/ACK gets dropped so both sides keep retransmitting."
Gets dropped where? Your saying you see this syn,ack on your wan sniff??
