New subject: [Users] engine-setup fails in database creation

11 Mar 2012


      Hi Elias,

I was looking for these logs actually


******
engine-db-install-2012_03_10_14_13_46.log
*****

Can you send the output here


On 3/10/12, Elias Abacioglu <elias.rabi@gmail.com> wrote:
...
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@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@ovirt.org <mailto:Users@ovirt.org>
    http://lists.ovirt.org/mailman/listinfo/users
-- 
Kumar Shantanu
Senior System Administrator
Techblue Softwares Pvt Ltd (Gurgaon)

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

kumar shantanu

Yair Zaslavsky

Elias Abacioglu

Yair Zaslavsky

Elias Abacioglu

kumar shantanu

Elias Abacioglu

Yair Zaslavsky

Elias Abacioglu

Yair Zaslavsky

Elias Abacioglu

Ofer Schreiber

Elias Abacioglu

Ofer Schreiber

Elias Abacioglu

Elias Abacioglu

Elias Abacioglu

Yair Zaslavsky

tags

participants (4)