Hanging LAN in KVM Pfsense

ilya.rockitin

New Member
Jul 1, 2015
2
0
1
Good day, friends.
Sorry for long post, but it is because of big logs.

System Configuration
Pfsense 2.2.1-RELEASE (i386)
built on Fri Mar 13 08:16:53 CDT 2015
FreeBSD 10.1-RELEASE-p6
Proxmox 3.2-1 1933730b

So Pfsense works in a single KVM.
There are two NIC, ISP delivers externel IP with DHCP server (static IP - M.A.C address).

So the network config (/etc/network/interfaces) (Proxmox):
Code:
# network interface settings
auto lo
iface lo inet loopback

iface eth0 inet manual

iface eth1 inet manual

auto vmbr0
iface vmbr0 inet static
    address  188.113.156.235
    netmask  255.255.255.0
    gateway  188.113.156.1
    bridge_ports eth0
    bridge_stp off
    bridge_fd 0


auto vmbr1
iface vmbr1 inet static
    address  192.168.0.7
    netmask  255.255.255.0
    # gateway  192.168.0.1
    bridge_ports eth1
    bridge_stp off
    bridge_fd 0
The network config (Pfsense) - ifconfig -a:

Code:
em0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric 0 mtu 1500
    options=209b<RXCSUM,TXCSUM,VLAN_MTU,VLAN_HWTAGGING,VLAN_HWCSUM,WOL_MAGIC>
    ether 9e:32:a0:9c:7c:91
    inet6 fe80::9c32:a0ff:fe9c:7c91%em0 prefixlen 64 scopeid 0x1 
    inet 188.113.156.235 netmask 0xffffff00 broadcast 188.113.156.255 
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
    media: Ethernet autoselect (1000baseT <full-duplex>)
    status: active
em1: flags=88843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST,STATICARP> metric 0 mtu 1500
    options=209b<RXCSUM,TXCSUM,VLAN_MTU,VLAN_HWTAGGING,VLAN_HWCSUM,WOL_MAGIC>
    ether 0e:0e:5f:44:9c:a1
    inet6 fe80::c0e:5fff:fe44:9ca1%em1 prefixlen 64 scopeid 0x2 
    inet 192.168.0.1 netmask 0xffffff00 broadcast 192.168.0.255 
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
    media: Ethernet autoselect (1000baseT <full-duplex>)
    status: active
pflog0: flags=100<PROMISC> metric 0 mtu 33172
pfsync0: flags=0<> metric 0 mtu 1500
    syncpeer: 224.0.0.240 maxupd: 128 defer: on
    syncok: 1
lo0: flags=8049<UP,LOOPBACK,RUNNING,MULTICAST> metric 0 mtu 16384
    options=600003<RXCSUM,TXCSUM,RXCSUM_IPV6,TXCSUM_IPV6>
    inet 127.0.0.1 netmask 0xff000000 
    inet6 ::1 prefixlen 128 
    inet6 fe80::1%lo0 prefixlen 64 scopeid 0x5 
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
enc0: flags=0<> metric 0 mtu 1536
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd0: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd1: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd2: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd3: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd4: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd5: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd6: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
pptpd7: flags=8890<POINTOPOINT,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>

