Attachment 850216 Details for Bug 1053225 – Log file

Log file

rhevm-dwh-setup-2014_01_09_07_41_03.log (text/plain), 15.17 KB, created by Narmadha K on 2014-01-14 21:38:26 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Narmadha K

Created: 2014-01-14 21:38:26 UTC

Size: 15.17 KB

patch

obsolete

>2014-01-09 07:41:03::DEBUG::rhevm-dwh-setup::384::root:: starting main()
>2014-01-09 07:41:03::DEBUG::common_utils::445::root:: running sql query on host: localhost, port: 5432, db: engine, user: engine, query: 'copy (
>        select option_value from vdc_options
>        where option_name like 'MinimalETLVersion'
>    ) to stdout with csv header;'.
>2014-01-09 07:41:03::DEBUG::common_utils::874::root:: Executing command --> '/usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname engine --host localhost --port 5432 --username engine -w -c copy (
>        select option_value from vdc_options
>        where option_name like 'MinimalETLVersion'
>    ) to stdout with csv header;' in working directory '/'
>2014-01-09 07:41:03::DEBUG::common_utils::916::root:: output = option_value
>3.3.0
>
>2014-01-09 07:41:03::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:03::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:03::DEBUG::common_utils::152::root:: Value of MinimalETLVersion is 3.3.0
>2014-01-09 07:41:03::DEBUG::common_utils::874::root:: Executing command --> 'rpm -q --queryformat %{VERSION}-%{RELEASE} rhevm-dwh' in working directory '/'
>2014-01-09 07:41:04::DEBUG::common_utils::916::root:: output = 3.3.0-26.el6ev
>2014-01-09 07:41:04::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:04::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:04::DEBUG::common_utils::599::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.0-26.el6ev
>2014-01-09 07:41:04::DEBUG::common_utils::604::root:: found version, 3.3
>2014-01-09 07:41:04::DEBUG::common_utils::606::root:: found minorVersion 0
>2014-01-09 07:41:04::DEBUG::common_utils::608::root:: found release 26
>2014-01-09 07:41:04::DEBUG::common_utils::599::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.0-0
>2014-01-09 07:41:04::DEBUG::common_utils::604::root:: found version, 3.3
>2014-01-09 07:41:04::DEBUG::common_utils::606::root:: found minorVersion 0
>2014-01-09 07:41:04::DEBUG::common_utils::608::root:: found release 0
>2014-01-09 07:41:04::DEBUG::common_utils::473::root:: checking ovirt-engine service
>2014-01-09 07:41:04::DEBUG::common_utils::464::root:: checking the status of ovirt-engine
>2014-01-09 07:41:04::DEBUG::common_utils::259::root:: getting status for ovirt-engine
>2014-01-09 07:41:04::DEBUG::common_utils::276::root:: executing action ovirt-engine on service status
>2014-01-09 07:41:04::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service ovirt-engine status' in working directory '/'
>2014-01-09 07:41:04::DEBUG::common_utils::916::root:: output = ovirt-engine (pid  26185) is running...
>
>2014-01-09 07:41:04::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:04::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:04::DEBUG::common_utils::475::root:: ovirt-engine is up and running
>2014-01-09 07:41:04::DEBUG::common_utils::389::root:: asking user: Would you like to stop the ovirt-engine service (yes|no): 
>2014-01-09 07:41:10::DEBUG::common_utils::393::root:: user answered: yes
>2014-01-09 07:41:10::DEBUG::decorators::18::root:: running stopEngineService
>2014-01-09 07:41:10::DEBUG::common_utils::488::root:: Stopping ovirt-engine
>2014-01-09 07:41:10::DEBUG::common_utils::225::root:: stopping ovirt-engine
>2014-01-09 07:41:10::DEBUG::common_utils::276::root:: executing action ovirt-engine on service stop
>2014-01-09 07:41:10::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service ovirt-engine stop' in working directory '/'
>2014-01-09 07:41:11::DEBUG::common_utils::916::root:: output = Stopping oVirt Engine: [  OK  ]
>
>2014-01-09 07:41:11::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:11::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:11::DEBUG::common_utils::572::root:: Stopping ovirt-engine-dwhd
>2014-01-09 07:41:11::DEBUG::common_utils::563::root:: checking the status of dwhd
>2014-01-09 07:41:11::DEBUG::common_utils::259::root:: getting status for ovirt-engine-dwhd
>2014-01-09 07:41:11::DEBUG::common_utils::276::root:: executing action ovirt-engine-dwhd on service status
>2014-01-09 07:41:11::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service ovirt-engine-dwhd status' in working directory '/'
>2014-01-09 07:41:11::DEBUG::common_utils::916::root:: output = /etc/init.d/ovirt-engine-dwhd is stopped
>
>2014-01-09 07:41:11::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:11::DEBUG::common_utils::918::root:: retcode = 1
>2014-01-09 07:41:11::DEBUG::common_utils::874::root:: Executing command --> 'rpm -q --queryformat %{VERSION}-%{RELEASE} rhevm-dwh' in working directory '/'
>2014-01-09 07:41:11::DEBUG::common_utils::916::root:: output = 3.3.0-26.el6ev
>2014-01-09 07:41:11::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:11::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:11::DEBUG::common_utils::599::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.0-26.el6ev
>2014-01-09 07:41:11::DEBUG::common_utils::604::root:: found version, 3.3
>2014-01-09 07:41:11::DEBUG::common_utils::606::root:: found minorVersion 0
>2014-01-09 07:41:11::DEBUG::common_utils::608::root:: found release 26
>2014-01-09 07:41:11::DEBUG::rhevm-dwh-setup::358::root:: Setting etlVersion
>2014-01-09 07:41:11::DEBUG::rhevm-dwh-setup::359::root:: editing etl connectivity file
>2014-01-09 07:41:11::DEBUG::common_utils::874::root:: Executing command --> '/sbin/ip addr' in working directory '/'
>2014-01-09 07:41:11::DEBUG::common_utils::916::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 e8:39:35:ac:bf:d0 brd ff:ff:ff:ff:ff:ff
>    inet 172.30.60.21/18 brd 172.30.63.255 scope global eth0
>    inet6 fe80::ea39:35ff:feac:bfd0/64 scope link 
>       valid_lft forever preferred_lft forever
>3: eth1: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d4 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd4/64 scope link 
>       valid_lft forever preferred_lft forever
>4: eth2: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d1 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd1/64 scope link 
>       valid_lft forever preferred_lft forever
>5: eth3: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d5 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd5/64 scope link 
>       valid_lft forever preferred_lft forever
>6: eth4: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d2 brd ff:ff:ff:ff:ff:ff
>7: eth5: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d6 brd ff:ff:ff:ff:ff:ff
>8: eth6: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d3 brd ff:ff:ff:ff:ff:ff
>9: eth7: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d7 brd ff:ff:ff:ff:ff:ff
>
>2014-01-09 07:41:11::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:11::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:11::DEBUG::common_utils::719::root:: Found IP Address: 172.30.60.21
>2014-01-09 07:41:11::DEBUG::common_utils::1327::root:: Updating pghba postgres use
>2014-01-09 07:41:11::DEBUG::common_utils::511::root:: checking the status of postgresql
>2014-01-09 07:41:11::DEBUG::common_utils::259::root:: getting status for postgresql
>2014-01-09 07:41:11::DEBUG::common_utils::276::root:: executing action postgresql on service status
>2014-01-09 07:41:11::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service postgresql status' in working directory '/'
>2014-01-09 07:41:11::DEBUG::common_utils::916::root:: output = postmaster (pid  18091) is running...
>
>2014-01-09 07:41:11::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:11::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:11::DEBUG::common_utils::555::root:: stopping postgresql
>2014-01-09 07:41:11::DEBUG::common_utils::225::root:: stopping postgresql
>2014-01-09 07:41:11::DEBUG::common_utils::276::root:: executing action postgresql on service stop
>2014-01-09 07:41:11::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service postgresql stop' in working directory '/'
>2014-01-09 07:41:12::DEBUG::common_utils::916::root:: output = Stopping postgresql service: [  OK  ]
>
>2014-01-09 07:41:12::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:12::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:12::DEBUG::common_utils::511::root:: checking the status of postgresql
>2014-01-09 07:41:12::DEBUG::common_utils::259::root:: getting status for postgresql
>2014-01-09 07:41:12::DEBUG::common_utils::276::root:: executing action postgresql on service status
>2014-01-09 07:41:12::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service postgresql status' in working directory '/'
>2014-01-09 07:41:12::DEBUG::common_utils::916::root:: output = postmaster is stopped
>
>2014-01-09 07:41:12::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:12::DEBUG::common_utils::918::root:: retcode = 3
>2014-01-09 07:41:12::DEBUG::common_utils::550::root:: starting postgresql
>2014-01-09 07:41:12::DEBUG::common_utils::215::root:: starting postgresql
>2014-01-09 07:41:12::DEBUG::common_utils::276::root:: executing action postgresql on service start
>2014-01-09 07:41:12::DEBUG::common_utils::874::root:: Executing command --> '/sbin/service postgresql start' in working directory '/'
>2014-01-09 07:41:14::DEBUG::common_utils::916::root:: output = Starting postgresql service: [  OK  ]
>
>2014-01-09 07:41:14::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:14::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:14::DEBUG::common_utils::874::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tAc "select 1;"' in working directory '/'
>2014-01-09 07:41:15::DEBUG::common_utils::916::root:: output = 1
>
>2014-01-09 07:41:15::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:15::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:15::DEBUG::common_utils::389::root:: asking user: 
>This utility can configure a read only user for DB access. Would you like to do so? (yes|no): 
>2014-01-09 07:41:21::DEBUG::common_utils::393::root:: user answered: no
>2014-01-09 07:41:21::DEBUG::rhevm-dwh-setup::439::root:: Skipping creation of read only DB user.
>2014-01-09 07:41:21::DEBUG::common_utils::630::root:: checking if ovirt_engine_history db already exists
>2014-01-09 07:41:21::DEBUG::common_utils::445::root:: running sql query on host: localhost, port: 5432, db: ovirt_engine_history, user: engine_history, query: 'select 1'.
>2014-01-09 07:41:21::DEBUG::common_utils::874::root:: Executing command --> '/usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname ovirt_engine_history --host localhost --port 5432 --username engine_history -w -c select 1' in working directory '/'
>2014-01-09 07:41:21::DEBUG::common_utils::916::root:: output = 
>2014-01-09 07:41:21::DEBUG::common_utils::917::root:: stderr = psql: FATAL:  password authentication failed for user "engine_history"
>
>2014-01-09 07:41:21::DEBUG::common_utils::918::root:: retcode = 2
>2014-01-09 07:41:21::DEBUG::common_utils::630::root:: checking if ovirt_engine_history db already exists
>2014-01-09 07:41:21::DEBUG::common_utils::445::root:: running sql query on host: localhost, port: 5432, db: ovirt_engine_history, user: engine, query: 'select 1'.
>2014-01-09 07:41:21::DEBUG::common_utils::874::root:: Executing command --> '/usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname ovirt_engine_history --host localhost --port 5432 --username engine -w -c select 1' in working directory '/'
>2014-01-09 07:41:21::DEBUG::common_utils::916::root:: output =         1
>
>
>2014-01-09 07:41:21::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:21::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:21::DEBUG::common_utils::874::root:: Executing command --> '/sbin/ip addr' in working directory '/'
>2014-01-09 07:41:21::DEBUG::common_utils::916::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 e8:39:35:ac:bf:d0 brd ff:ff:ff:ff:ff:ff
>    inet 172.30.60.21/18 brd 172.30.63.255 scope global eth0
>    inet6 fe80::ea39:35ff:feac:bfd0/64 scope link 
>       valid_lft forever preferred_lft forever
>3: eth1: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d4 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd4/64 scope link 
>       valid_lft forever preferred_lft forever
>4: eth2: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d1 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd1/64 scope link 
>       valid_lft forever preferred_lft forever
>5: eth3: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
>    link/ether e8:39:35:ac:bf:d5 brd ff:ff:ff:ff:ff:ff
>    inet6 fe80::ea39:35ff:feac:bfd5/64 scope link 
>       valid_lft forever preferred_lft forever
>6: eth4: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d2 brd ff:ff:ff:ff:ff:ff
>7: eth5: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d6 brd ff:ff:ff:ff:ff:ff
>8: eth6: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d3 brd ff:ff:ff:ff:ff:ff
>9: eth7: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN qlen 1000
>    link/ether e8:39:35:ac:bf:d7 brd ff:ff:ff:ff:ff:ff
>
>2014-01-09 07:41:21::DEBUG::common_utils::917::root:: stderr = 
>2014-01-09 07:41:21::DEBUG::common_utils::918::root:: retcode = 0
>2014-01-09 07:41:21::DEBUG::common_utils::719::root:: Found IP Address: 172.30.60.21
>2014-01-09 07:41:21::DEBUG::common_utils::1115::root:: Adding user engine
>2014-01-09 07:41:21::DEBUG::common_utils::874::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -c "CREATE ROLE engine with createdb login encrypted password 'compaq123';"' in working directory '/'
>2014-01-09 07:41:21::DEBUG::common_utils::916::root:: output = 
>2014-01-09 07:41:21::DEBUG::common_utils::917::root:: stderr = ERROR:  role "engine" already exists
>
>2014-01-09 07:41:21::DEBUG::common_utils::918::root:: retcode = 1
>2014-01-09 07:41:21::ERROR::rhevm-dwh-setup::628::root:: Exception caught!
>2014-01-09 07:41:21::ERROR::rhevm-dwh-setup::629::root:: Traceback (most recent call last):
>  File "/usr/bin/rhevm-dwh-setup", line 489, in main
>    validate=False,
>  File "/usr/share/ovirt-engine-dwh/common_utils.py", line 1153, in createUser
>    failOnError=True
>  File "/usr/share/ovirt-engine-dwh/common_utils.py", line 921, in execCmd
>    raise Exception(msg)
>Exception: Return Code is not zero
>

Actions: View

Attachments on bug 1053225: 850216 | 850217