Re: [Users] engine-setup fails in database creation

Hi Kumar, The log is in the first fpaste link. But I can paste it here as well.. 2012-03-10 14:12:43::DEBUG::common_utils::196::root:: cmd = /sbin/ip addr 2012-03-10 14:12:43::DEBUG::common_utils::201::root:: output = 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 16436 qdisc noqueue state UNKNOWN link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo inet6 ::1/128 scope host valid_lft forever preferred_lft forever 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000 link/ether 00:1b:78:37:36:f6 brd ff:ff:ff:ff:ff:ff inet 10.121.1.20/24 brd 10.121.1.255 scope global eth0 inet6 fe80::21b:78ff:fe37:36f6/64 scope link valid_lft forever preferred_lft forever 3: eth1: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN qlen 1000 link/ether 00:1b:78:37:36:f4 brd ff:ff:ff:ff:ff:ff 2012-03-10 14:12:43::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:43::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:43::DEBUG::common_utils::318::root:: Found IP Address: 10.121.1.20 2012-03-10 14:12:43::DEBUG::engine-setup::2298::root:: checking total memory 2012-03-10 14:12:43::DEBUG::common_utils::196::root:: cmd = /usr/bin/free -g 2012-03-10 14:12:43::DEBUG::common_utils::201::root:: output = total used free shared buffers cached Mem: 7 1 6 0 0 0 -/+ buffers/cache: 0 7 Swap: 17 0 17 2012-03-10 14:12:43::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:43::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:43::DEBUG::engine-setup::2308::root:: Found a match, amount of memory: 7 2012-03-10 14:12:43::DEBUG::engine-setup::2342::root:: initiating command line option parser 2012-03-10 14:12:43::DEBUG::engine-setup::2236::root:: Entered main(configFile='None') 2012-03-10 14:12:43::DEBUG::engine-setup::1608::root:: checking the status of jboss 2012-03-10 14:12:43::DEBUG::common_utils::196::root:: cmd = /sbin/service jboss-as status 2012-03-10 14:12:43::DEBUG::common_utils::201::root:: output = jboss-as is not running 2012-03-10 14:12:43::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:43::DEBUG::common_utils::203::root:: retcode = 3 2012-03-10 14:12:43::DEBUG::engine-setup::1355::root:: going over group {'PRE_CONDITION_MATCH': True, 'DESCRIPTION': 'General configuration parameters', 'POST_CONDITION': False, 'GROUP_NAME': 'ALL_PARAMS', 'PRE_CONDITION': False, 'POST_CONDITION_MATCH': True} 2012-03-10 14:12:44::DEBUG::engine_validators::48::root:: Validating 8080 as a valid TCP Port 2012-03-10 14:12:44::DEBUG::common_utils::175::root:: Checking if TCP port 8080 is open by any process 2012-03-10 14:12:44::DEBUG::common_utils::196::root:: cmd = /usr/sbin/lsof -i -n -P 2012-03-10 14:12:44::DEBUG::common_utils::201::root:: output = COMMAND PID USER FD TYPE DEVICE SIZE/OFF NODE NAME rpcbind 1276 rpc 6u IPv4 11810 0t0 UDP *:111 rpcbind 1276 rpc 7u IPv4 11814 0t0 UDP *:603 rpcbind 1276 rpc 8u IPv4 11815 0t0 TCP *:111 (LISTEN) rpcbind 1276 rpc 9u IPv6 11817 0t0 UDP *:111 rpcbind 1276 rpc 10u IPv6 11819 0t0 UDP *:603 rpcbind 1276 rpc 11u IPv6 11820 0t0 TCP *:111 (LISTEN) rpc.statd 1294 rpcuser 5u IPv4 12006 0t0 UDP *:622 rpc.statd 1294 rpcuser 8u IPv4 12010 0t0 UDP *:33095 rpc.statd 1294 rpcuser 9u IPv4 12014 0t0 TCP *:58964 (LISTEN) rpc.statd 1294 rpcuser 10u IPv6 12018 0t0 UDP *:46082 rpc.statd 1294 rpcuser 11u IPv6 12022 0t0 TCP *:39537 (LISTEN) snmpd 1404 root 7u IPv4 12453 0t0 UDP *:161 snmpd 1404 root 8u IPv4 12452 0t0 UDP *:33175 snmpd 1404 root 9u IPv4 12455 0t0 TCP 127.0.0.1:199 (LISTEN) snmpd 1404 root 10u IPv4 12456 0t0 UDP 127.0.0.1:25375 sshd 1417 root 3u IPv4 12493 0t0 TCP *:22 (LISTEN) sshd 1417 root 4u IPv6 12496 0t0 TCP *:22 (LISTEN) hpsmhd 1489 root 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1489 root 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1522 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1522 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1523 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1523 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1524 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1524 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1525 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1525 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1526 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1526 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) cmapeerd 1882 root 5u IPv4 13897 0t0 UDP 127.0.0.1:25376 cmanicd 2080 root 4u IPv4 14759 0t0 UDP 127.0.0.1:25393 postmaste 16561 postgres 3u IPv6 3332337 0t0 TCP [::1]:5432 (LISTEN) postmaste 16561 postgres 4u IPv4 3332338 0t0 TCP 127.0.0.1:5432 (LISTEN) postmaste 16561 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16565 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16566 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16567 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16568 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 sshd 16823 root 3r IPv4 3390860 0t0 TCP 10.121.1.20:22->10.102.3.209:37284 (ESTABLISHED) sshd 31757 root 3u IPv4 3300483 0t0 TCP 10.121.1.20:22->10.102.3.209:37283 (ESTABLISHED) 2012-03-10 14:12:44::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:44::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:44::DEBUG::engine_validators::48::root:: Validating 8443 as a valid TCP Port 2012-03-10 14:12:44::DEBUG::common_utils::175::root:: Checking if TCP port 8443 is open by any process 2012-03-10 14:12:44::DEBUG::common_utils::196::root:: cmd = /usr/sbin/lsof -i -n -P 2012-03-10 14:12:44::DEBUG::common_utils::201::root:: output = COMMAND PID USER FD TYPE DEVICE SIZE/OFF NODE NAME rpcbind 1276 rpc 6u IPv4 11810 0t0 UDP *:111 rpcbind 1276 rpc 7u IPv4 11814 0t0 UDP *:603 rpcbind 1276 rpc 8u IPv4 11815 0t0 TCP *:111 (LISTEN) rpcbind 1276 rpc 9u IPv6 11817 0t0 UDP *:111 rpcbind 1276 rpc 10u IPv6 11819 0t0 UDP *:603 rpcbind 1276 rpc 11u IPv6 11820 0t0 TCP *:111 (LISTEN) rpc.statd 1294 rpcuser 5u IPv4 12006 0t0 UDP *:622 rpc.statd 1294 rpcuser 8u IPv4 12010 0t0 UDP *:33095 rpc.statd 1294 rpcuser 9u IPv4 12014 0t0 TCP *:58964 (LISTEN) rpc.statd 1294 rpcuser 10u IPv6 12018 0t0 UDP *:46082 rpc.statd 1294 rpcuser 11u IPv6 12022 0t0 TCP *:39537 (LISTEN) snmpd 1404 root 7u IPv4 12453 0t0 UDP *:161 snmpd 1404 root 8u IPv4 12452 0t0 UDP *:33175 snmpd 1404 root 9u IPv4 12455 0t0 TCP 127.0.0.1:199 (LISTEN) snmpd 1404 root 10u IPv4 12456 0t0 UDP 127.0.0.1:25375 sshd 1417 root 3u IPv4 12493 0t0 TCP *:22 (LISTEN) sshd 1417 root 4u IPv6 12496 0t0 TCP *:22 (LISTEN) hpsmhd 1489 root 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1489 root 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1522 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1522 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1523 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1523 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1524 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1524 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1525 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1525 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) hpsmhd 1526 hpsmh 4u IPv6 12740 0t0 TCP *:2301 (LISTEN) hpsmhd 1526 hpsmh 6u IPv6 12744 0t0 TCP *:2381 (LISTEN) cmapeerd 1882 root 5u IPv4 13897 0t0 UDP 127.0.0.1:25376 cmanicd 2080 root 4u IPv4 14759 0t0 UDP 127.0.0.1:25393 postmaste 16561 postgres 3u IPv6 3332337 0t0 TCP [::1]:5432 (LISTEN) postmaste 16561 postgres 4u IPv4 3332338 0t0 TCP 127.0.0.1:5432 (LISTEN) postmaste 16561 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16565 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16566 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16567 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 postmaste 16568 postgres 7u IPv6 3332349 0t0 UDP [::1]:41122->[::1]:41122 sshd 16823 root 3r IPv4 3390860 0t0 TCP 10.121.1.20:22->10.102.3.209:37284 (ESTABLISHED) sshd 31757 root 3u IPv4 3300483 0t0 TCP 10.121.1.20:22->10.102.3.209:37283 (ESTABLISHED) 2012-03-10 14:12:44::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:44::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:44::DEBUG::engine-setup::433::root:: setting default value (00:1A:4A:79:01:00-00:1A:4A:79:01:FF) for key (MAC_RANGE) 2012-03-10 14:12:49::INFO::engine_validators::122::root:: Validating virtual.unixwarez.org as a FQDN 2012-03-10 14:12:49::INFO::engine_validators::96::root:: validating virtual.unixwarez.org as a valid domain string 2012-03-10 14:12:49::DEBUG::common_utils::196::root:: cmd = /sbin/ip addr 2012-03-10 14:12:49::DEBUG::common_utils::201::root:: output = 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 16436 qdisc noqueue state UNKNOWN link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo inet6 ::1/128 scope host valid_lft forever preferred_lft forever 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000 link/ether 00:1b:78:37:36:f6 brd ff:ff:ff:ff:ff:ff inet 10.121.1.20/24 brd 10.121.1.255 scope global eth0 inet6 fe80::21b:78ff:fe37:36f6/64 scope link valid_lft forever preferred_lft forever 3: eth1: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN qlen 1000 link/ether 00:1b:78:37:36:f4 brd ff:ff:ff:ff:ff:ff 2012-03-10 14:12:49::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:49::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:49::DEBUG::common_utils::318::root:: Found IP Address: 10.121.1.20 2012-03-10 14:12:49::DEBUG::common_utils::196::root:: cmd = /usr/bin/nslookup virtual.unixwarez.org 2012-03-10 14:12:49::DEBUG::common_utils::201::root:: output = Server: 84.17.199.34 Address: 84.17.199.34#53 Non-authoritative answer: Name: virtual.unixwarez.org Address: 10.121.1.20 2012-03-10 14:12:49::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:49::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:49::DEBUG::engine_validators::259::root:: virtual.unixwarez.org resolved into 10.121.1.20 2012-03-10 14:12:49::DEBUG::common_utils::196::root:: cmd = /usr/bin/nslookup 10.121.1.20 2012-03-10 14:12:49::DEBUG::common_utils::201::root:: output = Server: 84.17.199.34 Address: 84.17.199.34#53 20.1.121.10.in-addr.arpa name = 500001-010-ap01.rtr.tconet.net. 2012-03-10 14:12:49::DEBUG::common_utils::202::root:: stderr = 2012-03-10 14:12:49::DEBUG::common_utils::203::root:: retcode = 0 2012-03-10 14:12:49::DEBUG::engine_validators::259::root:: 10.121.1.20 resolved into 500001-010-ap01.rtr.tconet.net 2012-03-10 14:12:49::WARNING::engine_validators::164::root:: 10.121.1.20 did not reverse-resolve into virtual.unixwarez.org 2012-03-10 14:12:49::ERROR::engine_validators::166::root:: The following addresses: 10.121.1.20 did not reverse resolve into virtual.unixwarez.org 2012-03-10 14:12:49::DEBUG::engine-setup::519::root:: asking user: User input failed validation, do you still wish to use it? (yes|no): 2012-03-10 14:12:50::DEBUG::engine-setup::523::root:: user answered: yes 2012-03-10 14:12:57::DEBUG::engine_validators::71::root:: Validating password 2012-03-10 14:13:21::DEBUG::engine_validators::71::root:: Validating password 2012-03-10 14:13:27::INFO::engine_validators::203::root:: validating organization name 2012-03-10 14:13:28::INFO::engine_validators::84::root:: Validating NFS as part of ['NFS', 'FC', 'ISCSI'] 2012-03-10 14:13:28::DEBUG::engine-setup::1355::root:: going over group {'PRE_CONDITION_MATCH': 'yes', 'DESCRIPTION': 'ISO Domain paramters', 'POST_CONDITION': False, 'GROUP_NAME': 'NFS', 'PRE_CONDITION': 'CONFIG_NFS', 'POST_CONDITION_MATCH': True} 2012-03-10 14:13:30::INFO::engine_validators::84::root:: Validating yes as part of ['yes', 'no'] 2012-03-10 14:13:34::INFO::engine_validators::17::root:: validating /virtual/iso as a valid mount point 2012-03-10 14:13:34::DEBUG::engine_validators::288::root:: attempting to write temp file to /virtual 2012-03-10 14:13:34::DEBUG::common_utils::349::root:: Checking available space on /virtual 2012-03-10 14:13:34::DEBUG::common_utils::354::root:: Available space on /virtual is 522943 2012-03-10 14:13:40::INFO::engine_validators::186::root:: validating iso domain name 2012-03-10 14:13:40::DEBUG::engine-setup::1355::root:: going over group {'PRE_CONDITION_MATCH': True, 'DESCRIPTION': 'Firewall related paramters', 'POST_CONDITION': False, 'GROUP_NAME': 'IPTABLES', 'PRE_CONDITION': False, 'POST_CONDITION_MATCH': True} 2012-03-10 14:13:42::INFO::engine_validators::84::root:: Validating yes as part of ['yes', 'no'] 2012-03-10 14:13:42::INFO::engine-setup::1436::root:: *** User input summary *** 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: http-port: 8080 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: https-port: 8443 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: host-fqdn: virtual.unixwarez.org 2012-03-10 14:13:42::INFO::engine-setup::1447::root:: auth-pass: ******** 2012-03-10 14:13:42::INFO::engine-setup::1447::root:: db-pass: ******** 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: org-name: telecomputing 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: default-dc-type: NFS 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: nfs-mp: /virtual/iso 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: iso-domain-name: iso_store 2012-03-10 14:13:42::INFO::engine-setup::1451::root:: override-iptables: yes 2012-03-10 14:13:42::INFO::engine-setup::1453::root:: *** User input summary *** 2012-03-10 14:13:42::DEBUG::engine-setup::519::root:: asking user: Proceed with the configuration listed above? (yes|no): 2012-03-10 14:13:44::DEBUG::engine-setup::523::root:: user answered: yes 2012-03-10 14:13:44::DEBUG::engine-setup::1480::root:: user chose to accept user parameters 2012-03-10 14:13:44::DEBUG::engine-setup::2262::root:: {'ORG_NAME': 'telecomputing', 'HOST_FQDN': 'virtual.unixwarez.org', 'AUTH_PASS_CONFIRMED': '********', 'HTTP_PORT': '8080', 'HTTPS_PORT': '8443', 'DB_PASS_CONFIRMED': '********', 'CONFIG_NFS': 'yes', 'AUTH_PASS': '********', 'DB_PASS': '********', 'ISO_DOMAIN_NAME': 'iso_store', 'MAC_RANGE': '00:1A:4A:79:01:00-00:1A:4A:79:01:FF', 'NFS_MP': '/virtual/iso', 'OVERRIDE_IPTABLES': 'yes', 'DC_TYPE': 'NFS'} 2012-03-10 14:13:44::DEBUG::engine-setup::2265::root:: Entered Configuration stage 2012-03-10 14:13:44::DEBUG::engine-setup::1160::root:: running _createJbossProfile 2012-03-10 14:13:44::DEBUG::engine-setup::919::root:: creating jboss profile 2012-03-10 14:13:44::DEBUG::engine-setup::934::root:: Successfully created jboss profile default 2012-03-10 14:13:44::DEBUG::engine-setup::938::root:: touching .dodeploy file for /usr/share/jboss-as/standalone/deployments/engine.ear 2012-03-10 14:13:44::DEBUG::engine-setup::934::root:: Successfully created jboss profile default 2012-03-10 14:13:44::DEBUG::engine-setup::938::root:: touching .dodeploy file for /usr/share/jboss-as/standalone/deployments/ROOT.war 2012-03-10 14:13:44::DEBUG::engine-setup::1160::root:: running setMaxSharedMemory 2012-03-10 14:13:44::DEBUG::engine-setup::1534::root:: loading /etc/sysctl.conf 2012-03-10 14:13:44::DEBUG::engine-setup::1541::root:: current shared memory max in kernel is 68719476736, there is no need to update the kernel parameters 2012-03-10 14:13:44::DEBUG::engine-setup::1163::root:: running _createCA 2012-03-10 14:13:44::DEBUG::engine-setup::846::root:: updating /etc/pki/ovirt-engine/cacert.template 2012-03-10 14:13:44::DEBUG::engine-setup::846::root:: updating /etc/pki/ovirt-engine/cert.template 2012-03-10 14:13:44::DEBUG::engine-setup::764::root:: current timezone offset is -1 2012-03-10 14:13:44::DEBUG::engine-setup::778::root:: Date string is 120309141344-0100 2012-03-10 14:13:44::DEBUG::common_utils::219::root:: Executing command --> '/etc/pki/ovirt-engine/installCA.sh virtual.unixwarez.org US telecomputing engine ******** 120309141344-0100 /etc/pki/ovirt-engine virtual.unixwarez.org.69504' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = } Creating CA... } Creating KeyStore... }} Converting formats... > Importing CA certificate... } Creating client certificate for oVirt... }} Creating certificate request... }} Signing certificate request... X509v3 Subject Key Identifier: }} Converting formats... } Importing oVirt certificate... } Exporting oVirt key as SSH... 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = Generating RSA private key, 1024 bit long modulus ...........++++++ ..................................++++++ e is 65537 (0x10001) Using configuration from openssl.conf Check that the request matches the signature Signature ok The Subject's Distinguished Name is as follows countryName :PRINTABLE:'US' organizationName :PRINTABLE:'telecomputing' commonName :PRINTABLE:'CA-virtual.unixwarez.org.69504' Certificate is to be certified until Mar 8 13:13:44 2022 GMT (3650 days) Write out database with 1 new entries Data Base Updated Certificate was added to keystore Certificate was added to keystore Using configuration from openssl.conf Check that the request matches the signature Signature ok The Subject's Distinguished Name is as follows countryName :PRINTABLE:'US' organizationName :PRINTABLE:'telecomputing' commonName :PRINTABLE:'virtual.unixwarez.org' Certificate is to be certified until Feb 12 13:13:45 2017 GMT (1800 days) Write out database with 1 new entries Data Base Updated Certificate reply was installed in keystore Certificate stored in file <keys/engine.pub.tmp> 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 0 2012-03-10 14:13:46::DEBUG::common_utils::219::root:: Executing command --> '/etc/pki/ovirt-engine/generate-ssh-keys -s /etc/pki/ovirt-engine/.keystore -p ******** -a engine -k /etc/pki/ovirt-engine/keys/engine_id_rsa' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = Finished successfuly 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 0 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /etc/pki/ovirt-engine/keys/engine.ssh.key.txt to target destination /usr/share/jboss-as/standalone/deployments/ROOT.war 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/engine.ssh.key.txt uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/engine.ssh.key.txt mode to -1 2012-03-10 14:13:46::DEBUG::common_utils::219::root:: Executing command --> '/usr/bin/openssl x509 -in /etc/pki/ovirt-engine/ca.pem -fingerprint -noout' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = SHA1 Fingerprint=23:BC:7F:6F:E2:96:4B:E6:01:40:D3:ED:E0:38:5D:13:16:63:05:4E 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 0 2012-03-10 14:13:46::DEBUG::common_utils::219::root:: Executing command --> '/usr/bin/ssh-keygen -lf /etc/pki/ovirt-engine/keys/engine.ssh.key.txt' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = 1024 c2:ab:2b:69:78:2e:9a:8c:47:5a:4a:5a:68:1f:92:fe /etc/pki/ovirt-engine/keys/engine.ssh.key.txt (RSA) 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 0 2012-03-10 14:13:46::DEBUG::engine-setup::839::root:: changing ownership of /etc/pki/ovirt-engine/ca.pem to 498/502 (uid/gid) 2012-03-10 14:13:46::DEBUG::engine-setup::841::root:: changing file permissions for /etc/pki/ovirt-engine/ca.pem to 0750 2012-03-10 14:13:46::DEBUG::engine-setup::839::root:: changing ownership of /etc/pki/ovirt-engine/.keystore to 498/502 (uid/gid) 2012-03-10 14:13:46::DEBUG::engine-setup::841::root:: changing file permissions for /etc/pki/ovirt-engine/.keystore to 0750 2012-03-10 14:13:46::DEBUG::engine-setup::839::root:: changing ownership of /etc/pki/ovirt-engine/private to 498/502 (uid/gid) 2012-03-10 14:13:46::DEBUG::engine-setup::841::root:: changing file permissions for /etc/pki/ovirt-engine/private to 0750 2012-03-10 14:13:46::DEBUG::engine-setup::839::root:: changing ownership of /etc/pki/ovirt-engine/private/ca.pem to 498/502 (uid/gid) 2012-03-10 14:13:46::DEBUG::engine-setup::841::root:: changing file permissions for /etc/pki/ovirt-engine/private/ca.pem to 0750 2012-03-10 14:13:46::DEBUG::engine-setup::839::root:: changing ownership of /etc/pki/ovirt-engine/.truststore to 498/502 (uid/gid) 2012-03-10 14:13:46::DEBUG::engine-setup::841::root:: changing file permissions for /etc/pki/ovirt-engine/.truststore to 0750 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /etc/pki/ovirt-engine/keys/engine.ssh.key.txt to target destination /usr/share/jboss-as/standalone/deployments/ROOT.war 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/engine.ssh.key.txt uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/engine.ssh.key.txt mode to -1 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running configJbossXml 2012-03-10 14:13:46::DEBUG::engine-setup::1898::root:: Backing up /usr/share/jboss-as/standalone/configuration/standalone.xml into /usr/share/jboss-as/standalone/configuration/standalone.xml.BACKUP.5735372 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /usr/share/jboss-as-7.1.0.Beta1b/standalone/configuration/standalone.xml to target destination /usr/share/jboss-as/standalone/configuration/standalone.xml.BACKUP.5735372 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.BACKUP.5735372 uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.BACKUP.5735372 mode to -1 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /usr/share/jboss-as-7.1.0.Beta1b/standalone/configuration/standalone.xml to target destination /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.1034875 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.1034875 uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.1034875 mode to -1 2012-03-10 14:13:46::DEBUG::engine-setup::1903::root:: loading xml file handler 2012-03-10 14:13:46::DEBUG::engine-setup::1910::root:: Configuring Jboss 2012-03-10 14:13:46::DEBUG::engine-setup::1932::root:: Configuring logging for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::1934::root:: Registering logging namespace 2012-03-10 14:13:46::DEBUG::engine-setup::1937::root:: setting attributes 2012-03-10 14:13:46::DEBUG::engine-setup::1941::root:: Adding level node with attribute: name, value: INFO 2012-03-10 14:13:46::DEBUG::engine-setup::1951::root:: Adding file handler for ENGINE_LOG 2012-03-10 14:13:46::DEBUG::engine-setup::1966::root:: Adding Loggers for ovirt-engine 2012-03-10 14:13:46::DEBUG::engine-setup::1995::root:: Logging is enabled and configured in jboss's configuration 2012-03-10 14:13:46::DEBUG::engine-setup::2001::root:: Configuring logging for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::2003::root:: Registering datasource namespaces 2012-03-10 14:13:46::DEBUG::engine-setup::2007::root:: looking for ENGINEDatasource datasource 2012-03-10 14:13:46::DEBUG::engine-setup::2049::root:: Adding ENGINE datasource 2012-03-10 14:13:46::DEBUG::engine-setup::2052::root:: Adding drivers to datasource 2012-03-10 14:13:46::DEBUG::engine-setup::2065::root:: configuring deployment-scanner 2012-03-10 14:13:46::DEBUG::engine-setup::2071::root:: Datasource has been added into jboss's configuration 2012-03-10 14:13:46::DEBUG::engine-setup::2116::root:: Configuring Jboss's network 2012-03-10 14:13:46::DEBUG::engine-setup::2118::root:: Removing all interfaces from the public interface 2012-03-10 14:13:46::DEBUG::engine-setup::2121::root:: Adding access to public interface 2012-03-10 14:13:46::DEBUG::engine-setup::2124::root:: Setting ports 2012-03-10 14:13:46::DEBUG::engine-setup::2131::root:: Network has been configured for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::2137::root:: Configuring SSL for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::2139::root:: Registering web namespaces 2012-03-10 14:13:46::DEBUG::engine-setup::2149::root:: Disabling default welcome-content 2012-03-10 14:13:46::DEBUG::engine-setup::2153::root:: SSL has been configured for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::1915::root:: Jboss has been configured 2012-03-10 14:13:46::DEBUG::engine-setup::1921::root:: Jboss configuration has been saved 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running deployJbossModules 2012-03-10 14:13:46::DEBUG::engine-setup::1819::root:: Adding modules to jboss's modules 2012-03-10 14:13:46::DEBUG::common_utils::248::root:: removing link /usr/share/jboss-as/modules/org/postgresql 2012-03-10 14:13:46::DEBUG::common_utils::258::root:: Linking /usr/share/ovirt-engine/resources/jboss/modules/org/postgresql to /usr/share/jboss-as/modules/org/postgresql 2012-03-10 14:13:46::DEBUG::engine-setup::1829::root:: Backing up /usr/share/jboss-as/modules/sun/jdk/main/module.xml into /usr/share/jboss-as/modules/sun/jdk/main/module.xml.1145030 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /usr/share/jboss-as-7.1.0.Beta1b/modules/sun/jdk/main/module.xml to target destination /usr/share/jboss-as/modules/sun/jdk/main/module.xml.1145030 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/modules/sun/jdk/main/module.xml.1145030 uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/modules/sun/jdk/main/module.xml.1145030 mode to -1 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /usr/share/jboss-as-7.1.0.Beta1b/modules/sun/jdk/main/module.xml to target destination /usr/share/jboss-as/modules/sun/jdk/main/module.xml.EDIT.2998580 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/modules/sun/jdk/main/module.xml.EDIT.2998580 uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/modules/sun/jdk/main/module.xml.EDIT.2998580 mode to -1 2012-03-10 14:13:46::DEBUG::engine-setup::1833::root:: loading xml file handler 2012-03-10 14:13:46::DEBUG::engine-setup::1837::root:: registering name space 2012-03-10 14:13:46::DEBUG::engine-setup::1843::root:: adding <path name="sun/security"/> as node 2012-03-10 14:13:46::DEBUG::engine-setup::1843::root:: adding <path name="sun/security/krb5"/> as node 2012-03-10 14:13:46::DEBUG::engine-setup::1843::root:: adding <path name="com/sun/jndi/url"/> as node 2012-03-10 14:13:46::DEBUG::engine-setup::1843::root:: adding <path name="com/sun/jndi/url/dns"/> as node 2012-03-10 14:13:46::DEBUG::engine-setup::1849::root:: JDK module configuration has been saved 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running _editRootWar 2012-03-10 14:13:46::DEBUG::engine-setup::608::root:: removing file /usr/share/jboss-as/standalone/deployments/ROOT.war/web-conf.js 2012-03-10 14:13:46::DEBUG::engine-setup::611::root:: Linking /etc/ovirt-engine/web-conf.js to /usr/share/jboss-as/standalone/deployments/ROOT.war/web-conf.js 2012-03-10 14:13:46::DEBUG::engine-setup::715::root:: update /etc/ovirt-engine/web-conf.js with http & ssl urls 2012-03-10 14:13:46::DEBUG::engine-setup::676::root:: copying /etc/pki/ovirt-engine/ca.pem to /usr/share/jboss-as/standalone/deployments/ROOT.war/ca.crt 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /etc/pki/ovirt-engine/ca.pem to target destination /usr/share/jboss-as/standalone/deployments/ROOT.war/ca.crt 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/ca.crt uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/deployments/ROOT.war/ca.crt mode to -1 2012-03-10 14:13:46::DEBUG::engine-setup::686::root:: editing jboss conf file /usr/share/jboss-as/standalone/deployments/ROOT.war/WEB-INF/web.xml 2012-03-10 14:13:46::DEBUG::engine-setup::1780::root:: checking if rhevm db is already installed.. 2012-03-10 14:13:46::DEBUG::common_utils::235::root:: running sql query engine on db: 'select 1'. 2012-03-10 14:13:46::DEBUG::common_utils::196::root:: cmd = /usr/bin/psql -U postgres -d engine -c "select 1" 2012-03-10 14:13:46::DEBUG::common_utils::201::root:: output = 2012-03-10 14:13:46::DEBUG::common_utils::202::root:: stderr = psql: FATAL: database "engine" does not exist 2012-03-10 14:13:46::DEBUG::common_utils::203::root:: retcode = 2 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running _updatePgPassFile 2012-03-10 14:13:46::DEBUG::engine-setup::1094::root:: found existing pgpass file, backing current to /root/.pgpass.2012_03_10_14_13_46 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running _encryptDBPass 2012-03-10 14:13:46::DEBUG::common_utils::219::root:: Executing command --> '/etc/pki/ovirt-engine/encryptpasswd.sh ********' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = /usr/share/jboss-as ~ Encoded password: -5030367e89005f23ced737a80b1b9ee4 ~ 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 0 2012-03-10 14:13:46::DEBUG::common_utils::376::root:: found new parsed string: -5030367e89005f23ced737a80b1b9ee4 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running configEncryptedPass 2012-03-10 14:13:46::DEBUG::engine-setup::1865::root:: Backing up /usr/share/jboss-as/standalone/configuration/standalone.xml into None 2012-03-10 14:13:46::DEBUG::common_utils::406::root:: successfully copied file /usr/share/jboss-as-7.1.0.Beta1b/standalone/configuration/standalone.xml to target destination /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.7770771 2012-03-10 14:13:46::DEBUG::common_utils::414::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.7770771 uid/gid ownership 2012-03-10 14:13:46::DEBUG::common_utils::417::root:: setting file /usr/share/jboss-as/standalone/configuration/standalone.xml.EDIT.7770771 mode to -1 2012-03-10 14:13:46::DEBUG::engine-setup::1869::root:: loading xml file handler 2012-03-10 14:13:46::DEBUG::engine-setup::2077::root:: Configuring security for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::2079::root:: Registering security namespaces 2012-03-10 14:13:46::DEBUG::engine-setup::2109::root:: Security has been configured for jboss 2012-03-10 14:13:46::DEBUG::engine-setup::1881::root:: Jboss configuration has been saved 2012-03-10 14:13:46::DEBUG::engine-setup::1160::root:: running _createDB 2012-03-10 14:13:46::DEBUG::engine-setup::950::root:: installing postgres db 2012-03-10 14:13:46::DEBUG::engine-setup::953::root:: engine db creation is logged at /var/log/ovirt-engine//engine-db-install-2012_03_10_14_13_46.log 2012-03-10 14:13:46::DEBUG::common_utils::219::root:: Executing command --> '/usr/share/ovirt-engine/dbscripts/engine-db-install.sh engine-db-install-2012_03_10_14_13_46.log ********' 2012-03-10 14:13:46::DEBUG::common_utils::226::root:: output = [engine-db-install] postgresql service cannot be executed from /sbin/service postgresql 2012-03-10 14:13:46::DEBUG::common_utils::227::root:: stderr = 2012-03-10 14:13:46::DEBUG::common_utils::228::root:: retcode = 1 2012-03-10 14:13:46::DEBUG::engine-setup::1759::root:: *** The following params were used as user input: 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: override-iptables: yes 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: http-port: 8080 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: https-port: 8443 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: mac-range: 00:1A:4A:79:01:00-00:1A:4A:79:01:FF 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: host-fqdn: virtual.unixwarez.org 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: auth-pass: ******** 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: db-pass: ******** 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: org-name: telecomputing 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: default-dc-type: NFS 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: config-nfs: yes 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: nfs-mp: /virtual/iso 2012-03-10 14:13:46::DEBUG::engine-setup::1763::root:: iso-domain-name: iso_store 2012-03-10 14:13:46::ERROR::engine-setup::2453::root:: Traceback (most recent call last): File "/usr/bin/engine-setup", line 2447, in <module> main(confFile) File "/usr/bin/engine-setup", line 2269, in main runMainFunctions(conf) File "/usr/bin/engine-setup", line 2187, in runMainFunctions runFunction([_createDB, _updateVDCOptions], output_messages.INFO_CREATE_DB) File "/usr/bin/engine-setup", line 1170, in runFunction raise Exception(instance) Exception: Database creation failed Thanks, Elias kumar shantanu skrev 2012-03-10 14:55: > Looks like problem with database encoding type here. can you post > output of /var/log/ovirt-engine/engine-s > etup_2012_03_10_14_12_43.log here. > > Thanks > Shantanu > > > On Sat, Mar 10, 2012 at 6:55 PM, Elias Abacioglu <elias.rabi(a)gmail.com > <mailto:elias.rabi@gmail.com>> wrote: > > Hi, I'm unable to complete engine-setup: > > Installing: > Configuring oVirt-engine... [ DONE ] > Creating CA... [ DONE ] > Editing JBoss Configuration... [ DONE ] > Setting Database Security... [ DONE ] > Creating Database... [ ERROR ] > Database creation failed > Please check log file > /var/log/ovirt-engine/engine-setup_2012_03_10_14_12_43.log for > more information > > > > I have both engine-setup log and engine-db-install logs here: > http://fpaste.org/8dcu/ > http://fpaste.org/ZUXL/ > > Any idea whats wrong and how I can fix it? > _______________________________________________ > Users mailing list > Users(a)ovirt.org <mailto:Users@ovirt.org> > http://lists.ovirt.org/mailman/listinfo/users > > > >