Where eth0/vmb0 is WLAN interface, eth1/vmb1 is LAN interface.
From time to time Pfsense LAN interfase doesn't respond and there is nothing causes, no extraordinary errors, i base on logs of both the systems.
More than that it don't want up after first reboot :)
I use the following link to try fix hanging (http://forum.proxmox.com/threads/2020-Proxmox-Pfsense-working-setup-solved-2-NIC), I have just done it and I test now. :) May be it works.
But I would like to know what is the causes to hang?
Does the proxmox have correct settings of bridges?

I suspect that hanging is because of proxmox config, because Pfsense external NIC (eth0) respons to ping and etc in hanging behavior, i can connect to it via ssh, but internal NIC (eth1) has no life.
While I was writing the message it hanged and I got the following errors (proxmox):

Code:
2015-07-01 15:06:28    Cron.Info    192.168.0.7    Jul  1 16:07:01 teplichnii /USR/SBIN/CRON[3873]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:06:28    System0.Info    192.168.0.7    Jul  1 16:07:01 teplichnii CRON[3872]: pam_unix(cron:session): session closed for user root
2015-07-01 15:07:17    Daemon.Debug    192.168.0.7    Jul  1 16:07:50 teplichnii rrdcached[2528]: flushing old values
2015-07-01 15:07:17    Daemon.Debug    192.168.0.7    Jul  1 16:07:50 teplichnii rrdcached[2528]: rotating journals
2015-07-01 15:07:17    Daemon.Debug    192.168.0.7    Jul  1 16:07:50 teplichnii rrdcached[2528]: started new journal /var/lib/rrdcached/journal/rrd.journal.1435727270.820260
2015-07-01 15:07:28    System0.Info    192.168.0.7    Jul  1 16:08:01 teplichnii CRON[3887]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:07:28    Cron.Info    192.168.0.7    Jul  1 16:08:01 teplichnii /USR/SBIN/CRON[3888]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:07:28    System0.Info    192.168.0.7    Jul  1 16:08:01 teplichnii CRON[3887]: pam_unix(cron:session): session closed for user root
2015-07-01 15:08:28    System0.Info    192.168.0.7    Jul  1 16:09:01 teplichnii CRON[3902]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:08:28    Cron.Info    192.168.0.7    Jul  1 16:09:01 teplichnii /USR/SBIN/CRON[3903]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:08:28    System0.Info    192.168.0.7    Jul  1 16:09:01 teplichnii CRON[3902]: pam_unix(cron:session): session closed for user root
2015-07-01 15:09:28    System0.Info    192.168.0.7    Jul  1 16:10:01 teplichnii CRON[3917]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:09:28    Cron.Info    192.168.0.7    Jul  1 16:10:01 teplichnii /USR/SBIN/CRON[3918]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:09:28    System0.Info    192.168.0.7    Jul  1 16:10:01 teplichnii CRON[3917]: pam_unix(cron:session): session closed for user root
2015-07-01 15:10:28    System0.Info    192.168.0.7    Jul  1 16:11:01 teplichnii CRON[3932]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:10:28    Cron.Info    192.168.0.7    Jul  1 16:11:01 teplichnii /USR/SBIN/CRON[3933]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:10:28    System0.Info    192.168.0.7    Jul  1 16:11:01 teplichnii CRON[3932]: pam_unix(cron:session): session closed for user root
2015-07-01 15:11:27    System0.Info    192.168.0.7    Jul  1 16:12:01 teplichnii CRON[3947]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:11:27    Cron.Info    192.168.0.7    Jul  1 16:12:01 teplichnii /USR/SBIN/CRON[3948]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:11:27    System0.Info    192.168.0.7    Jul  1 16:12:01 teplichnii CRON[3947]: pam_unix(cron:session): session closed for user root
2015-07-01 15:12:27    System0.Info    192.168.0.7    Jul  1 16:13:01 teplichnii CRON[3962]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:12:27    Cron.Info    192.168.0.7    Jul  1 16:13:01 teplichnii /USR/SBIN/CRON[3963]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:12:27    System0.Info    192.168.0.7    Jul  1 16:13:01 teplichnii CRON[3962]: pam_unix(cron:session): session closed for user root
2015-07-01 15:13:27    System0.Info    192.168.0.7    Jul  1 16:14:01 teplichnii CRON[3977]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:13:27    Cron.Info    192.168.0.7    Jul  1 16:14:01 teplichnii /USR/SBIN/CRON[3978]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:13:27    System0.Info    192.168.0.7    Jul  1 16:14:01 teplichnii CRON[3977]: pam_unix(cron:session): session closed for user root
2015-07-01 15:14:27    System0.Info    192.168.0.7    Jul  1 16:15:01 teplichnii CRON[3992]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:14:27    Cron.Info    192.168.0.7    Jul  1 16:15:01 teplichnii /USR/SBIN/CRON[3993]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:14:27    System0.Info    192.168.0.7    Jul  1 16:15:01 teplichnii CRON[3992]: pam_unix(cron:session): session closed for user root
2015-07-01 15:15:27    System0.Info    192.168.0.7    Jul  1 16:16:01 teplichnii CRON[4007]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:15:27    Cron.Info    192.168.0.7    Jul  1 16:16:01 teplichnii /USR/SBIN/CRON[4008]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:15:27    System0.Info    192.168.0.7    Jul  1 16:16:01 teplichnii CRON[4007]: pam_unix(cron:session): session closed for user root
2015-07-01 15:16:07    Daemon.Info    192.168.0.7    Jul  1 16:16:41 teplichnii pvedaemon[2732]: <root@pam> successful auth for user 'root@pam'
2015-07-01 15:16:27    System0.Info    192.168.0.7    Jul  1 16:17:01 teplichnii CRON[4023]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:16:27    System0.Info    192.168.0.7    Jul  1 16:17:01 teplichnii CRON[4022]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:16:27    Cron.Info    192.168.0.7    Jul  1 16:17:01 teplichnii /USR/SBIN/CRON[4025]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
2015-07-01 15:16:27    Cron.Info    192.168.0.7    Jul  1 16:17:01 teplichnii /USR/SBIN/CRON[4024]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:16:27    System0.Info    192.168.0.7    Jul  1 16:17:01 teplichnii CRON[4023]: pam_unix(cron:session): session closed for user root
2015-07-01 15:16:27    System0.Info    192.168.0.7    Jul  1 16:17:01 teplichnii CRON[4022]: pam_unix(cron:session): session closed for user root
2015-07-01 15:17:27    System0.Info    192.168.0.7    Jul  1 16:18:01 teplichnii CRON[4040]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:17:27    Cron.Info    192.168.0.7    Jul  1 16:18:01 teplichnii /USR/SBIN/CRON[4041]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:17:27    System0.Info    192.168.0.7    Jul  1 16:18:01 teplichnii CRON[4040]: pam_unix(cron:session): session closed for user root
2015-07-01 15:18:27    System0.Info    192.168.0.7    Jul  1 16:19:01 teplichnii CRON[4055]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:18:27    Cron.Info    192.168.0.7    Jul  1 16:19:01 teplichnii /USR/SBIN/CRON[4056]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:18:27    System0.Info    192.168.0.7    Jul  1 16:19:01 teplichnii CRON[4055]: pam_unix(cron:session): session closed for user root
2015-07-01 15:19:27    System0.Info    192.168.0.7    Jul  1 16:20:01 teplichnii CRON[4070]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:19:27    Cron.Info    192.168.0.7    Jul  1 16:20:01 teplichnii /USR/SBIN/CRON[4071]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:19:27    System0.Info    192.168.0.7    Jul  1 16:20:01 teplichnii CRON[4070]: pam_unix(cron:session): session closed for user root
2015-07-01 15:20:27    System0.Info    192.168.0.7    Jul  1 16:21:01 teplichnii CRON[4085]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:20:27    Cron.Info    192.168.0.7    Jul  1 16:21:01 teplichnii /USR/SBIN/CRON[4086]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:20:27    System0.Info    192.168.0.7    Jul  1 16:21:01 teplichnii CRON[4085]: pam_unix(cron:session): session closed for user root
2015-07-01 15:21:09    Daemon.Info    192.168.0.7    Jul  1 16:21:43 teplichnii pveproxy[2753]: worker 3256 finished


And after I have rebooted it I got the the same log:

Code:
2015-07-01 15:40:36    Kernel.Info    192.168.0.7    Jul  1 16:41:12 teplichnii kernel: vmbr0: port 2(tap100i0) entering disabled state
2015-07-01 15:40:36    Kernel.Info    192.168.0.7    Jul  1 16:41:12 teplichnii kernel: vmbr0: port 2(tap100i0) entering disabled state
2015-07-01 15:40:36    Kernel.Info    192.168.0.7    Jul  1 16:41:12 teplichnii kernel: vmbr1: port 2(tap100i1) entering disabled state
2015-07-01 15:40:36    Kernel.Info    192.168.0.7    Jul  1 16:41:12 teplichnii kernel: vmbr1: port 2(tap100i1) entering disabled state
2015-07-01 15:40:39    User.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvesh: <root@pam> end task UPID:teplichnii:000011AD:00088BBB:55937D66:stopall::root@pam: OK
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvestatd[2748]: server closing
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pveproxy[2753]: received terminate request
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pveproxy[2753]: worker 3871 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pveproxy[2753]: worker 4092 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pveproxy[2753]: worker 3286 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pveproxy[2753]: server closing
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvedaemon[2724]: received terminate request
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvedaemon[2724]: worker 2732 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvedaemon[2724]: worker 2734 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvedaemon[2724]: worker 2733 finished
2015-07-01 15:40:39    Daemon.Info    192.168.0.7    Jul  1 16:41:15 teplichnii pvedaemon[2724]: server closing
2015-07-01 15:40:39    Kernel.Notice    192.168.0.7    Jul  1 16:41:15 teplichnii kernel: FS-Cache: Netfs 'nfs' unregistered from caching
2015-07-01 15:40:39    Kernel.Notice    192.168.0.7    Jul  1 16:41:15 teplichnii kernel: FS-Cache: Unloaded
2015-07-01 15:40:39    Daemon.Notice    192.168.0.7    Jul  1 16:41:15 teplichnii pmxcfs[2536]: [main] notice: teardown filesystem
2015-07-01 15:40:40    Daemon.Warning    192.168.0.7    Jul  1 16:41:15 teplichnii iscsid: iscsid shutting down.
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: Deleting interface #11 tap100i0, fe80::f0ff:e8ff:feb1:8e20#123, interface stats: received=0, sent=0, dropped=0, active_time=5444 secs
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: Deleting interface #10 tap100i1, fe80::3c75:2eff:feb2:f1b9#123, interface stats: received=0, sent=0, dropped=0, active_time=5444 secs
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: Deleting interface #7 venet0, fe80::1#123, interface stats: received=0, sent=0, dropped=0, active_time=5444 secs
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: mail.sonur.ru interface 192.168.0.7 -> ip-188-113-156-235.z28.ysk.scts.tv
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: 89.221.207.113 interface 192.168.0.7 -> ip-188-113-156-235.z28.ysk.scts.tv
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: mx.lan32.ru interface 192.168.0.7 -> ip-188-113-156-235.z28.ysk.scts.tv
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: broadband-77-37-134-150.nationalcablenetworks.ru interface 192.168.0.7 -> ip-188-113-156-235.z28.ysk.scts.tv
2015-07-01 15:40:40    Daemon.Info    192.168.0.7    Jul  1 16:41:16 teplichnii ntpd[2465]: peers refreshed
2015-07-01 15:40:41    Daemon.Notice    192.168.0.7    Jul  1 16:41:17 teplichnii pmxcfs[2536]: [main] notice: exit proxmox configuration filesystem (0)
2015-07-01 15:40:41    Auth.Info    192.168.0.7    Jul  1 16:41:17 teplichnii sshd[2484]: Received signal 15; terminating.
2015-07-01 15:40:41    Auth.Info    192.168.0.7    Jul  1 16:41:17 teplichnii sshd[3486]: Exiting on signal 15
2015-07-01 15:40:41    System0.Info    192.168.0.7    Jul  1 16:41:17 teplichnii sshd[3486]: pam_unix(sshd:session): session closed for user root
2015-07-01 15:40:41    Auth.Info    192.168.0.7    Jul  1 16:41:17 teplichnii sshd[4378]: Exiting on signal 15
2015-07-01 15:40:41    System0.Info    192.168.0.7    Jul  1 16:41:17 teplichnii sshd[4378]: pam_unix(sshd:session): session closed for user root
2015-07-01 15:40:41    Daemon.Notice    192.168.0.7    Jul  1 16:41:17 teplichnii ntpd[2465]: ntpd exiting on signal 15
2015-07-01 15:41:18    Cron.Info    192.168.0.7    Jul  1 16:41:53 teplichnii /usr/sbin/cron[2603]: (CRON) STARTUP (fork ok)
2015-07-01 15:41:18    Cron.Info    192.168.0.7    Jul  1 16:41:53 teplichnii /usr/sbin/cron[2603]: (CRON) INFO (Running @reboot jobs)
2015-07-01 15:41:18    Kernel.Info    192.168.0.7    Jul  1 16:41:53 teplichnii kernel: tun: Universal TUN/TAP device driver, 1.6
2015-07-01 15:41:18    Kernel.Info    192.168.0.7    Jul  1 16:41:53 teplichnii kernel: tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
2015-07-01 15:41:18    Kernel.Info    192.168.0.7    Jul  1 16:41:54 teplichnii kernel: ip6_tables: (C) 2000-2006 Netfilter Core Team
2015-07-01 15:41:18    Kernel.Warning    192.168.0.7    Jul  1 16:41:54 teplichnii kernel: Enabling conntracks and NAT for ve0
2015-07-01 15:41:18    Kernel.Warning    192.168.0.7    Jul  1 16:41:54 teplichnii kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
2015-07-01 15:41:18    Kernel.Info    192.168.0.7    Jul  1 16:41:54 teplichnii kernel: ploop_dev: module loaded
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvedaemon[2722]: starting server
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvedaemon[2722]: starting 3 worker(s)
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvedaemon[2722]: worker 2730 started
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvedaemon[2722]: worker 2731 started
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvedaemon[2722]: worker 2732 started
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:55 teplichnii pvestatd[2746]: starting server
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pveproxy[2751]: starting server
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pveproxy[2751]: starting 3 worker(s)
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pveproxy[2751]: worker 2752 started
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pveproxy[2751]: worker 2753 started
2015-07-01 15:41:20    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pveproxy[2751]: worker 2754 started
2015-07-01 15:41:20    User.Info    192.168.0.7    Jul  1 16:41:56 teplichnii pvesh: <root@pam> starting task UPID:teplichnii:00000AD3:00000858:55937DA4:startall::root@pam:
2015-07-01 15:41:20    User.Info    192.168.0.7    Jul  1 16:41:56 teplichnii task UPID:teplichnii:00000AD4:0000085A:55937DA4:qmstart:100:root@pam:: start VM 100: UPID:teplichnii:00000AD4:0000085A:55937DA4:qmstart:100:root@pam:
2015-07-01 15:41:20    User.Info    192.168.0.7    Jul  1 16:41:56 teplichnii task UPID:teplichnii:00000AD3:00000858:55937DA4:startall::root@pam:: <root@pam> starting task UPID:teplichnii:00000AD4:0000085A:55937DA4:qmstart:100:root@pam:
2015-07-01 15:41:21    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii spiceproxy[2775]: starting server
2015-07-01 15:41:21    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii spiceproxy[2775]: starting 1 worker(s)
2015-07-01 15:41:21    Daemon.Info    192.168.0.7    Jul  1 16:41:56 teplichnii spiceproxy[2775]: worker 2776 started
2015-07-01 15:41:21    Kernel.Info    192.168.0.7    Jul  1 16:41:57 teplichnii kernel: device tap100i0 entered promiscuous mode
2015-07-01 15:41:21    Kernel.Info    192.168.0.7    Jul  1 16:41:57 teplichnii kernel: vmbr0: port 2(tap100i0) entering forwarding state
2015-07-01 15:41:22    Kernel.Info    192.168.0.7    Jul  1 16:41:57 teplichnii kernel: device tap100i1 entered promiscuous mode
2015-07-01 15:41:22    Kernel.Info    192.168.0.7    Jul  1 16:41:57 teplichnii kernel: vmbr1: port 2(tap100i1) entering forwarding state
2015-07-01 15:41:25    Kernel.Debug    192.168.0.7    Jul  1 16:42:00 teplichnii kernel: eth1: no IPv6 routers present
2015-07-01 15:41:25    Kernel.Debug    192.168.0.7    Jul  1 16:42:00 teplichnii kernel: eth0: no IPv6 routers present
2015-07-01 15:41:25    Kernel.Debug    192.168.0.7    Jul  1 16:42:00 teplichnii kernel: vmbr1: no IPv6 routers present
2015-07-01 15:41:25    Kernel.Debug    192.168.0.7    Jul  1 16:42:01 teplichnii kernel: vmbr0: no IPv6 routers present
2015-07-01 15:41:26    System0.Info    192.168.0.7    Jul  1 16:42:01 teplichnii CRON[2820]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:41:26    Cron.Info    192.168.0.7    Jul  1 16:42:01 teplichnii /USR/SBIN/CRON[2821]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:41:26    System0.Info    192.168.0.7    Jul  1 16:42:01 teplichnii CRON[2820]: pam_unix(cron:session): session closed for user root
2015-07-01 15:41:27    User.Info    192.168.0.7    Jul  1 16:42:02 teplichnii pvesh: <root@pam> end task UPID:teplichnii:00000AD3:00000858:55937DA4:startall::root@pam: OK
2015-07-01 15:41:28    Kernel.Debug    192.168.0.7    Jul  1 16:42:03 teplichnii kernel: venet0: no IPv6 routers present
2015-07-01 15:41:32    Kernel.Debug    192.168.0.7    Jul  1 16:42:07 teplichnii kernel: tap100i0: no IPv6 routers present
2015-07-01 15:41:33    Kernel.Debug    192.168.0.7    Jul  1 16:42:08 teplichnii kernel: tap100i1: no IPv6 routers present
2015-07-01 15:41:56    Daemon.Info    192.168.0.7    Jul  1 16:42:32 teplichnii ntpd[2456]: Deferring DNS for 0.debian.pool.ntp.org 1
2015-07-01 15:42:26    System0.Info    192.168.0.7    Jul  1 16:43:01 teplichnii CRON[2889]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:42:26    Cron.Info    192.168.0.7    Jul  1 16:43:01 teplichnii /USR/SBIN/CRON[2890]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:42:26    System0.Info    192.168.0.7    Jul  1 16:43:01 teplichnii CRON[2889]: pam_unix(cron:session): session closed for user root
2015-07-01 15:42:36    Daemon.Info    192.168.0.7    Jul  1 16:43:12 teplichnii ntpd[2456]: Deferring DNS for 1.debian.pool.ntp.org 1
2015-07-01 15:43:16    Daemon.Info    192.168.0.7    Jul  1 16:43:52 teplichnii ntpd[2456]: Deferring DNS for 2.debian.pool.ntp.org 1
2015-07-01 15:43:25    System0.Info    192.168.0.7    Jul  1 16:44:01 teplichnii CRON[2904]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:43:25    Cron.Info    192.168.0.7    Jul  1 16:44:01 teplichnii /USR/SBIN/CRON[2905]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:43:25    System0.Info    192.168.0.7    Jul  1 16:44:01 teplichnii CRON[2904]: pam_unix(cron:session): session closed for user root
2015-07-01 15:43:56    Daemon.Info    192.168.0.7    Jul  1 16:44:32 teplichnii ntpd[2456]: Deferring DNS for 3.debian.pool.ntp.org 1
2015-07-01 15:43:56    Daemon.Debug    192.168.0.7    Jul  1 16:44:32 teplichnii ntpd[2910]: signal_no_reset: signal 17 had flags 4000000
2015-07-01 15:43:57    Daemon.Info    192.168.0.7    Jul  1 16:44:33 teplichnii ntpd[2456]: Listen normally on 9 tap100i0 fe80::182d:b2ff:fecf:698b UDP 123
2015-07-01 15:43:57    Daemon.Info    192.168.0.7    Jul  1 16:44:33 teplichnii ntpd[2456]: Listen normally on 10 venet0 fe80::1 UDP 123
2015-07-01 15:43:57    Daemon.Info    192.168.0.7    Jul  1 16:44:33 teplichnii ntpd[2456]: Listen normally on 11 tap100i1 fe80::7c97:28ff:fe2a:b36c UDP 123
2015-07-01 15:43:57    Daemon.Info    192.168.0.7    Jul  1 16:44:33 teplichnii ntpd[2456]: Listen normally on 12 vmbr0 fe80::5246:5dff:fe52:f308 UDP 123
2015-07-01 15:43:57    Daemon.Info    192.168.0.7    Jul  1 16:44:33 teplichnii ntpd[2456]: peers refreshed
2015-07-01 15:44:25    System0.Info    192.168.0.7    Jul  1 16:45:01 teplichnii CRON[2920]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:44:25    Cron.Info    192.168.0.7    Jul  1 16:45:01 teplichnii /USR/SBIN/CRON[2921]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:44:25    System0.Info    192.168.0.7    Jul  1 16:45:01 teplichnii CRON[2920]: pam_unix(cron:session): session closed for user root
2015-07-01 15:44:38    Daemon.Error    192.168.0.7    Jul  1 16:45:14 teplichnii ntpd_intres[2910]: host name not found: 0.debian.pool.ntp.org
2015-07-01 15:45:18    Daemon.Error    192.168.0.7    Jul  1 16:45:54 teplichnii ntpd_intres[2910]: host name not found: 1.debian.pool.ntp.org
2015-07-01 15:45:25    System0.Info    192.168.0.7    Jul  1 16:46:01 teplichnii CRON[2935]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:45:25    Cron.Info    192.168.0.7    Jul  1 16:46:01 teplichnii /USR/SBIN/CRON[2936]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:45:25    System0.Info    192.168.0.7    Jul  1 16:46:01 teplichnii CRON[2935]: pam_unix(cron:session): session closed for user root
2015-07-01 15:45:57    Daemon.Error    192.168.0.7    Jul  1 16:46:34 teplichnii ntpd_intres[2910]: host name not found: 2.debian.pool.ntp.org
2015-07-01 15:46:07    Daemon.Info    192.168.0.7    Jul  1 16:46:43 teplichnii pvedaemon[2731]: <root@pam> successful auth for user 'root@pam'
2015-07-01 15:46:25    System0.Info    192.168.0.7    Jul  1 16:47:01 teplichnii CRON[2950]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:46:25    Cron.Info    192.168.0.7    Jul  1 16:47:01 teplichnii /USR/SBIN/CRON[2951]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:46:25    System0.Info    192.168.0.7    Jul  1 16:47:01 teplichnii CRON[2950]: pam_unix(cron:session): session closed for user root
2015-07-01 15:46:37    Daemon.Error    192.168.0.7    Jul  1 16:47:14 teplichnii ntpd_intres[2910]: host name not found: 3.debian.pool.ntp.org
2015-07-01 15:47:19    Daemon.Error    192.168.0.7    Jul  1 16:47:56 teplichnii ntpd_intres[2910]: host name not found: 0.debian.pool.ntp.org
2015-07-01 15:47:25    System0.Info    192.168.0.7    Jul  1 16:48:01 teplichnii CRON[2965]: pam_unix(cron:session): session opened for user root by (uid=0)
2015-07-01 15:47:25    Cron.Info    192.168.0.7    Jul  1 16:48:01 teplichnii /USR/SBIN/CRON[2966]: (root) CMD (ifconfig  -a >> /root/ifconfoglog)
2015-07-01 15:47:25    System0.Info    192.168.0.7    Jul  1 16:48:01 teplichnii CRON[2965]: pam_unix(cron:session): session closed for user root
2015-07-01 15:47:59    Daemon.Error    192.168.0.7    Jul  1 16:48:36 teplichnii ntpd_intres[2910]: host name not found: 1.debian.pool.ntp.org

I have no ideas to reslove the bug and I will be killed with my office soon :)
Thanks for response!
 
