· 9 years ago · Dec 21, 2016, 06:30 AM
1
2Wed Dec 21 06:21:14 UTC 2016 Executing cloud-early-config
3Wed Dec 21 06:21:14 UTC 2016 Detected that we are running inside kvm guest
4Wed Dec 21 06:21:14 UTC 2016 Found a non empty cmdline file. Will now exit the loop and proceed with configuration.
5Wed Dec 21 06:21:14 UTC 2016 Patching scripts oldmd5=0b260321715ec35ed7bab1d6b03bedfc newmd5=6a20ff74eb235f16e848f66235f0732a
6Wed Dec 21 06:21:14 UTC 2016 Patching cloud service
7Wed Dec 21 06:21:15 UTC 2016 Rebooting system since we patched init scripts
8Wed Dec 21 06:21:17 UTC 2016 Updating log4j-cloud.xml
9Wed Dec 21 06:21:18 UTC 2016 Setting up dhcp server system vm
10Wed Dec 21 06:21:18 UTC 2016 checking that eth0 has IP
11Wed Dec 21 06:21:18 UTC 2016 checking that eth1 has IP
12Wed Dec 21 06:21:21 UTC 2016 Setting up dnsmasq
13Wed Dec 21 06:21:21 UTC 2016 Setting up apache web server
14Wed Dec 21 06:21:21 UTC 2016 Enable service dnsmasq = 1
15Wed Dec 21 06:21:21 UTC 2016 Enable service haproxy = 0
16Wed Dec 21 06:21:21 UTC 2016 Processors = 1 Enable service = 0
17Wed Dec 21 06:21:21 UTC 2016 Enable service cloud-passwd-srvr = 1
18Wed Dec 21 06:21:21 UTC 2016 Enable service cloud = 0
19Wed Dec 21 06:21:21 UTC 2016 cloud: enable_fwding = 0
20Wed Dec 21 06:21:21 UTC 2016 enable_fwding = 0
212016-12-21 06:21:22,336 merge.py load:57 Creating data bag type cmdline
222016-12-21 06:21:22,337 merge.py process:100 Command of type cmdline received
232016-12-21 06:21:22,337 merge.py load:57 Creating data bag type ips
242016-12-21 06:21:22,337 merge.py process:100 Command of type ips received
252016-12-21 06:21:22,337 merge.py save:71 Writing data bag type ips
262016-12-21 06:21:22,338 merge.py save:72 {'id': 'ips', 'eth0': [{'broadcast': '10.3.28.255', 'one_to_one_nat': False, 'nic_dev_id': '0', 'network': '10.3.28.0/24', 'add': True, 'gateway': 'None', 'public_ip': u'10.3.28.10', 'netmask': u'255.255.255.0', 'nw_type': 'guest', 'device': 'eth0', 'cidr': '10.3.28.10/24', 'source_nat': False, 'size': '24'}]}
272016-12-21 06:21:22,338 merge.py load:60 Loading data bag type ips
282016-12-21 06:21:22,338 merge.py process:100 Command of type ips received
292016-12-21 06:21:22,339 merge.py save:71 Writing data bag type ips
302016-12-21 06:21:22,339 merge.py save:72 {u'id': u'ips', 'eth1': [{'broadcast': '169.254.255.255', 'one_to_one_nat': False, 'nic_dev_id': '1', 'network': '169.254.0.0/16', 'add': True, 'gateway': 'None', 'public_ip': u'169.254.1.124', 'netmask': u'255.255.0.0', 'nw_type': 'control', 'device': 'eth1', 'cidr': '169.254.1.124/16', 'source_nat': False, 'size': '16'}], u'eth0': [{u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}]}
312016-12-21 06:21:22,339 merge.py save:71 Writing data bag type cmdline
322016-12-21 06:21:22,339 merge.py save:72 {'config': {u'domain': u'nocser.net', u'eth1ip': u'169.254.1.124', u'name': u'r-690-VM', u'eth0mask': u'255.255.255.0', u'cidrsize': u'24', u'dns1': u'8.8.8.8', u'port': u'8080', u'dhcprange': u'10.3.28.1', u'ip6dns1': u'', u'host': u'10.2.30.11', u'baremetalnotificationsecuritykey': u'uavJByNGGjNLrELG-qbdN99__1I3tnp8qa0KbcsKokKJcPB43K9s6oQu2nMLqo3YP8p6jqDy5XT3WWOWBA2yNw', u'eth1mask': u'255.255.0.0', 'redundant_router': 'false', u'template': u'domP', u'dns2': u'8.8.4.4', u'disable_rp_filter': u'true', u'ip6dns2': u'', u'baremetalnotificationapikey': u'8JH4mdkxsEMhgIBgMonkNXAEKjVOeZnG1m5UVekvvo4v_iXQ4ZS7rh6NNS0qphhc7ZrCauiz23tp2-Wa3AASlg', u'type': u'dhcpsrvr', u'gateway': u'10.3.28.1', u'eth0ip': u'10.3.28.10'}, 'id': u'cmdline'}
332016-12-21 06:21:22,340 merge.py load:283 Could not open /var/cache/cloud/cmd_line.json
342016-12-21 06:21:22,340 merge.py load:60 Loading data bag type ips
352016-12-21 06:21:22,340 merge.py load:60 Loading data bag type cmdline
362016-12-21 06:21:22,341 configure.py main:924 Configuring ip addresses
372016-12-21 06:21:22,341 CsHelper.py execute:184 Executing: ip addr show dev eth1
382016-12-21 06:21:22,345 CsHelper.py execute:184 Executing: ip addr show dev eth0
392016-12-21 06:21:22,349 CsHelper.py execute:184 Executing: ip addr show dev eth1
402016-12-21 06:21:22,352 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
412016-12-21 06:21:22,352 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
422016-12-21 06:21:22,352 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
432016-12-21 06:21:22,352 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
442016-12-21 06:21:22,355 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
452016-12-21 06:21:22,356 CsHelper.py execute:184 Executing: ip -4 route list 0/0
462016-12-21 06:21:22,359 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
472016-12-21 06:21:22,359 CsHelper.py execute:184 Executing: ip addr show dev eth0
482016-12-21 06:21:22,362 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
492016-12-21 06:21:22,362 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
502016-12-21 06:21:22,362 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
512016-12-21 06:21:22,362 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
522016-12-21 06:21:22,365 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
532016-12-21 06:21:22,367 CsHelper.py addifmissing:172 Added 0 Table_eth0 to file /etc/iproute2/rt_tables
542016-12-21 06:21:22,367 CsHelper.py execute:184 Executing: ip rule show
552016-12-21 06:21:22,370 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
562016-12-21 06:21:22,373 CsRule.py addMark:37 Added fwmark rule for Table_eth0
572016-12-21 06:21:22,373 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
582016-12-21 06:21:22,377 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
592016-12-21 06:21:42,425 CsAddress.py inKernel:686 rpsfr is not present in the kernel
602016-12-21 06:21:42,426 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
612016-12-21 06:21:42,427 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
622016-12-21 06:21:42,427 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
632016-12-21 06:21:42,434 CsHelper.py copy:251 Copied /etc/apache2/vhost.template to /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
642016-12-21 06:21:42,434 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
652016-12-21 06:21:42,435 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
662016-12-21 06:21:42,435 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
672016-12-21 06:21:42,436 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
682016-12-21 06:21:42,437 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
692016-12-21 06:21:42,438 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
702016-12-21 06:21:42,439 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
712016-12-21 06:21:42,440 CsFile.py commit:66 Wrote edited file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
722016-12-21 06:21:42,441 CsFile.py commit:68 Updated file in-cache configuration
732016-12-21 06:21:42,441 CsHelper.py execute:184 Executing: service apache2 restart
742016-12-21 06:21:42,599 CsHelper.py service:213 Service apache2 restart
752016-12-21 06:21:42,600 CsHelper.py execute:184 Executing: ps aux
762016-12-21 06:21:42,607 CsProcess.py start:33 Started dummy
772016-12-21 06:21:42,608 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
782016-12-21 06:21:42,608 CsHelper.py execute:184 Executing: ip -4 route list 0/0
792016-12-21 06:21:42,613 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
802016-12-21 06:21:42,613 configure.py main:929 Configuring Guest Network
812016-12-21 06:21:42,613 configure.py main:933 Configuring vmpassword
822016-12-21 06:21:42,613 merge.py load:57 Creating data bag type vmpassword
832016-12-21 06:21:42,613 configure.py main:938 Configuring vmdata
842016-12-21 06:21:42,613 merge.py load:57 Creating data bag type vmdata
852016-12-21 06:21:42,614 configure.py main:943 Configuring networkacl
862016-12-21 06:21:42,614 configure.py main:947 Configuring firewall rules
872016-12-21 06:21:42,614 configure.py main:951 Configuring PF rules
882016-12-21 06:21:42,614 configure.py main:955 Configuring s2s vpn
892016-12-21 06:21:42,614 configure.py main:959 Configuring remote access vpn
902016-12-21 06:21:42,614 configure.py main:963 Configuring vpn users list
912016-12-21 06:21:42,614 merge.py load:57 Creating data bag type vpnuserlist
922016-12-21 06:21:42,614 configure.py main:968 Configuring dhcp entry
932016-12-21 06:21:42,614 merge.py load:57 Creating data bag type dhcpentry
942016-12-21 06:21:42,614 CsHelper.py execute:184 Executing: ip addr show
952016-12-21 06:21:42,624 CsFile.py load:37 File /etc/dhcphosts.txt does not exist
962016-12-21 06:21:42,624 CsFile.py load:37 File /etc/dnsmasq.d/cloud.conf does not exist
972016-12-21 06:21:42,625 CsFile.py load:39 Reading file /etc/hosts
982016-12-21 06:21:42,625 CsFile.py commit:66 Wrote edited file /etc/hosts
992016-12-21 06:21:42,625 CsFile.py commit:68 Updated file in-cache configuration
1002016-12-21 06:21:42,625 CsDhcp.py write_hosts:125 Updated hosts file
1012016-12-21 06:21:42,625 CsFile.py commit:60 Nothing to commit. The /etc/dnsmasq.d/cloud.conf file did not change
1022016-12-21 06:21:42,625 CsFile.py commit:60 Nothing to commit. The /etc/dhcphosts.txt file did not change
1032016-12-21 06:21:42,625 CsHelper.py execute:184 Executing: service dnsmasq restart
1042016-12-21 06:21:44,685 CsHelper.py service:213 Service dnsmasq restart
1052016-12-21 06:21:44,686 configure.py main:973 Configuring load balancer
1062016-12-21 06:21:44,686 configure.py main:977 Configuring monitor service
1072016-12-21 06:21:44,686 merge.py load:57 Creating data bag type monitorservice
1082016-12-21 06:21:44,687 merge.py load:57 Creating data bag type networkacl
1092016-12-21 06:21:44,687 merge.py load:57 Creating data bag type firewallrules
1102016-12-21 06:21:44,687 configure.py flushAllowAllEgressRules:267 Flush allow 'all' egress firewall rule
1112016-12-21 06:21:44,687 CsHelper.py execute:184 Executing: iptables-save | grep '^:FW_EGRESS_RULES' || iptables -t filter -N FW_EGRESS_RULES
1122016-12-21 06:21:44,744 CsHelper.py execute:184 Executing: iptables-save | grep '^-A FW_EGRESS_RULES -j ACCEPT$' | sed 's/^-A/iptables -t filter -D/g' | bash
1132016-12-21 06:21:44,752 merge.py load:57 Creating data bag type forwardingrules
1142016-12-21 06:21:44,753 merge.py load:57 Creating data bag type site2sitevpn
1152016-12-21 06:21:44,754 merge.py load:57 Creating data bag type remoteaccessvpn
1162016-12-21 06:21:44,754 configure.py process:618 {'id': 'remoteaccessvpn'}
1172016-12-21 06:21:44,754 merge.py load:57 Creating data bag type loadbalancer
1182016-12-21 06:21:44,754 configure.py main:1002 Configuring iptables rules
1192016-12-21 06:21:44,754 CsHelper.py execute:184 Executing: iptables-save
1202016-12-21 06:21:44,758 CsHelper.py execute:184 Executing: iptables -t filter -N FW_OUTBOUND
1212016-12-21 06:21:44,762 CsHelper.py execute:184 Executing: iptables -t filter -N
1222016-12-21 06:21:44,766 CsHelper.py execute:184 Executing: iptables -t mangle -N PREROUTING
1232016-12-21 06:21:44,780 CsHelper.py execute:184 Executing: iptables -t filter -N NETWORK_STATS
1242016-12-21 06:21:44,785 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-j': u'ACCEPT', u'-A': u'FW_OUTBOUND', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FW_OUTBOUND
1252016-12-21 06:21:44,785 CsNetfilter.py compare:164 Add: rule=-A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
1262016-12-21 06:21:44,785 CsHelper.py execute:184 Executing: iptables -t filter -A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT
1272016-12-21 06:21:44,802 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth1', u'-m2': u'state', u'--dport': u'3922', u'-p': u'tcp', u'--state': u'NEW,ESTABLISHED', u'-j': u'ACCEPT'} table=filter chain=INPUT
1282016-12-21 06:21:44,803 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT table=filter
1292016-12-21 06:21:44,803 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT
1302016-12-21 06:21:44,820 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-P': u'INPUT'} table=filter chain=
1312016-12-21 06:21:44,820 CsNetfilter.py compare:164 Add: rule=-P INPUT DROP table=filter
1322016-12-21 06:21:44,821 CsHelper.py execute:184 Executing: iptables -t filter -P INPUT DROP
1332016-12-21 06:21:44,824 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-P': u'FORWARD'} table=filter chain=
1342016-12-21 06:21:44,824 CsNetfilter.py compare:164 Add: rule=-P FORWARD DROP table=filter
1352016-12-21 06:21:44,825 CsHelper.py execute:184 Executing: iptables -t filter -P FORWARD DROP
1362016-12-21 06:21:44,828 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'PREROUTING', u'-i': u'eth0', u'-j': u'CONNMARK', u'--set-xmark': u'0x0/0xffffffff', u'--state': u'NEW', u'-m2': u'state'} table=mangle chain=PREROUTING
1372016-12-21 06:21:44,828 CsNetfilter.py compare:164 Add: rule=-A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff table=mangle
1382016-12-21 06:21:44,829 CsHelper.py execute:184 Executing: iptables -t mangle -A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff
1392016-12-21 06:21:44,849 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'PREROUTING', u'--restore-mark': u'--nfmask', u'-j': u'CONNMARK', u'0xffffffff': u'--ctmask', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=mangle chain=PREROUTING
1402016-12-21 06:21:44,850 CsNetfilter.py compare:164 Add: rule=-A PREROUTING -m state --state RELATED,ESTABLISHED -j CONNMARK --restore-mark --nfmask 0xffffffff --ctmask 0xffffffff table=mangle
1412016-12-21 06:21:44,850 CsHelper.py execute:184 Executing: iptables -t mangle -I PREROUTING -m state --state RELATED,ESTABLISHED -j CONNMARK --restore-mark --nfmask 0xffffffff --ctmask 0xffffffff
1422016-12-21 06:21:44,854 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'224.0.0.18/32', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
1432016-12-21 06:21:44,854 CsNetfilter.py compare:164 Add: rule=-A INPUT -d 224.0.0.18/32 -j ACCEPT table=filter
1442016-12-21 06:21:44,854 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -d 224.0.0.18/32 -j ACCEPT
1452016-12-21 06:21:44,858 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'225.0.0.50/32', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
1462016-12-21 06:21:44,858 CsNetfilter.py compare:164 Add: rule=-A INPUT -d 225.0.0.50/32 -j ACCEPT table=filter
1472016-12-21 06:21:44,859 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -d 225.0.0.50/32 -j ACCEPT
1482016-12-21 06:21:44,862 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-j': u'ACCEPT', u'-A': u'INPUT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=INPUT
1492016-12-21 06:21:44,863 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
1502016-12-21 06:21:44,863 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
1512016-12-21 06:21:44,867 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-p': u'icmp', u'-j': u'ACCEPT'} table=filter chain=INPUT
1522016-12-21 06:21:44,867 CsNetfilter.py compare:164 Add: rule=-A INPUT -p icmp -j ACCEPT table=filter
1532016-12-21 06:21:44,867 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -p icmp -j ACCEPT
1542016-12-21 06:21:44,871 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'lo', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
1552016-12-21 06:21:44,871 CsNetfilter.py compare:164 Add: rule=-A INPUT -i lo -j ACCEPT table=filter
1562016-12-21 06:21:44,871 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i lo -j ACCEPT
1572016-12-21 06:21:44,874 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'67', u'-p': u'udp'} table=filter chain=INPUT
1582016-12-21 06:21:44,874 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT table=filter
1592016-12-21 06:21:44,874 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT
1602016-12-21 06:21:44,880 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'udp'} table=filter chain=INPUT
1612016-12-21 06:21:44,880 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 53 -j ACCEPT table=filter
1622016-12-21 06:21:44,880 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p udp -m udp --dport 53 -j ACCEPT
1632016-12-21 06:21:44,884 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'tcp'} table=filter chain=INPUT
1642016-12-21 06:21:44,884 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 53 -j ACCEPT table=filter
1652016-12-21 06:21:44,884 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 53 -j ACCEPT
1662016-12-21 06:21:44,888 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'80', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
1672016-12-21 06:21:44,888 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 80 -m state --state NEW -j ACCEPT table=filter
1682016-12-21 06:21:44,888 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 80 -m state --state NEW -j ACCEPT
1692016-12-21 06:21:44,892 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'8080', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
1702016-12-21 06:21:44,892 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 8080 -m state --state NEW -j ACCEPT table=filter
1712016-12-21 06:21:44,892 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 8080 -m state --state NEW -j ACCEPT
1722016-12-21 06:21:44,896 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth1', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
1732016-12-21 06:21:44,896 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth1 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
1742016-12-21 06:21:44,896 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth1 -m state --state RELATED,ESTABLISHED -j ACCEPT
1752016-12-21 06:21:44,900 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'NEW', u'-m2': u'state'} table=filter chain=FORWARD
1762016-12-21 06:21:44,900 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth0 -m state --state NEW -j ACCEPT table=filter
1772016-12-21 06:21:44,900 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth0 -m state --state NEW -j ACCEPT
1782016-12-21 06:21:44,903 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth2', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
1792016-12-21 06:21:44,904 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth2 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
1802016-12-21 06:21:44,904 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth2 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
1812016-12-21 06:21:44,907 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
1822016-12-21 06:21:44,907 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
1832016-12-21 06:21:44,908 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
1842016-12-21 06:21:44,910 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-o': u'eth2', u'-A': u'FORWARD', u'-j': u'FW_OUTBOUND'} table=filter chain=FORWARD
1852016-12-21 06:21:44,911 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth2 -j FW_OUTBOUND table=filter
1862016-12-21 06:21:44,911 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth2 -j FW_OUTBOUND
1872016-12-21 06:21:44,913 CsNetfilter.py compare:148 Already processed : ('mangle', '', u'-A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff')
1882016-12-21 06:21:44,914 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-j': u'NETWORK_STATS'} table=filter chain=FORWARD
1892016-12-21 06:21:44,914 CsNetfilter.py compare:164 Add: rule=-A FORWARD -j NETWORK_STATS table=filter
1902016-12-21 06:21:44,914 CsHelper.py execute:184 Executing: iptables -t filter -I FORWARD -j NETWORK_STATS
1912016-12-21 06:21:44,917 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-j': u'NETWORK_STATS'} table=filter chain=INPUT
1922016-12-21 06:21:44,917 CsNetfilter.py compare:164 Add: rule=-A INPUT -j NETWORK_STATS table=filter
1932016-12-21 06:21:44,917 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -j NETWORK_STATS
1942016-12-21 06:21:44,920 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'OUTPUT', u'-j': u'NETWORK_STATS'} table=filter chain=OUTPUT
1952016-12-21 06:21:44,920 CsNetfilter.py compare:164 Add: rule=-A OUTPUT -j NETWORK_STATS table=filter
1962016-12-21 06:21:44,920 CsHelper.py execute:184 Executing: iptables -t filter -I OUTPUT -j NETWORK_STATS
1972016-12-21 06:21:44,923 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-o': u'eth2', u'-A': u'NETWORK_STATS'} table=filter chain=NETWORK_STATS
1982016-12-21 06:21:44,923 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth0 -o eth2 table=filter
1992016-12-21 06:21:44,923 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth0 -o eth2
2002016-12-21 06:21:44,927 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth2', u'-o': u'eth0', u'-A': u'NETWORK_STATS'} table=filter chain=NETWORK_STATS
2012016-12-21 06:21:44,927 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth2 -o eth0 table=filter
2022016-12-21 06:21:44,927 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth2 -o eth0
2032016-12-21 06:21:44,930 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-o': u'eth2', u'-A': u'NETWORK_STATS', u'-p': u'tcp', u'!_-i': u'eth0'} table=filter chain=NETWORK_STATS
2042016-12-21 06:21:44,930 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -o eth2 ! -i eth0 -p tcp table=filter
2052016-12-21 06:21:44,930 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -o eth2 ! -i eth0 -p tcp
2062016-12-21 06:21:44,933 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'!_-o': u'eth0', u'-i': u'eth2', u'-A': u'NETWORK_STATS', u'-p': u'tcp'} table=filter chain=NETWORK_STATS
2072016-12-21 06:21:44,933 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth2 ! -o eth0 -p tcp table=filter
2082016-12-21 06:21:44,933 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth2 ! -o eth0 -p tcp
2092016-12-21 06:21:44,936 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'67', u'-p': u'udp'} table=filter chain=INPUT
2102016-12-21 06:21:44,936 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT table=filter
2112016-12-21 06:21:44,937 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT
2122016-12-21 06:21:44,940 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'udp'} table=filter chain=INPUT
2132016-12-21 06:21:44,940 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p udp -m udp --dport 53 -j ACCEPT table=filter
2142016-12-21 06:21:44,940 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p udp -m udp --dport 53 -j ACCEPT
2152016-12-21 06:21:44,943 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'tcp'} table=filter chain=INPUT
2162016-12-21 06:21:44,943 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp --dport 53 -j ACCEPT table=filter
2172016-12-21 06:21:44,944 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp --dport 53 -j ACCEPT
2182016-12-21 06:21:44,947 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'80', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
2192016-12-21 06:21:44,947 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 80 -j ACCEPT table=filter
2202016-12-21 06:21:44,947 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 80 -j ACCEPT
2212016-12-21 06:21:44,950 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'443', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
2222016-12-21 06:21:44,951 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 443 -j ACCEPT table=filter
2232016-12-21 06:21:44,951 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 443 -j ACCEPT
2242016-12-21 06:21:44,954 CsNetfilter.py compare:148 Already processed : ('filter', '', '-A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT')
2252016-12-21 06:21:44,954 CsNetfilter.py compare:148 Already processed : ('filter', '', '-A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT')
2262016-12-21 06:21:44,954 CsNetfilter.py compare:148 Already processed : ('filter', '', '-P INPUT DROP')
2272016-12-21 06:21:44,954 CsNetfilter.py compare:148 Already processed : ('filter', '', '-P FORWARD DROP')
2282016-12-21 06:21:44,954 merge.py load:60 Loading data bag type cmdline
2292016-12-21 06:21:44,955 configure.py main:1006 Configuring iptables rules done ...saving rules
2302016-12-21 06:21:44,956 CsHelper.py save_iptables:192 Saving iptables for iptables-save
2312016-12-21 06:21:44,956 CsHelper.py execute:184 Executing: iptables-save
2322016-12-21 06:21:44,959 CsHelper.py save_iptables:192 Saving iptables for ip6tables-save
2332016-12-21 06:21:44,959 CsHelper.py execute:184 Executing: ip6tables-save
2342016-12-21 06:21:44,962 CsRedundant.py set:68 Router redundancy status is False
2352016-12-21 06:21:44,962 CsHelper.py execute:184 Executing: service conntrackd stop
2362016-12-21 06:21:44,989 CsHelper.py service:213 Service conntrackd stop
2372016-12-21 06:21:44,990 CsHelper.py execute:184 Executing: service keepalived stop
2382016-12-21 06:21:44,995 CsHelper.py service:213 Service keepalived stop
2392016-12-21 06:21:44,996 CsHelper.py execute:184 Executing: mount
2402016-12-21 06:21:44,998 configure.py main:1016 Configuring static routes
2412016-12-21 06:21:44,999 merge.py load:57 Creating data bag type staticroutes
2422016-12-21 06:21:44,999 CsStaticRoutes.py process:27 Processing CsStaticRoutes file ==> {'id': 'staticroutes'}
243Wed Dec 21 06:23:30 UTC 2016 Executing cloud-early-config
244Wed Dec 21 06:23:30 UTC 2016 Detected that we are running inside kvm guest
245Wed Dec 21 06:23:30 UTC 2016 Found a non empty cmdline file. Will now exit the loop and proceed with configuration.
246Wed Dec 21 06:23:30 UTC 2016 Patching cloud service
247Wed Dec 21 06:23:31 UTC 2016 Updating log4j-cloud.xml
248Wed Dec 21 06:23:31 UTC 2016 Setting up dhcp server system vm
249Wed Dec 21 06:23:31 UTC 2016 checking that eth0 has IP
250Wed Dec 21 06:23:32 UTC 2016 waiting for eth0 interface setup with ip timer=0
251Wed Dec 21 06:23:32 UTC 2016 checking that eth1 has IP
252Wed Dec 21 06:23:35 UTC 2016 Setting up dnsmasq
253Wed Dec 21 06:23:35 UTC 2016 Setting up apache web server
254Wed Dec 21 06:23:35 UTC 2016 Enable service dnsmasq = 1
255Wed Dec 21 06:23:35 UTC 2016 Enable service haproxy = 0
256Wed Dec 21 06:23:35 UTC 2016 Processors = 1 Enable service = 0
257Wed Dec 21 06:23:35 UTC 2016 Enable service cloud-passwd-srvr = 1
258Wed Dec 21 06:23:35 UTC 2016 Enable service cloud = 0
259Wed Dec 21 06:23:35 UTC 2016 cloud: enable_fwding = 0
260Wed Dec 21 06:23:35 UTC 2016 enable_fwding = 0
2612016-12-21 06:23:36,587 merge.py load:60 Loading data bag type cmdline
2622016-12-21 06:23:36,588 merge.py process:100 Command of type cmdline received
2632016-12-21 06:23:36,588 merge.py load:60 Loading data bag type ips
2642016-12-21 06:23:36,589 merge.py process:100 Command of type ips received
2652016-12-21 06:23:36,590 merge.py save:71 Writing data bag type ips
2662016-12-21 06:23:36,590 merge.py save:72 {u'id': u'ips', u'eth1': [{u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}], u'eth0': [{'broadcast': '10.3.28.255', 'one_to_one_nat': False, 'nic_dev_id': '0', 'network': '10.3.28.0/24', 'add': True, 'gateway': 'None', 'public_ip': u'10.3.28.10', 'netmask': u'255.255.255.0', 'nw_type': 'guest', 'device': 'eth0', 'cidr': '10.3.28.10/24', 'source_nat': False, 'size': '24'}]}
2672016-12-21 06:23:36,591 merge.py load:60 Loading data bag type ips
2682016-12-21 06:23:36,591 merge.py process:100 Command of type ips received
2692016-12-21 06:23:36,599 merge.py save:71 Writing data bag type ips
2702016-12-21 06:23:36,599 merge.py save:72 {u'id': u'ips', u'eth1': [{'broadcast': '169.254.255.255', 'one_to_one_nat': False, 'nic_dev_id': '1', 'network': '169.254.0.0/16', 'add': True, 'gateway': 'None', 'public_ip': u'169.254.1.124', 'netmask': u'255.255.0.0', 'nw_type': 'control', 'device': 'eth1', 'cidr': '169.254.1.124/16', 'source_nat': False, 'size': '16'}], u'eth0': [{u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}]}
2712016-12-21 06:23:36,600 merge.py save:71 Writing data bag type cmdline
2722016-12-21 06:23:36,600 merge.py save:72 {u'config': {u'domain': u'nocser.net', u'eth1ip': u'169.254.1.124', u'name': u'r-690-VM', u'eth0mask': u'255.255.255.0', u'cidrsize': u'24', u'dns1': u'8.8.8.8', u'port': u'8080', u'dhcprange': u'10.3.28.1', u'ip6dns1': u'', u'host': u'10.2.30.11', u'baremetalnotificationsecuritykey': u'uavJByNGGjNLrELG-qbdN99__1I3tnp8qa0KbcsKokKJcPB43K9s6oQu2nMLqo3YP8p6jqDy5XT3WWOWBA2yNw', u'eth1mask': u'255.255.0.0', 'redundant_router': 'false', u'template': u'domP', u'dns2': u'8.8.4.4', u'disable_rp_filter': u'true', u'ip6dns2': u'', u'baremetalnotificationapikey': u'8JH4mdkxsEMhgIBgMonkNXAEKjVOeZnG1m5UVekvvo4v_iXQ4ZS7rh6NNS0qphhc7ZrCauiz23tp2-Wa3AASlg', u'type': u'dhcpsrvr', u'gateway': u'10.3.28.1', u'eth0ip': u'10.3.28.10'}, u'id': u'cmdline'}
2732016-12-21 06:23:36,604 merge.py load:283 Could not open /var/cache/cloud/cmd_line.json
2742016-12-21 06:23:36,604 merge.py load:60 Loading data bag type ips
2752016-12-21 06:23:36,604 merge.py load:60 Loading data bag type cmdline
2762016-12-21 06:23:36,605 configure.py main:924 Configuring ip addresses
2772016-12-21 06:23:36,605 CsHelper.py execute:184 Executing: ip addr show dev eth1
2782016-12-21 06:23:36,609 CsHelper.py execute:184 Executing: ip addr show dev eth0
2792016-12-21 06:23:36,614 CsHelper.py execute:184 Executing: ip addr show dev eth1
2802016-12-21 06:23:36,619 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
2812016-12-21 06:23:36,619 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
2822016-12-21 06:23:36,619 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
2832016-12-21 06:23:36,619 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
2842016-12-21 06:23:36,623 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
2852016-12-21 06:23:36,623 CsHelper.py execute:184 Executing: ip -4 route list 0/0
2862016-12-21 06:23:36,626 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
2872016-12-21 06:23:36,627 CsHelper.py execute:184 Executing: ip addr show dev eth0
2882016-12-21 06:23:36,630 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
2892016-12-21 06:23:36,630 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
2902016-12-21 06:23:36,631 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
2912016-12-21 06:23:36,631 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
2922016-12-21 06:23:36,635 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
2932016-12-21 06:23:36,637 CsHelper.py execute:184 Executing: ip rule show
2942016-12-21 06:23:36,640 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
2952016-12-21 06:23:36,644 CsRule.py addMark:37 Added fwmark rule for Table_eth0
2962016-12-21 06:23:36,644 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
2972016-12-21 06:23:36,649 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
2982016-12-21 06:23:56,680 CsAddress.py inKernel:686 rpsfr is not present in the kernel
2992016-12-21 06:23:56,680 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
3002016-12-21 06:23:56,680 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
3012016-12-21 06:23:56,681 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
3022016-12-21 06:23:56,690 CsHelper.py copy:251 Copied /etc/apache2/vhost.template to /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
3032016-12-21 06:23:56,690 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
3042016-12-21 06:23:56,691 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
3052016-12-21 06:23:56,691 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
3062016-12-21 06:23:56,692 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
3072016-12-21 06:23:56,693 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
3082016-12-21 06:23:56,694 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
3092016-12-21 06:23:56,694 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
3102016-12-21 06:23:56,696 CsFile.py commit:66 Wrote edited file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
3112016-12-21 06:23:56,696 CsFile.py commit:68 Updated file in-cache configuration
3122016-12-21 06:23:56,696 CsHelper.py execute:184 Executing: service apache2 restart
3132016-12-21 06:23:57,147 CsHelper.py service:213 Service apache2 restart
3142016-12-21 06:23:57,147 CsHelper.py execute:184 Executing: ps aux
3152016-12-21 06:23:57,162 CsProcess.py start:33 Started dummy
3162016-12-21 06:23:57,165 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
3172016-12-21 06:23:57,165 CsHelper.py execute:184 Executing: ip -4 route list 0/0
3182016-12-21 06:23:57,176 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
3192016-12-21 06:23:57,176 configure.py main:929 Configuring Guest Network
3202016-12-21 06:23:57,176 configure.py main:933 Configuring vmpassword
3212016-12-21 06:23:57,176 merge.py load:57 Creating data bag type vmpassword
3222016-12-21 06:23:57,176 configure.py main:938 Configuring vmdata
3232016-12-21 06:23:57,176 merge.py load:57 Creating data bag type vmdata
3242016-12-21 06:23:57,177 configure.py main:943 Configuring networkacl
3252016-12-21 06:23:57,177 configure.py main:947 Configuring firewall rules
3262016-12-21 06:23:57,177 configure.py main:951 Configuring PF rules
3272016-12-21 06:23:57,177 configure.py main:955 Configuring s2s vpn
3282016-12-21 06:23:57,177 configure.py main:959 Configuring remote access vpn
3292016-12-21 06:23:57,177 configure.py main:963 Configuring vpn users list
3302016-12-21 06:23:57,177 merge.py load:57 Creating data bag type vpnuserlist
3312016-12-21 06:23:57,177 configure.py main:968 Configuring dhcp entry
3322016-12-21 06:23:57,177 merge.py load:57 Creating data bag type dhcpentry
3332016-12-21 06:23:57,178 CsHelper.py execute:184 Executing: ip addr show
3342016-12-21 06:23:57,188 CsFile.py load:37 File /etc/dhcphosts.txt does not exist
3352016-12-21 06:23:57,188 CsFile.py load:37 File /etc/dnsmasq.d/cloud.conf does not exist
3362016-12-21 06:23:57,188 CsFile.py load:39 Reading file /etc/hosts
3372016-12-21 06:23:57,188 CsFile.py commit:66 Wrote edited file /etc/hosts
3382016-12-21 06:23:57,189 CsFile.py commit:68 Updated file in-cache configuration
3392016-12-21 06:23:57,189 CsDhcp.py write_hosts:125 Updated hosts file
3402016-12-21 06:23:57,189 CsFile.py commit:60 Nothing to commit. The /etc/dnsmasq.d/cloud.conf file did not change
3412016-12-21 06:23:57,189 CsFile.py commit:60 Nothing to commit. The /etc/dhcphosts.txt file did not change
3422016-12-21 06:23:57,189 CsHelper.py execute:184 Executing: service dnsmasq restart
3432016-12-21 06:23:59,244 CsHelper.py service:213 Service dnsmasq restart
3442016-12-21 06:23:59,244 configure.py main:973 Configuring load balancer
3452016-12-21 06:23:59,244 configure.py main:977 Configuring monitor service
3462016-12-21 06:23:59,245 merge.py load:57 Creating data bag type monitorservice
3472016-12-21 06:23:59,245 merge.py load:57 Creating data bag type networkacl
3482016-12-21 06:23:59,245 merge.py load:57 Creating data bag type firewallrules
3492016-12-21 06:23:59,245 configure.py flushAllowAllEgressRules:267 Flush allow 'all' egress firewall rule
3502016-12-21 06:23:59,246 CsHelper.py execute:184 Executing: iptables-save | grep '^:FW_EGRESS_RULES' || iptables -t filter -N FW_EGRESS_RULES
3512016-12-21 06:23:59,307 CsHelper.py execute:184 Executing: iptables-save | grep '^-A FW_EGRESS_RULES -j ACCEPT$' | sed 's/^-A/iptables -t filter -D/g' | bash
3522016-12-21 06:23:59,317 merge.py load:57 Creating data bag type forwardingrules
3532016-12-21 06:23:59,317 merge.py load:57 Creating data bag type site2sitevpn
3542016-12-21 06:23:59,318 merge.py load:57 Creating data bag type remoteaccessvpn
3552016-12-21 06:23:59,319 configure.py process:618 {'id': 'remoteaccessvpn'}
3562016-12-21 06:23:59,319 merge.py load:57 Creating data bag type loadbalancer
3572016-12-21 06:23:59,319 configure.py main:1002 Configuring iptables rules
3582016-12-21 06:23:59,319 CsHelper.py execute:184 Executing: iptables-save
3592016-12-21 06:23:59,324 CsHelper.py execute:184 Executing: iptables -t filter -N FW_OUTBOUND
3602016-12-21 06:23:59,329 CsHelper.py execute:184 Executing: iptables -t filter -N
3612016-12-21 06:23:59,333 CsHelper.py execute:184 Executing: iptables -t mangle -N PREROUTING
3622016-12-21 06:23:59,348 CsHelper.py execute:184 Executing: iptables -t filter -N NETWORK_STATS
3632016-12-21 06:23:59,353 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-j': u'ACCEPT', u'-A': u'FW_OUTBOUND', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FW_OUTBOUND
3642016-12-21 06:23:59,354 CsNetfilter.py compare:164 Add: rule=-A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
3652016-12-21 06:23:59,354 CsHelper.py execute:184 Executing: iptables -t filter -A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT
3662016-12-21 06:23:59,373 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth1', u'-m2': u'state', u'--dport': u'3922', u'-p': u'tcp', u'--state': u'NEW,ESTABLISHED', u'-j': u'ACCEPT'} table=filter chain=INPUT
3672016-12-21 06:23:59,374 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT table=filter
3682016-12-21 06:23:59,374 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT
3692016-12-21 06:23:59,391 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-P': u'INPUT'} table=filter chain=
3702016-12-21 06:23:59,392 CsNetfilter.py compare:164 Add: rule=-P INPUT DROP table=filter
3712016-12-21 06:23:59,392 CsHelper.py execute:184 Executing: iptables -t filter -P INPUT DROP
3722016-12-21 06:23:59,395 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-P': u'FORWARD'} table=filter chain=
3732016-12-21 06:23:59,396 CsNetfilter.py compare:164 Add: rule=-P FORWARD DROP table=filter
3742016-12-21 06:23:59,396 CsHelper.py execute:184 Executing: iptables -t filter -P FORWARD DROP
3752016-12-21 06:23:59,399 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'PREROUTING', u'-i': u'eth0', u'-j': u'CONNMARK', u'--set-xmark': u'0x0/0xffffffff', u'--state': u'NEW', u'-m2': u'state'} table=mangle chain=PREROUTING
3762016-12-21 06:23:59,400 CsNetfilter.py compare:164 Add: rule=-A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff table=mangle
3772016-12-21 06:23:59,400 CsHelper.py execute:184 Executing: iptables -t mangle -A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff
3782016-12-21 06:23:59,415 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'PREROUTING', u'--restore-mark': u'--nfmask', u'-j': u'CONNMARK', u'0xffffffff': u'--ctmask', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=mangle chain=PREROUTING
3792016-12-21 06:23:59,415 CsNetfilter.py compare:164 Add: rule=-A PREROUTING -m state --state RELATED,ESTABLISHED -j CONNMARK --restore-mark --nfmask 0xffffffff --ctmask 0xffffffff table=mangle
3802016-12-21 06:23:59,415 CsHelper.py execute:184 Executing: iptables -t mangle -I PREROUTING -m state --state RELATED,ESTABLISHED -j CONNMARK --restore-mark --nfmask 0xffffffff --ctmask 0xffffffff
3812016-12-21 06:23:59,419 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'224.0.0.18/32', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
3822016-12-21 06:23:59,419 CsNetfilter.py compare:164 Add: rule=-A INPUT -d 224.0.0.18/32 -j ACCEPT table=filter
3832016-12-21 06:23:59,419 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -d 224.0.0.18/32 -j ACCEPT
3842016-12-21 06:23:59,423 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'225.0.0.50/32', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
3852016-12-21 06:23:59,423 CsNetfilter.py compare:164 Add: rule=-A INPUT -d 225.0.0.50/32 -j ACCEPT table=filter
3862016-12-21 06:23:59,424 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -d 225.0.0.50/32 -j ACCEPT
3872016-12-21 06:23:59,427 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-j': u'ACCEPT', u'-A': u'INPUT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=INPUT
3882016-12-21 06:23:59,428 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
3892016-12-21 06:23:59,428 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
3902016-12-21 06:23:59,432 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-p': u'icmp', u'-j': u'ACCEPT'} table=filter chain=INPUT
3912016-12-21 06:23:59,432 CsNetfilter.py compare:164 Add: rule=-A INPUT -p icmp -j ACCEPT table=filter
3922016-12-21 06:23:59,432 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -p icmp -j ACCEPT
3932016-12-21 06:23:59,436 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'lo', u'-A': u'INPUT', u'-j': u'ACCEPT'} table=filter chain=INPUT
3942016-12-21 06:23:59,436 CsNetfilter.py compare:164 Add: rule=-A INPUT -i lo -j ACCEPT table=filter
3952016-12-21 06:23:59,437 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i lo -j ACCEPT
3962016-12-21 06:23:59,440 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'67', u'-p': u'udp'} table=filter chain=INPUT
3972016-12-21 06:23:59,441 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT table=filter
3982016-12-21 06:23:59,441 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT
3992016-12-21 06:23:59,447 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'udp'} table=filter chain=INPUT
4002016-12-21 06:23:59,447 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 53 -j ACCEPT table=filter
4012016-12-21 06:23:59,447 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p udp -m udp --dport 53 -j ACCEPT
4022016-12-21 06:23:59,451 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'tcp'} table=filter chain=INPUT
4032016-12-21 06:23:59,452 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 53 -j ACCEPT table=filter
4042016-12-21 06:23:59,452 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 53 -j ACCEPT
4052016-12-21 06:23:59,456 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'80', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
4062016-12-21 06:23:59,456 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 80 -m state --state NEW -j ACCEPT table=filter
4072016-12-21 06:23:59,456 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 80 -m state --state NEW -j ACCEPT
4082016-12-21 06:23:59,460 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'8080', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
4092016-12-21 06:23:59,460 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p tcp -m tcp --dport 8080 -m state --state NEW -j ACCEPT table=filter
4102016-12-21 06:23:59,460 CsHelper.py execute:184 Executing: iptables -t filter -A INPUT -i eth0 -p tcp -m tcp --dport 8080 -m state --state NEW -j ACCEPT
4112016-12-21 06:23:59,464 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth1', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
4122016-12-21 06:23:59,464 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth1 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
4132016-12-21 06:23:59,464 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth1 -m state --state RELATED,ESTABLISHED -j ACCEPT
4142016-12-21 06:23:59,468 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'NEW', u'-m2': u'state'} table=filter chain=FORWARD
4152016-12-21 06:23:59,468 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth0 -m state --state NEW -j ACCEPT table=filter
4162016-12-21 06:23:59,468 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth0 -m state --state NEW -j ACCEPT
4172016-12-21 06:23:59,471 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth2', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
4182016-12-21 06:23:59,472 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth2 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
4192016-12-21 06:23:59,472 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth2 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
4202016-12-21 06:23:59,475 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-o': u'eth0', u'-i': u'eth0', u'-j': u'ACCEPT', u'--state': u'RELATED,ESTABLISHED', u'-m2': u'state'} table=filter chain=FORWARD
4212016-12-21 06:23:59,475 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT table=filter
4222016-12-21 06:23:59,476 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth0 -m state --state RELATED,ESTABLISHED -j ACCEPT
4232016-12-21 06:23:59,479 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-o': u'eth2', u'-A': u'FORWARD', u'-j': u'FW_OUTBOUND'} table=filter chain=FORWARD
4242016-12-21 06:23:59,479 CsNetfilter.py compare:164 Add: rule=-A FORWARD -i eth0 -o eth2 -j FW_OUTBOUND table=filter
4252016-12-21 06:23:59,479 CsHelper.py execute:184 Executing: iptables -t filter -A FORWARD -i eth0 -o eth2 -j FW_OUTBOUND
4262016-12-21 06:23:59,482 CsNetfilter.py compare:148 Already processed : ('mangle', '', u'-A PREROUTING -i eth0 -m state --state NEW -j CONNMARK --set-xmark 0x0/0xffffffff')
4272016-12-21 06:23:59,483 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'FORWARD', u'-j': u'NETWORK_STATS'} table=filter chain=FORWARD
4282016-12-21 06:23:59,483 CsNetfilter.py compare:164 Add: rule=-A FORWARD -j NETWORK_STATS table=filter
4292016-12-21 06:23:59,483 CsHelper.py execute:184 Executing: iptables -t filter -I FORWARD -j NETWORK_STATS
4302016-12-21 06:23:59,486 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-j': u'NETWORK_STATS'} table=filter chain=INPUT
4312016-12-21 06:23:59,486 CsNetfilter.py compare:164 Add: rule=-A INPUT -j NETWORK_STATS table=filter
4322016-12-21 06:23:59,486 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -j NETWORK_STATS
4332016-12-21 06:23:59,490 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'OUTPUT', u'-j': u'NETWORK_STATS'} table=filter chain=OUTPUT
4342016-12-21 06:23:59,490 CsNetfilter.py compare:164 Add: rule=-A OUTPUT -j NETWORK_STATS table=filter
4352016-12-21 06:23:59,490 CsHelper.py execute:184 Executing: iptables -t filter -I OUTPUT -j NETWORK_STATS
4362016-12-21 06:23:59,493 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth0', u'-o': u'eth2', u'-A': u'NETWORK_STATS'} table=filter chain=NETWORK_STATS
4372016-12-21 06:23:59,493 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth0 -o eth2 table=filter
4382016-12-21 06:23:59,493 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth0 -o eth2
4392016-12-21 06:23:59,497 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-i': u'eth2', u'-o': u'eth0', u'-A': u'NETWORK_STATS'} table=filter chain=NETWORK_STATS
4402016-12-21 06:23:59,497 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth2 -o eth0 table=filter
4412016-12-21 06:23:59,497 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth2 -o eth0
4422016-12-21 06:23:59,500 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-o': u'eth2', u'-A': u'NETWORK_STATS', u'-p': u'tcp', u'!_-i': u'eth0'} table=filter chain=NETWORK_STATS
4432016-12-21 06:23:59,500 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -o eth2 ! -i eth0 -p tcp table=filter
4442016-12-21 06:23:59,500 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -o eth2 ! -i eth0 -p tcp
4452016-12-21 06:23:59,503 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'!_-o': u'eth0', u'-i': u'eth2', u'-A': u'NETWORK_STATS', u'-p': u'tcp'} table=filter chain=NETWORK_STATS
4462016-12-21 06:23:59,503 CsNetfilter.py compare:164 Add: rule=-A NETWORK_STATS -i eth2 ! -o eth0 -p tcp table=filter
4472016-12-21 06:23:59,504 CsHelper.py execute:184 Executing: iptables -t filter -A NETWORK_STATS -i eth2 ! -o eth0 -p tcp
4482016-12-21 06:23:59,506 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'67', u'-p': u'udp'} table=filter chain=INPUT
4492016-12-21 06:23:59,507 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT table=filter
4502016-12-21 06:23:59,507 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -p udp -m udp --dport 67 -j ACCEPT
4512016-12-21 06:23:59,510 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'udp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'udp'} table=filter chain=INPUT
4522016-12-21 06:23:59,510 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p udp -m udp --dport 53 -j ACCEPT table=filter
4532016-12-21 06:23:59,510 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p udp -m udp --dport 53 -j ACCEPT
4542016-12-21 06:23:59,513 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-j': u'ACCEPT', u'--dport': u'53', u'-p': u'tcp'} table=filter chain=INPUT
4552016-12-21 06:23:59,514 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp --dport 53 -j ACCEPT table=filter
4562016-12-21 06:23:59,514 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp --dport 53 -j ACCEPT
4572016-12-21 06:23:59,517 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'80', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
4582016-12-21 06:23:59,517 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 80 -j ACCEPT table=filter
4592016-12-21 06:23:59,517 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 80 -j ACCEPT
4602016-12-21 06:23:59,521 CsNetfilter.py compare:159 Checking if the rule already exists: rule={u'-d': u'10.3.28.10/32', u'-A': u'INPUT', u'-m': u'tcp', u'-i': u'eth0', u'-m2': u'state', u'--dport': u'443', u'-p': u'tcp', u'--state': u'NEW', u'-j': u'ACCEPT'} table=filter chain=INPUT
4612016-12-21 06:23:59,521 CsNetfilter.py compare:164 Add: rule=-A INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 443 -j ACCEPT table=filter
4622016-12-21 06:23:59,521 CsHelper.py execute:184 Executing: iptables -t filter -I INPUT -i eth0 -d 10.3.28.10/32 -p tcp -m tcp -m state --state NEW --dport 443 -j ACCEPT
4632016-12-21 06:23:59,524 CsNetfilter.py compare:148 Already processed : ('filter', '', '-A FW_OUTBOUND -m state --state RELATED,ESTABLISHED -j ACCEPT')
4642016-12-21 06:23:59,524 CsNetfilter.py compare:148 Already processed : ('filter', '', '-A INPUT -i eth1 -p tcp -m tcp --dport 3922 -m state --state NEW,ESTABLISHED -j ACCEPT')
4652016-12-21 06:23:59,524 CsNetfilter.py compare:148 Already processed : ('filter', '', '-P INPUT DROP')
4662016-12-21 06:23:59,524 CsNetfilter.py compare:148 Already processed : ('filter', '', '-P FORWARD DROP')
4672016-12-21 06:23:59,524 merge.py load:60 Loading data bag type cmdline
4682016-12-21 06:23:59,526 configure.py main:1006 Configuring iptables rules done ...saving rules
4692016-12-21 06:23:59,526 CsHelper.py save_iptables:192 Saving iptables for iptables-save
4702016-12-21 06:23:59,526 CsHelper.py execute:184 Executing: iptables-save
4712016-12-21 06:23:59,530 CsHelper.py save_iptables:192 Saving iptables for ip6tables-save
4722016-12-21 06:23:59,530 CsHelper.py execute:184 Executing: ip6tables-save
4732016-12-21 06:23:59,532 CsRedundant.py set:68 Router redundancy status is False
4742016-12-21 06:23:59,533 CsHelper.py execute:184 Executing: service conntrackd stop
4752016-12-21 06:23:59,546 CsHelper.py service:213 Service conntrackd stop
4762016-12-21 06:23:59,546 CsHelper.py execute:184 Executing: service keepalived stop
4772016-12-21 06:23:59,554 CsHelper.py service:213 Service keepalived stop
4782016-12-21 06:23:59,554 CsHelper.py execute:184 Executing: mount
4792016-12-21 06:23:59,557 configure.py main:1016 Configuring static routes
4802016-12-21 06:23:59,557 merge.py load:57 Creating data bag type staticroutes
4812016-12-21 06:23:59,557 CsStaticRoutes.py process:27 Processing CsStaticRoutes file ==> {'id': 'staticroutes'}
482Wed Dec 21 06:25:02 UTC 2016 : VR config: configuation format version 1.0
483Wed Dec 21 06:25:02 UTC 2016 : VR config: creating file: /var/cache/cloud/monitor_service.json
484Wed Dec 21 06:25:02 UTC 2016 : VR config: create file success
485Wed Dec 21 06:25:02 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py monitor_service.json
4862016-12-21 06:25:02,882 merge.py load:57 Creating data bag type monitorservice
4872016-12-21 06:25:02,886 merge.py process:100 Command of type monitorservice received
4882016-12-21 06:25:02,886 merge.py save:71 Writing data bag type monitorservice
4892016-12-21 06:25:02,887 merge.py save:72 {'config': u'[dhcp]:processname=dnsmasq:servicename=dnsmasq:pidfile=/var/run/dnsmasq/dnsmasq.pid:,[ssh]:processname=sshd:servicename=ssh:pidfile=/var/run/sshd.pid:,[webserver]:processname=apache2:servicename=apache2:pidfile=/var/run/apache2.pid:,', 'id': u'monitorservice'}
4902016-12-21 06:25:02,887 merge.py load:60 Loading data bag type ips
4912016-12-21 06:25:02,887 merge.py load:60 Loading data bag type cmdline
4922016-12-21 06:25:02,887 configure.py main:924 Configuring ip addresses
4932016-12-21 06:25:02,888 CsHelper.py execute:184 Executing: ip addr show dev eth1
4942016-12-21 06:25:02,899 CsHelper.py execute:184 Executing: ip addr show dev eth0
4952016-12-21 06:25:02,905 CsHelper.py execute:184 Executing: ip addr show dev eth1
4962016-12-21 06:25:02,910 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
4972016-12-21 06:25:02,910 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
4982016-12-21 06:25:02,910 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
4992016-12-21 06:25:02,910 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
5002016-12-21 06:25:02,919 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
5012016-12-21 06:25:02,919 CsHelper.py execute:184 Executing: ip -4 route list 0/0
5022016-12-21 06:25:02,925 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
5032016-12-21 06:25:02,925 CsHelper.py execute:184 Executing: ip addr show dev eth0
5042016-12-21 06:25:02,935 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
5052016-12-21 06:25:02,935 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
5062016-12-21 06:25:02,935 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
5072016-12-21 06:25:02,935 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
5082016-12-21 06:25:02,940 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
5092016-12-21 06:25:02,941 CsHelper.py execute:184 Executing: ip rule show
5102016-12-21 06:25:02,950 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
5112016-12-21 06:25:02,955 CsRule.py addMark:37 Added fwmark rule for Table_eth0
5122016-12-21 06:25:02,955 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
5132016-12-21 06:25:02,962 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
5142016-12-21 06:25:22,990 CsAddress.py inKernel:686 rpsfr is not present in the kernel
5152016-12-21 06:25:22,990 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
5162016-12-21 06:25:22,991 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
5172016-12-21 06:25:22,991 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
5182016-12-21 06:25:22,997 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
5192016-12-21 06:25:22,997 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
5202016-12-21 06:25:22,999 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
5212016-12-21 06:25:23,000 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
5222016-12-21 06:25:23,001 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
5232016-12-21 06:25:23,003 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
5242016-12-21 06:25:23,004 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
5252016-12-21 06:25:23,006 CsHelper.py execute:184 Executing: ps aux
5262016-12-21 06:25:23,021 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
5272016-12-21 06:25:23,021 CsHelper.py execute:184 Executing: ip -4 route list 0/0
5282016-12-21 06:25:23,025 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
5292016-12-21 06:25:23,025 configure.py main:977 Configuring monitor service
5302016-12-21 06:25:23,025 merge.py load:60 Loading data bag type monitorservice
5312016-12-21 06:25:23,025 CsFile.py load:37 File /etc/monitor.conf does not exist
5322016-12-21 06:25:23,026 CsFile.py commit:66 Wrote edited file /etc/monitor.conf
5332016-12-21 06:25:23,026 CsFile.py commit:68 Updated file in-cache configuration
5342016-12-21 06:25:23,026 CsFile.py load:37 File /etc/cron.d/process does not exist
5352016-12-21 06:25:23,026 CsFile.py commit:66 Wrote edited file /etc/cron.d/process
5362016-12-21 06:25:23,027 CsFile.py commit:68 Updated file in-cache configuration
5372016-12-21 06:25:23,027 CsRedundant.py set:68 Router redundancy status is False
5382016-12-21 06:25:23,027 CsHelper.py execute:184 Executing: service conntrackd stop
5392016-12-21 06:25:23,042 CsHelper.py service:213 Service conntrackd stop
5402016-12-21 06:25:23,043 CsHelper.py execute:184 Executing: service keepalived stop
5412016-12-21 06:25:23,051 CsHelper.py service:213 Service keepalived stop
5422016-12-21 06:25:23,052 CsHelper.py execute:184 Executing: mount
543[INFO] update_config.py :: Processing incoming file => monitor_service.json
544[INFO] Processing JSON file monitor_service.json
545Wed Dec 21 06:25:23 UTC 2016 : VR config: execution success
546Wed Dec 21 06:25:23 UTC 2016 : VR config: creating file: /var/cache/cloud/vm_dhcp_entry.json
547Wed Dec 21 06:25:23 UTC 2016 : VR config: create file success
548Wed Dec 21 06:25:23 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
5492016-12-21 06:25:23,132 merge.py load:57 Creating data bag type dhcpentry
5502016-12-21 06:25:23,133 merge.py process:100 Command of type dhcpentry received
5512016-12-21 06:25:23,133 merge.py save:71 Writing data bag type dhcpentry
5522016-12-21 06:25:23,133 merge.py save:72 {u'10.3.28.168': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:1f:1e:00:04:4b', u'default_entry': False, u'ipv4_adress': u'10.3.28.168', u'host_name': u'server-923', u'mac_address': u'06:1f:1e:00:04:4b', u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, 'id': u'dhcpentry'}
5532016-12-21 06:25:23,134 merge.py load:60 Loading data bag type ips
5542016-12-21 06:25:23,134 merge.py load:60 Loading data bag type cmdline
5552016-12-21 06:25:23,134 configure.py main:924 Configuring ip addresses
5562016-12-21 06:25:23,135 CsHelper.py execute:184 Executing: ip addr show dev eth1
5572016-12-21 06:25:23,138 CsHelper.py execute:184 Executing: ip addr show dev eth0
5582016-12-21 06:25:23,140 CsHelper.py execute:184 Executing: ip addr show dev eth1
5592016-12-21 06:25:23,143 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
5602016-12-21 06:25:23,143 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
5612016-12-21 06:25:23,143 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
5622016-12-21 06:25:23,144 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
5632016-12-21 06:25:23,146 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
5642016-12-21 06:25:23,146 CsHelper.py execute:184 Executing: ip -4 route list 0/0
5652016-12-21 06:25:23,149 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
5662016-12-21 06:25:23,149 CsHelper.py execute:184 Executing: ip addr show dev eth0
5672016-12-21 06:25:23,152 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
5682016-12-21 06:25:23,152 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
5692016-12-21 06:25:23,152 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
5702016-12-21 06:25:23,152 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
5712016-12-21 06:25:23,155 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
5722016-12-21 06:25:23,156 CsHelper.py execute:184 Executing: ip rule show
5732016-12-21 06:25:23,158 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
5742016-12-21 06:25:23,160 CsRule.py addMark:37 Added fwmark rule for Table_eth0
5752016-12-21 06:25:23,160 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
5762016-12-21 06:25:23,163 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
5772016-12-21 06:25:43,188 CsAddress.py inKernel:686 rpsfr is not present in the kernel
5782016-12-21 06:25:43,188 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
5792016-12-21 06:25:43,189 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
5802016-12-21 06:25:43,189 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
5812016-12-21 06:25:43,195 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
5822016-12-21 06:25:43,196 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
5832016-12-21 06:25:43,197 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
5842016-12-21 06:25:43,198 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
5852016-12-21 06:25:43,200 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
5862016-12-21 06:25:43,201 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
5872016-12-21 06:25:43,202 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
5882016-12-21 06:25:43,204 CsHelper.py execute:184 Executing: ps aux
5892016-12-21 06:25:43,219 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
5902016-12-21 06:25:43,219 CsHelper.py execute:184 Executing: ip -4 route list 0/0
5912016-12-21 06:25:43,223 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
5922016-12-21 06:25:43,223 configure.py main:968 Configuring dhcp entry
5932016-12-21 06:25:43,224 merge.py load:60 Loading data bag type dhcpentry
5942016-12-21 06:25:43,224 CsHelper.py execute:184 Executing: ip addr show
5952016-12-21 06:25:43,228 CsFile.py load:37 File /etc/dhcphosts.txt does not exist
5962016-12-21 06:25:43,228 CsFile.py load:37 File /etc/dnsmasq.d/cloud.conf does not exist
5972016-12-21 06:25:43,229 CsFile.py load:39 Reading file /etc/hosts
5982016-12-21 06:25:43,229 CsFile.py commit:66 Wrote edited file /etc/hosts
5992016-12-21 06:25:43,229 CsFile.py commit:68 Updated file in-cache configuration
6002016-12-21 06:25:43,229 CsDhcp.py write_hosts:125 Updated hosts file
6012016-12-21 06:25:43,229 CsFile.py search:124 Searching for dhcp-range=interface:eth0,set:interface-eth0-0 and replacing with dhcp-range=interface:eth0,set:interface-eth0-0,10.3.28.10,static
6022016-12-21 06:25:43,230 merge.py load:57 Creating data bag type guestnetwork
6032016-12-21 06:25:43,230 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,15 and replacing with dhcp-option=tag:interface-eth0-0,15,nocser.net
6042016-12-21 06:25:43,231 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6052016-12-21 06:25:43,232 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6062016-12-21 06:25:43,232 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,6 and replacing with dhcp-option=tag:interface-eth0-0,6,10.3.28.10,8.8.8.8,8.8.4.4
6072016-12-21 06:25:43,233 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,3, and replacing with dhcp-option=tag:interface-eth0-0,3,0.0.0.0
6082016-12-21 06:25:43,233 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6092016-12-21 06:25:43,234 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,1, and replacing with dhcp-option=tag:interface-eth0-0,1,255.255.255.0
6102016-12-21 06:25:43,234 CsFile.py commit:66 Wrote edited file /etc/dnsmasq.d/cloud.conf
6112016-12-21 06:25:43,235 CsFile.py commit:68 Updated file in-cache configuration
6122016-12-21 06:25:43,235 CsFile.py commit:66 Wrote edited file /etc/dhcphosts.txt
6132016-12-21 06:25:43,235 CsFile.py commit:68 Updated file in-cache configuration
6142016-12-21 06:25:43,235 CsHelper.py execute:184 Executing: service dnsmasq restart
6152016-12-21 06:25:45,258 CsHelper.py service:213 Service dnsmasq restart
6162016-12-21 06:25:45,258 CsRedundant.py set:68 Router redundancy status is False
6172016-12-21 06:25:45,259 CsHelper.py execute:184 Executing: service conntrackd stop
6182016-12-21 06:25:45,278 CsHelper.py service:213 Service conntrackd stop
6192016-12-21 06:25:45,278 CsHelper.py execute:184 Executing: service keepalived stop
6202016-12-21 06:25:45,287 CsHelper.py service:213 Service keepalived stop
6212016-12-21 06:25:45,287 CsHelper.py execute:184 Executing: mount
622[INFO] update_config.py :: Processing incoming file => vm_dhcp_entry.json
623[INFO] Processing JSON file vm_dhcp_entry.json
624Wed Dec 21 06:25:45 UTC 2016 : VR config: execution success
625Wed Dec 21 06:25:45 UTC 2016 : VR config: creating file: /var/cache/cloud/vm_dhcp_entry.json
626Wed Dec 21 06:25:45 UTC 2016 : VR config: create file success
627Wed Dec 21 06:25:45 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
6282016-12-21 06:25:45,374 merge.py load:60 Loading data bag type dhcpentry
6292016-12-21 06:25:45,375 merge.py process:100 Command of type dhcpentry received
6302016-12-21 06:25:45,375 merge.py save:71 Writing data bag type dhcpentry
6312016-12-21 06:25:45,375 merge.py save:72 {u'10.3.28.62': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:81:c2:00:03:e1', u'default_entry': False, u'ipv4_adress': u'10.3.28.62', u'host_name': u'monitor', u'mac_address': u'06:81:c2:00:03:e1', u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.168': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:1f:1e:00:04:4b', u'mac_address': u'06:1f:1e:00:04:4b', u'ipv4_adress': u'10.3.28.168', u'host_name': u'server-923', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'id': u'dhcpentry'}
6322016-12-21 06:25:45,376 merge.py load:60 Loading data bag type ips
6332016-12-21 06:25:45,376 merge.py load:60 Loading data bag type cmdline
6342016-12-21 06:25:45,377 configure.py main:924 Configuring ip addresses
6352016-12-21 06:25:45,377 CsHelper.py execute:184 Executing: ip addr show dev eth1
6362016-12-21 06:25:45,380 CsHelper.py execute:184 Executing: ip addr show dev eth0
6372016-12-21 06:25:45,383 CsHelper.py execute:184 Executing: ip addr show dev eth1
6382016-12-21 06:25:45,385 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
6392016-12-21 06:25:45,386 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
6402016-12-21 06:25:45,386 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
6412016-12-21 06:25:45,386 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
6422016-12-21 06:25:45,389 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
6432016-12-21 06:25:45,389 CsHelper.py execute:184 Executing: ip -4 route list 0/0
6442016-12-21 06:25:45,391 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
6452016-12-21 06:25:45,391 CsHelper.py execute:184 Executing: ip addr show dev eth0
6462016-12-21 06:25:45,394 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
6472016-12-21 06:25:45,394 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
6482016-12-21 06:25:45,395 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
6492016-12-21 06:25:45,395 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
6502016-12-21 06:25:45,398 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
6512016-12-21 06:25:45,398 CsHelper.py execute:184 Executing: ip rule show
6522016-12-21 06:25:45,401 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
6532016-12-21 06:25:45,403 CsRule.py addMark:37 Added fwmark rule for Table_eth0
6542016-12-21 06:25:45,404 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
6552016-12-21 06:25:45,407 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
6562016-12-21 06:26:05,432 CsAddress.py inKernel:686 rpsfr is not present in the kernel
6572016-12-21 06:26:05,432 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
6582016-12-21 06:26:05,433 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
6592016-12-21 06:26:05,433 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
6602016-12-21 06:26:05,439 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
6612016-12-21 06:26:05,440 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
6622016-12-21 06:26:05,441 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
6632016-12-21 06:26:05,443 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
6642016-12-21 06:26:05,444 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
6652016-12-21 06:26:05,445 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
6662016-12-21 06:26:05,447 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
6672016-12-21 06:26:05,448 CsHelper.py execute:184 Executing: ps aux
6682016-12-21 06:26:05,463 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
6692016-12-21 06:26:05,464 CsHelper.py execute:184 Executing: ip -4 route list 0/0
6702016-12-21 06:26:05,467 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
6712016-12-21 06:26:05,467 configure.py main:968 Configuring dhcp entry
6722016-12-21 06:26:05,468 merge.py load:60 Loading data bag type dhcpentry
6732016-12-21 06:26:05,468 CsHelper.py execute:184 Executing: ip addr show
6742016-12-21 06:26:05,472 CsFile.py load:39 Reading file /etc/dhcphosts.txt
6752016-12-21 06:26:05,472 CsFile.py load:39 Reading file /etc/dnsmasq.d/cloud.conf
6762016-12-21 06:26:05,473 CsFile.py load:39 Reading file /etc/hosts
6772016-12-21 06:26:05,473 CsFile.py commit:66 Wrote edited file /etc/hosts
6782016-12-21 06:26:05,473 CsFile.py commit:68 Updated file in-cache configuration
6792016-12-21 06:26:05,474 CsDhcp.py write_hosts:125 Updated hosts file
6802016-12-21 06:26:05,474 CsFile.py search:124 Searching for dhcp-range=interface:eth0,set:interface-eth0-0 and replacing with dhcp-range=interface:eth0,set:interface-eth0-0,10.3.28.10,static
6812016-12-21 06:26:05,475 merge.py load:57 Creating data bag type guestnetwork
6822016-12-21 06:26:05,475 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,15 and replacing with dhcp-option=tag:interface-eth0-0,15,nocser.net
6832016-12-21 06:26:05,476 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6842016-12-21 06:26:05,477 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6852016-12-21 06:26:05,477 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,6 and replacing with dhcp-option=tag:interface-eth0-0,6,10.3.28.10,8.8.8.8,8.8.4.4
6862016-12-21 06:26:05,478 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,3, and replacing with dhcp-option=tag:interface-eth0-0,3,0.0.0.0
6872016-12-21 06:26:05,478 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
6882016-12-21 06:26:05,479 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,1, and replacing with dhcp-option=tag:interface-eth0-0,1,255.255.255.0
6892016-12-21 06:26:05,479 CsFile.py commit:60 Nothing to commit. The /etc/dnsmasq.d/cloud.conf file did not change
6902016-12-21 06:26:05,480 CsFile.py commit:66 Wrote edited file /etc/dhcphosts.txt
6912016-12-21 06:26:05,480 CsFile.py commit:68 Updated file in-cache configuration
6922016-12-21 06:26:05,480 CsHelper.py execute:184 Executing: service dnsmasq restart
6932016-12-21 06:26:07,502 CsHelper.py service:213 Service dnsmasq restart
6942016-12-21 06:26:07,503 CsRedundant.py set:68 Router redundancy status is False
6952016-12-21 06:26:07,503 CsHelper.py execute:184 Executing: service conntrackd stop
6962016-12-21 06:26:07,522 CsHelper.py service:213 Service conntrackd stop
6972016-12-21 06:26:07,522 CsHelper.py execute:184 Executing: service keepalived stop
6982016-12-21 06:26:07,531 CsHelper.py service:213 Service keepalived stop
6992016-12-21 06:26:07,531 CsHelper.py execute:184 Executing: mount
700[INFO] update_config.py :: Processing incoming file => vm_dhcp_entry.json
701[INFO] Processing JSON file vm_dhcp_entry.json
702server-923 monitor
703Wed Dec 21 06:26:07 UTC 2016 : VR config: execution success
704Wed Dec 21 06:26:07 UTC 2016 : VR config: creating file: /var/cache/cloud/vm_dhcp_entry.json
705Wed Dec 21 06:26:07 UTC 2016 : VR config: create file success
706Wed Dec 21 06:26:07 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
7072016-12-21 06:26:07,618 merge.py load:60 Loading data bag type dhcpentry
7082016-12-21 06:26:07,619 merge.py process:100 Command of type dhcpentry received
7092016-12-21 06:26:07,619 merge.py save:71 Writing data bag type dhcpentry
7102016-12-21 06:26:07,619 merge.py save:72 {u'10.3.28.115': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:4f:64:00:04:16', u'default_entry': False, u'ipv4_adress': u'10.3.28.115', u'host_name': u'sv1', u'mac_address': u'06:4f:64:00:04:16', u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.62': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:81:c2:00:03:e1', u'mac_address': u'06:81:c2:00:03:e1', u'ipv4_adress': u'10.3.28.62', u'host_name': u'monitor', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.168': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:1f:1e:00:04:4b', u'mac_address': u'06:1f:1e:00:04:4b', u'ipv4_adress': u'10.3.28.168', u'host_name': u'server-923', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'id': u'dhcpentry'}
7112016-12-21 06:26:07,620 merge.py load:60 Loading data bag type ips
7122016-12-21 06:26:07,620 merge.py load:60 Loading data bag type cmdline
7132016-12-21 06:26:07,621 configure.py main:924 Configuring ip addresses
7142016-12-21 06:26:07,621 CsHelper.py execute:184 Executing: ip addr show dev eth1
7152016-12-21 06:26:07,624 CsHelper.py execute:184 Executing: ip addr show dev eth0
7162016-12-21 06:26:07,626 CsHelper.py execute:184 Executing: ip addr show dev eth1
7172016-12-21 06:26:07,629 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
7182016-12-21 06:26:07,629 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
7192016-12-21 06:26:07,630 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
7202016-12-21 06:26:07,630 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
7212016-12-21 06:26:07,632 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
7222016-12-21 06:26:07,633 CsHelper.py execute:184 Executing: ip -4 route list 0/0
7232016-12-21 06:26:07,635 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
7242016-12-21 06:26:07,635 CsHelper.py execute:184 Executing: ip addr show dev eth0
7252016-12-21 06:26:07,638 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
7262016-12-21 06:26:07,638 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
7272016-12-21 06:26:07,639 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
7282016-12-21 06:26:07,639 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
7292016-12-21 06:26:07,641 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
7302016-12-21 06:26:07,642 CsHelper.py execute:184 Executing: ip rule show
7312016-12-21 06:26:07,645 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
7322016-12-21 06:26:07,647 CsRule.py addMark:37 Added fwmark rule for Table_eth0
7332016-12-21 06:26:07,647 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
7342016-12-21 06:26:07,651 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
7352016-12-21 06:26:27,676 CsAddress.py inKernel:686 rpsfr is not present in the kernel
7362016-12-21 06:26:27,676 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
7372016-12-21 06:26:27,677 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
7382016-12-21 06:26:27,677 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
7392016-12-21 06:26:27,682 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
7402016-12-21 06:26:27,683 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
7412016-12-21 06:26:27,683 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
7422016-12-21 06:26:27,684 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
7432016-12-21 06:26:27,685 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
7442016-12-21 06:26:27,686 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
7452016-12-21 06:26:27,687 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
7462016-12-21 06:26:27,689 CsHelper.py execute:184 Executing: ps aux
7472016-12-21 06:26:27,702 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
7482016-12-21 06:26:27,702 CsHelper.py execute:184 Executing: ip -4 route list 0/0
7492016-12-21 06:26:27,705 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
7502016-12-21 06:26:27,706 configure.py main:968 Configuring dhcp entry
7512016-12-21 06:26:27,706 merge.py load:60 Loading data bag type dhcpentry
7522016-12-21 06:26:27,706 CsHelper.py execute:184 Executing: ip addr show
7532016-12-21 06:26:27,710 CsFile.py load:39 Reading file /etc/dhcphosts.txt
7542016-12-21 06:26:27,711 CsFile.py load:39 Reading file /etc/dnsmasq.d/cloud.conf
7552016-12-21 06:26:27,711 CsFile.py load:39 Reading file /etc/hosts
7562016-12-21 06:26:27,712 CsFile.py commit:66 Wrote edited file /etc/hosts
7572016-12-21 06:26:27,712 CsFile.py commit:68 Updated file in-cache configuration
7582016-12-21 06:26:27,712 CsDhcp.py write_hosts:125 Updated hosts file
7592016-12-21 06:26:27,712 CsFile.py search:124 Searching for dhcp-range=interface:eth0,set:interface-eth0-0 and replacing with dhcp-range=interface:eth0,set:interface-eth0-0,10.3.28.10,static
7602016-12-21 06:26:27,713 merge.py load:57 Creating data bag type guestnetwork
7612016-12-21 06:26:27,714 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,15 and replacing with dhcp-option=tag:interface-eth0-0,15,nocser.net
7622016-12-21 06:26:27,714 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
7632016-12-21 06:26:27,715 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
7642016-12-21 06:26:27,715 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,6 and replacing with dhcp-option=tag:interface-eth0-0,6,10.3.28.10,8.8.8.8,8.8.4.4
7652016-12-21 06:26:27,716 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,3, and replacing with dhcp-option=tag:interface-eth0-0,3,0.0.0.0
7662016-12-21 06:26:27,717 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
7672016-12-21 06:26:27,717 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,1, and replacing with dhcp-option=tag:interface-eth0-0,1,255.255.255.0
7682016-12-21 06:26:27,718 CsFile.py commit:60 Nothing to commit. The /etc/dnsmasq.d/cloud.conf file did not change
7692016-12-21 06:26:27,718 CsFile.py commit:66 Wrote edited file /etc/dhcphosts.txt
7702016-12-21 06:26:27,718 CsFile.py commit:68 Updated file in-cache configuration
7712016-12-21 06:26:27,718 CsHelper.py execute:184 Executing: service dnsmasq restart
7722016-12-21 06:26:29,738 CsHelper.py service:213 Service dnsmasq restart
7732016-12-21 06:26:29,739 CsRedundant.py set:68 Router redundancy status is False
7742016-12-21 06:26:29,739 CsHelper.py execute:184 Executing: service conntrackd stop
7752016-12-21 06:26:29,755 CsHelper.py service:213 Service conntrackd stop
7762016-12-21 06:26:29,755 CsHelper.py execute:184 Executing: service keepalived stop
7772016-12-21 06:26:29,764 CsHelper.py service:213 Service keepalived stop
7782016-12-21 06:26:29,764 CsHelper.py execute:184 Executing: mount
779[INFO] update_config.py :: Processing incoming file => vm_dhcp_entry.json
780[INFO] Processing JSON file vm_dhcp_entry.json
781monitor sv1
782server-923 sv1
783Wed Dec 21 06:26:29 UTC 2016 : VR config: execution success
784Wed Dec 21 06:26:29 UTC 2016 : VR config: creating file: /var/cache/cloud/vm_dhcp_entry.json
785Wed Dec 21 06:26:29 UTC 2016 : VR config: create file success
786Wed Dec 21 06:26:29 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
7872016-12-21 06:26:29,847 merge.py load:60 Loading data bag type dhcpentry
7882016-12-21 06:26:29,848 merge.py process:100 Command of type dhcpentry received
7892016-12-21 06:26:29,848 merge.py save:71 Writing data bag type dhcpentry
7902016-12-21 06:26:29,848 merge.py save:72 {u'10.3.28.115': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:4f:64:00:04:16', u'mac_address': u'06:4f:64:00:04:16', u'ipv4_adress': u'10.3.28.115', u'host_name': u'sv1', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.201': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:7f:20:00:04:6c', u'default_entry': False, u'ipv4_adress': u'10.3.28.201', u'host_name': u'server-1200', u'mac_address': u'06:7f:20:00:04:6c', u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.62': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:81:c2:00:03:e1', u'mac_address': u'06:81:c2:00:03:e1', u'ipv4_adress': u'10.3.28.62', u'host_name': u'monitor', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.168': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:1f:1e:00:04:4b', u'mac_address': u'06:1f:1e:00:04:4b', u'ipv4_adress': u'10.3.28.168', u'host_name': u'server-923', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'id': u'dhcpentry'}
7912016-12-21 06:26:29,849 merge.py load:60 Loading data bag type ips
7922016-12-21 06:26:29,849 merge.py load:60 Loading data bag type cmdline
7932016-12-21 06:26:29,850 configure.py main:924 Configuring ip addresses
7942016-12-21 06:26:29,850 CsHelper.py execute:184 Executing: ip addr show dev eth1
7952016-12-21 06:26:29,853 CsHelper.py execute:184 Executing: ip addr show dev eth0
7962016-12-21 06:26:29,855 CsHelper.py execute:184 Executing: ip addr show dev eth1
7972016-12-21 06:26:29,858 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
7982016-12-21 06:26:29,859 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
7992016-12-21 06:26:29,859 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
8002016-12-21 06:26:29,859 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
8012016-12-21 06:26:29,862 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
8022016-12-21 06:26:29,862 CsHelper.py execute:184 Executing: ip -4 route list 0/0
8032016-12-21 06:26:29,864 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
8042016-12-21 06:26:29,865 CsHelper.py execute:184 Executing: ip addr show dev eth0
8052016-12-21 06:26:29,867 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
8062016-12-21 06:26:29,867 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
8072016-12-21 06:26:29,868 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
8082016-12-21 06:26:29,868 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
8092016-12-21 06:26:29,871 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
8102016-12-21 06:26:29,871 CsHelper.py execute:184 Executing: ip rule show
8112016-12-21 06:26:29,874 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
8122016-12-21 06:26:29,877 CsRule.py addMark:37 Added fwmark rule for Table_eth0
8132016-12-21 06:26:29,877 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
8142016-12-21 06:26:29,880 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
8152016-12-21 06:26:49,904 CsAddress.py inKernel:686 rpsfr is not present in the kernel
8162016-12-21 06:26:49,905 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
8172016-12-21 06:26:49,905 CsRoute.py add_route:50 Adding route: dev eth0 table: Table_eth0 network: 10.3.28.0/24 if not present
8182016-12-21 06:26:49,905 CsHelper.py execute:184 Executing: ip route show dev eth0 table Table_eth0 10.3.28.0/24
8192016-12-21 06:26:49,911 CsFile.py load:39 Reading file /etc/apache2/sites-enabled/vhost-10.3.28.10.conf
8202016-12-21 06:26:49,912 CsFile.py search:124 Searching for <VirtualHost.*:80> and replacing with <VirtualHost 10.3.28.10:80>
8212016-12-21 06:26:49,913 CsFile.py search:124 Searching for <VirtualHost.*:443> and replacing with <VirtualHost 10.3.28.10:443>
8222016-12-21 06:26:49,915 CsFile.py search:124 Searching for Listen .*:80 and replacing with Listen 10.3.28.10:80
8232016-12-21 06:26:49,916 CsFile.py search:124 Searching for Listen .*:443 and replacing with Listen 10.3.28.10:443
8242016-12-21 06:26:49,917 CsFile.py search:124 Searching for NameVirtualHost .*:80 and replacing with NameVirtualHost 10.3.28.10:80
8252016-12-21 06:26:49,918 CsFile.py search:124 Searching for ServerName.* and replacing with ServerName dhcpsrvr.nocser.net
8262016-12-21 06:26:49,920 CsHelper.py execute:184 Executing: ps aux
8272016-12-21 06:26:49,933 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
8282016-12-21 06:26:49,933 CsHelper.py execute:184 Executing: ip -4 route list 0/0
8292016-12-21 06:26:49,937 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
8302016-12-21 06:26:49,937 configure.py main:968 Configuring dhcp entry
8312016-12-21 06:26:49,937 merge.py load:60 Loading data bag type dhcpentry
8322016-12-21 06:26:49,938 CsHelper.py execute:184 Executing: ip addr show
8332016-12-21 06:26:49,942 CsFile.py load:39 Reading file /etc/dhcphosts.txt
8342016-12-21 06:26:49,942 CsFile.py load:39 Reading file /etc/dnsmasq.d/cloud.conf
8352016-12-21 06:26:49,943 CsFile.py load:39 Reading file /etc/hosts
8362016-12-21 06:26:49,943 CsFile.py commit:66 Wrote edited file /etc/hosts
8372016-12-21 06:26:49,943 CsFile.py commit:68 Updated file in-cache configuration
8382016-12-21 06:26:49,944 CsDhcp.py write_hosts:125 Updated hosts file
8392016-12-21 06:26:49,944 CsFile.py search:124 Searching for dhcp-range=interface:eth0,set:interface-eth0-0 and replacing with dhcp-range=interface:eth0,set:interface-eth0-0,10.3.28.10,static
8402016-12-21 06:26:49,945 merge.py load:57 Creating data bag type guestnetwork
8412016-12-21 06:26:49,945 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,15 and replacing with dhcp-option=tag:interface-eth0-0,15,nocser.net
8422016-12-21 06:26:49,946 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
8432016-12-21 06:26:49,946 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
8442016-12-21 06:26:49,947 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,6 and replacing with dhcp-option=tag:interface-eth0-0,6,10.3.28.10,8.8.8.8,8.8.4.4
8452016-12-21 06:26:49,947 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,3, and replacing with dhcp-option=tag:interface-eth0-0,3,0.0.0.0
8462016-12-21 06:26:49,948 CsAddress.py get_guest_if:59 Guest interface will be set on device 'eth0' and IP '10.3.28.10'
8472016-12-21 06:26:49,948 CsFile.py search:124 Searching for dhcp-option=tag:interface-eth0-0,1, and replacing with dhcp-option=tag:interface-eth0-0,1,255.255.255.0
8482016-12-21 06:26:49,949 CsFile.py commit:60 Nothing to commit. The /etc/dnsmasq.d/cloud.conf file did not change
8492016-12-21 06:26:49,949 CsFile.py commit:66 Wrote edited file /etc/dhcphosts.txt
8502016-12-21 06:26:49,950 CsFile.py commit:68 Updated file in-cache configuration
8512016-12-21 06:26:49,950 CsHelper.py execute:184 Executing: service dnsmasq restart
8522016-12-21 06:26:51,971 CsHelper.py service:213 Service dnsmasq restart
8532016-12-21 06:26:51,972 CsRedundant.py set:68 Router redundancy status is False
8542016-12-21 06:26:51,972 CsHelper.py execute:184 Executing: service conntrackd stop
8552016-12-21 06:26:51,992 CsHelper.py service:213 Service conntrackd stop
8562016-12-21 06:26:51,992 CsHelper.py execute:184 Executing: service keepalived stop
8572016-12-21 06:26:52,002 CsHelper.py service:213 Service keepalived stop
8582016-12-21 06:26:52,002 CsHelper.py execute:184 Executing: mount
859[INFO] update_config.py :: Processing incoming file => vm_dhcp_entry.json
860[INFO] Processing JSON file vm_dhcp_entry.json
861sv1 server-1200
862monitor server-1200
863server-923 server-1200
864Wed Dec 21 06:26:52 UTC 2016 : VR config: execution success
865Wed Dec 21 06:26:52 UTC 2016 : VR config: creating file: /var/cache/cloud/vm_dhcp_entry.json
866Wed Dec 21 06:26:52 UTC 2016 : VR config: create file success
867Wed Dec 21 06:26:52 UTC 2016 : VR config: executing: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
8682016-12-21 06:26:52,091 merge.py load:60 Loading data bag type dhcpentry
8692016-12-21 06:26:52,091 merge.py process:100 Command of type dhcpentry received
8702016-12-21 06:26:52,092 merge.py save:71 Writing data bag type dhcpentry
8712016-12-21 06:26:52,092 merge.py save:72 {u'10.3.28.223': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:84:42:00:04:82', u'default_entry': False, u'ipv4_adress': u'10.3.28.223', u'host_name': u'server-1093', u'mac_address': u'06:84:42:00:04:82', u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.115': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:4f:64:00:04:16', u'mac_address': u'06:4f:64:00:04:16', u'ipv4_adress': u'10.3.28.115', u'host_name': u'sv1', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.62': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:81:c2:00:03:e1', u'mac_address': u'06:81:c2:00:03:e1', u'ipv4_adress': u'10.3.28.62', u'host_name': u'monitor', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.168': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:1f:1e:00:04:4b', u'mac_address': u'06:1f:1e:00:04:4b', u'ipv4_adress': u'10.3.28.168', u'host_name': u'server-923', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'10.3.28.201': {u'default_gateway': u'0.0.0.0', u'ipv6_duid': u'00:03:00:01:06:7f:20:00:04:6c', u'mac_address': u'06:7f:20:00:04:6c', u'ipv4_adress': u'10.3.28.201', u'host_name': u'server-1200', u'default_entry': False, u'type': u'dhcpentry', u'dns_adresses': u'42.0.28.11'}, u'id': u'dhcpentry'}
8722016-12-21 06:26:52,093 merge.py load:60 Loading data bag type ips
8732016-12-21 06:26:52,093 merge.py load:60 Loading data bag type cmdline
8742016-12-21 06:26:52,094 configure.py main:924 Configuring ip addresses
8752016-12-21 06:26:52,094 CsHelper.py execute:184 Executing: ip addr show dev eth1
8762016-12-21 06:26:52,097 CsHelper.py execute:184 Executing: ip addr show dev eth0
8772016-12-21 06:26:52,100 CsHelper.py execute:184 Executing: ip addr show dev eth1
8782016-12-21 06:26:52,102 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'169.254.1.124', u'one_to_one_nat': False, u'nic_dev_id': u'1', u'network': u'169.254.0.0/16', u'netmask': u'255.255.0.0', u'source_nat': False, u'broadcast': u'169.254.255.255', u'add': True, u'nw_type': u'control', u'device': u'eth1', u'cidr': u'169.254.1.124/16', u'gateway': u'None', u'size': u'16'}
8792016-12-21 06:26:52,103 CsAddress.py process:116 Address 169.254.1.124/16 on device eth1 not configured
8802016-12-21 06:26:52,103 CsAddress.py configure:274 Configuring address 169.254.1.124/16 on device eth1
8812016-12-21 06:26:52,103 CsHelper.py execute:184 Executing: ip addr add dev eth1 169.254.1.124/16 brd +
8822016-12-21 06:26:52,106 CsRoute.py defaultroute_exists:89 Checking if default ipv4 route is present
8832016-12-21 06:26:52,106 CsHelper.py execute:184 Executing: ip -4 route list 0/0
8842016-12-21 06:26:52,108 CsRoute.py defaultroute_exists:93 Default route found: default via 10.3.28.1 dev eth0
8852016-12-21 06:26:52,109 CsHelper.py execute:184 Executing: ip addr show dev eth0
8862016-12-21 06:26:52,111 CsAddress.py process:107 Address found in DataBag ==> {u'public_ip': u'10.3.28.10', u'one_to_one_nat': False, u'nic_dev_id': u'0', u'network': u'10.3.28.0/24', u'netmask': u'255.255.255.0', u'source_nat': False, u'broadcast': u'10.3.28.255', u'add': True, u'nw_type': u'guest', u'device': u'eth0', u'cidr': u'10.3.28.10/24', u'gateway': u'None', u'size': u'24'}
8872016-12-21 06:26:52,111 CsAddress.py process:116 Address 10.3.28.10/24 on device eth0 not configured
8882016-12-21 06:26:52,112 CsAddress.py configure:274 Configuring address 10.3.28.10/24 on device eth0
8892016-12-21 06:26:52,112 CsHelper.py execute:184 Executing: ip addr add dev eth0 10.3.28.10/24 brd +
8902016-12-21 06:26:52,114 CsRoute.py add_table:38 Adding route table: 0 Table_eth0 to /etc/iproute2/rt_tables if not present
8912016-12-21 06:26:52,115 CsHelper.py execute:184 Executing: ip rule show
8922016-12-21 06:26:52,118 CsHelper.py execute:184 Executing: ip rule add fwmark 0 table Table_eth0
8932016-12-21 06:26:52,121 CsRule.py addMark:37 Added fwmark rule for Table_eth0
8942016-12-21 06:26:52,121 CsHelper.py execute:184 Executing: ip link show eth0 | grep 'state DOWN'
8952016-12-21 06:26:52,124 CsHelper.py execute:184 Executing: arping -c 1 -I eth0 -A -U -s 10.3.28.10 None
896
897Broadcast message from root@r-690-VM (Wed Dec 21 06:27:02 2016):
898
899The system is going down for system halt NOW!
900
901Broadcast message from root@r-690-VM (Wed Dec 21 06:27:03 2016):
902
903Power button pressed
904The system is going down for system halt NOW!
905/opt/cloud/bin/vr_cfg.sh: line 60: 4085 Killed /opt/cloud/bin/update_config.py vm_dhcp_entry.json
906Wed Dec 21 06:27:03 UTC 2016 : VR config: executing failed: /opt/cloud/bin/update_config.py vm_dhcp_entry.json
907debug1: channel 0: free: client-session, nchannels 1
908Connection to 169.254.1.124 closed by remote host.
909Connection to 169.254.1.124 closed.
910Transferred: sent 4384, received 121776 bytes, in 182.1 seconds
911Bytes per second: sent 24.1, received 668.8
912debug1: Exit status -1