It seems you're using the same external IP on both the host and VM (pfSense's em0 and proxmox' vmbr0), this might be conflicting settings. (The post you linked to doesn't do this AFAICS).
 
May be there is an article with the ordinary scenario?
I should note that i can connect to Pfsense via VPN through external NIC when it hangs and I can ping LAN including the gateway (192.168.0.1), so I suspect there are problems with my Pfsense rules but it doesn't explain why it works correct after several rebootings.
Yes, you are right the address of external NIC of the proxmox should not equal external NIC of pfsense more than that as i understand we can set no options to it:

Code:
# network interface settings
auto lo
iface lo inet loopback


iface eth0 inet manual


iface eth1 inet manual


auto vmbr0
iface vmbr0 inet manual
        bridge_ports eth0
        bridge_stp off
        bridge_fd 0


auto vmbr1
iface vmbr1 inet static
        address  192.168.0.7
        netmask  255.255.255.0
        bridge_ports eth1
        bridge_stp off
        bridge_fd 0

The post I linked to has the same scenario:

Code:
[COLOR=#333333]proxmox server : 192.168.1.90[/COLOR]
[COLOR=#333333]pfsense : LAN : 192.168.1.41 WAN 10.0.0.41
[/COLOR][COLOR=#333333]ADSL router : 10.0.0.1[/COLOR][COLOR=#333333]
[/COLOR]

So because I replaced network settings to valid one the problem must go away, isn't it? Let's see :)

I have just had the hanging proxmox, your advice didn't help me, but restarting vz service resolved the problem, why?=)
 
Last edited:

About

The Proxmox community has been around for many years and offers help and support for Proxmox VE, Proxmox Backup Server, and Proxmox Mail Gateway.
We think our community is one of the best thanks to people like you!

Get your subscription!

The Proxmox team works very hard to make sure you are running the best software and getting stable updates and security enhancements, as well as quick enterprise support. Tens of thousands of happy customers have a Proxmox subscription. Get yours easily in our online shop.

Buy now!