Attachment 834223 Details for Bug 1039459 – failed log

failed log

ovirt-engine-reports-setup-2013_12_08_21_36_22.log (text/plain), 16.32 KB, created by Barak Dagan on 2013-12-09 07:21:49 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Barak Dagan

Created: 2013-12-09 07:21:49 UTC

Size: 16.32 KB

patch

obsolete

>2013-12-08 21:36:22::DEBUG::rhevm-reports-setup::1007::root:: starting main()
>2013-12-08 21:36:22::DEBUG::rhevm-reports-setup::729::root:: /etc/pki/ovirt-engine/keys/engine.p12 exists, ovirt-engine is installed
>2013-12-08 21:36:22::DEBUG::common_utils::533::root:: checking ovirt-engine service
>2013-12-08 21:36:22::DEBUG::common_utils::524::root:: checking the status of ovirt-engine
>2013-12-08 21:36:22::DEBUG::common_utils::227::root:: getting status for ovirt-engine
>2013-12-08 21:36:22::DEBUG::common_utils::244::root:: executing action ovirt-engine on service status
>2013-12-08 21:36:22::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service ovirt-engine status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:36:22::DEBUG::common_utils::1027::root:: output = ovirt-engine (pid  26274) is running...
>
>2013-12-08 21:36:22::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:36:22::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:36:22::DEBUG::common_utils::535::root:: ovirt-engine is up and running
>2013-12-08 21:36:22::DEBUG::common_utils::440::root:: asking user: Would you like to stop the ovirt-engine service (yes|no): 
>2013-12-08 21:54:13::DEBUG::common_utils::444::root:: user answered: yes
>2013-12-08 21:54:13::DEBUG::decorators::17::root:: running stopEngineService
>2013-12-08 21:54:13::DEBUG::common_utils::548::root:: Stopping ovirt-engine
>2013-12-08 21:54:13::DEBUG::common_utils::193::root:: stopping ovirt-engine
>2013-12-08 21:54:13::DEBUG::common_utils::244::root:: executing action ovirt-engine on service stop
>2013-12-08 21:54:13::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service ovirt-engine stop' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:15::DEBUG::common_utils::1027::root:: output = Stopping oVirt Engine: [  OK  ]
>
>2013-12-08 21:54:15::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:15::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:15::DEBUG::rhevm-reports-setup::519::root:: /etc/ovirt-engine/jrs-deployment.version exists, checking version
>2013-12-08 21:54:15::DEBUG::common_utils::476::root:: cmd = rpm -q --queryformat %{VERSION}-%{RELEASE} jasperreports-server-pro
>2013-12-08 21:54:15::DEBUG::common_utils::492::root:: output = 5.5.0-4.el6ev
>2013-12-08 21:54:15::DEBUG::common_utils::493::root:: stderr = 
>2013-12-08 21:54:15::DEBUG::common_utils::494::root:: retcode = 0
>2013-12-08 21:54:15::DEBUG::rhevm-reports-setup::532::root:: 4.7.1-2.el6ev differs from 5.5.0-4.el6ev, war deployment required
>2013-12-08 21:54:15::DEBUG::rhevm-reports-setup::819::root:: Found WAR folder /usr/share/ovirt-engine/rhevm-reports.war
>2013-12-08 21:54:15::DEBUG::rhevm-reports-setup::1021::root:: war will be updated and was previously deployed, will preserve ad hoc reports
>2013-12-08 21:54:15::DEBUG::common_utils::476::root:: cmd = /sbin/ip addr
>2013-12-08 21:54:15::DEBUG::common_utils::492::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 pfifo_fast state UP qlen 1000
>    link/ether 00:1a:4a:16:97:f2 brd ff:ff:ff:ff:ff:ff
>    inet 10.35.161.242/24 brd 10.35.161.255 scope global eth0
>    inet6 fe80::21a:4aff:fe16:97f2/64 scope link 
>       valid_lft forever preferred_lft forever
>
>2013-12-08 21:54:15::DEBUG::common_utils::493::root:: stderr = 
>2013-12-08 21:54:15::DEBUG::common_utils::494::root:: retcode = 0
>2013-12-08 21:54:15::DEBUG::common_utils::907::root:: Found IP Address: 10.35.161.242
>2013-12-08 21:54:15::DEBUG::common_utils::985::root:: Executing command --> '/bin/hostname' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:15::DEBUG::common_utils::1027::root:: output = fire31-rep.scl.lab.tlv.redhat.com
>
>2013-12-08 21:54:15::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:15::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:15::DEBUG::common_utils::1070::root:: Updating pghba postgres use
>2013-12-08 21:54:15::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:15::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:15::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:15::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:15::DEBUG::common_utils::1027::root:: output = postmaster (pid  26221) is running...
>
>2013-12-08 21:54:15::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:15::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:15::DEBUG::common_utils::607::root:: stopping postgresql
>2013-12-08 21:54:15::DEBUG::common_utils::193::root:: stopping postgresql
>2013-12-08 21:54:15::DEBUG::common_utils::244::root:: executing action postgresql on service stop
>2013-12-08 21:54:15::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql stop' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:16::DEBUG::common_utils::1027::root:: output = Stopping postgresql service: [  OK  ]
>
>2013-12-08 21:54:16::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:16::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:16::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:16::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:16::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:16::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:16::DEBUG::common_utils::1027::root:: output = postmaster is stopped
>
>2013-12-08 21:54:16::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:16::DEBUG::common_utils::1029::root:: retcode = 3
>2013-12-08 21:54:16::DEBUG::common_utils::602::root:: starting postgresql
>2013-12-08 21:54:16::DEBUG::common_utils::183::root:: starting postgresql
>2013-12-08 21:54:16::DEBUG::common_utils::244::root:: executing action postgresql on service start
>2013-12-08 21:54:16::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql start' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output = Starting postgresql service: [  OK  ]
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::common_utils::733::root:: checking if ovirt_engine_history db already exists
>2013-12-08 21:54:18::DEBUG::common_utils::506::root:: running sql query on host: localhost, port: 5432, db: ovirt_engine_history, user: engine_history, query: 'select 1'.
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/usr/bin/psql -w --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname ovirt_engine_history --host localhost --port 5432 --username engine_history -c select 1' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output =         1
>
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::common_utils::733::root:: checking if ovirtenginereports db already exists
>2013-12-08 21:54:18::DEBUG::common_utils::506::root:: running sql query on host: localhost, port: 5432, db: ovirtenginereports, user: engine_reports, query: 'select 1'.
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/usr/bin/psql -w --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname ovirtenginereports --host localhost --port 5432 --username engine_reports -c select 1' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output = 
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = psql: FATAL:  database "ovirtenginereports" does not exist
>
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 2
>2013-12-08 21:54:18::DEBUG::common_utils::733::root:: checking if rhevmreports db already exists
>2013-12-08 21:54:18::DEBUG::common_utils::506::root:: running sql query on host: localhost, port: 5432, db: rhevmreports, user: engine, query: 'select 1'.
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/usr/bin/psql -w --pset=tuples_only=on --set ON_ERROR_STOP=1 --dbname rhevmreports --host localhost --port 5432 --username engine -c select 1' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output =         1
>
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::rhevm-reports-setup::1063::root:: Local database ovirtenginereports found, not owned by reports user. Updating the owner to engine_reports
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 -c "create role engine_reports";' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output = CREATE ROLE
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 -c "alter role engine_reports with login encrypted password '9445SirS';"' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output = ALTER ROLE
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::common_utils::1107::root:: Updating pghba
>2013-12-08 21:54:18::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:18::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:18::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:18::DEBUG::common_utils::1027::root:: output = postmaster (pid  27058) is running...
>
>2013-12-08 21:54:18::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:18::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:18::DEBUG::common_utils::607::root:: stopping postgresql
>2013-12-08 21:54:18::DEBUG::common_utils::193::root:: stopping postgresql
>2013-12-08 21:54:18::DEBUG::common_utils::244::root:: executing action postgresql on service stop
>2013-12-08 21:54:18::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql stop' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:20::DEBUG::common_utils::1027::root:: output = Stopping postgresql service: [  OK  ]
>
>2013-12-08 21:54:20::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:20::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:20::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:20::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:20::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:20::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:20::DEBUG::common_utils::1027::root:: output = postmaster is stopped
>
>2013-12-08 21:54:20::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:20::DEBUG::common_utils::1029::root:: retcode = 3
>2013-12-08 21:54:20::DEBUG::common_utils::602::root:: starting postgresql
>2013-12-08 21:54:20::DEBUG::common_utils::183::root:: starting postgresql
>2013-12-08 21:54:20::DEBUG::common_utils::244::root:: executing action postgresql on service start
>2013-12-08 21:54:20::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql start' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:22::DEBUG::common_utils::1027::root:: output = Starting postgresql service: [  OK  ]
>
>2013-12-08 21:54:22::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:22::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:22::DEBUG::common_utils::985::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql --pset=tuples_only=on --set ON_ERROR_STOP=1 -d ovirtenginereports -c "alter database ovirtenginereports owner to engine_reports;"' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:22::DEBUG::common_utils::1027::root:: output = 
>2013-12-08 21:54:22::DEBUG::common_utils::1028::root:: stderr = psql: FATAL:  database "ovirtenginereports" does not exist
>
>2013-12-08 21:54:22::DEBUG::common_utils::1029::root:: retcode = 2
>2013-12-08 21:54:22::ERROR::rhevm-reports-setup::1302::root:: Exception caught!
>2013-12-08 21:54:22::ERROR::rhevm-reports-setup::1303::root:: Traceback (most recent call last):
>  File "/usr/bin/rhevm-reports-setup", line 1069, in main
>    newowner=REPORTS_DB_USER,
>  File "/usr/share/ovirt-engine-reports/common_utils.py", line 1200, in updateDbOwner
>    failOnError=True,
>  File "/usr/share/ovirt-engine-reports/common_utils.py", line 1065, in runPostgresSuQuery
>    failOnError=failOnError
>  File "/usr/share/ovirt-engine-reports/common_utils.py", line 1032, in execCmd
>    raise Exception(msg)
>Exception: Return Code is not zero
>
>2013-12-08 21:54:22::DEBUG::rhevm-reports-setup::264::root:: editing reports datasource file /usr/share/ovirt-engine-reports/reports/resources/reports_resources/JDBC/data_sources/ovirt.xml
>2013-12-08 21:54:22::DEBUG::common_utils::1070::root:: Updating pghba postgres use
>2013-12-08 21:54:22::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:22::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:22::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:22::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:22::DEBUG::common_utils::1027::root:: output = postmaster (pid  27192) is running...
>
>2013-12-08 21:54:22::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:22::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:22::DEBUG::common_utils::607::root:: stopping postgresql
>2013-12-08 21:54:22::DEBUG::common_utils::193::root:: stopping postgresql
>2013-12-08 21:54:22::DEBUG::common_utils::244::root:: executing action postgresql on service stop
>2013-12-08 21:54:22::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql stop' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:23::DEBUG::common_utils::1027::root:: output = Stopping postgresql service: [  OK  ]
>
>2013-12-08 21:54:23::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:23::DEBUG::common_utils::1029::root:: retcode = 0
>2013-12-08 21:54:23::DEBUG::common_utils::578::root:: checking the status of postgresql
>2013-12-08 21:54:23::DEBUG::common_utils::227::root:: getting status for postgresql
>2013-12-08 21:54:23::DEBUG::common_utils::244::root:: executing action postgresql on service status
>2013-12-08 21:54:23::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql status' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:23::DEBUG::common_utils::1027::root:: output = postmaster is stopped
>
>2013-12-08 21:54:23::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:23::DEBUG::common_utils::1029::root:: retcode = 3
>2013-12-08 21:54:23::DEBUG::common_utils::602::root:: starting postgresql
>2013-12-08 21:54:23::DEBUG::common_utils::183::root:: starting postgresql
>2013-12-08 21:54:23::DEBUG::common_utils::244::root:: executing action postgresql on service start
>2013-12-08 21:54:23::DEBUG::common_utils::985::root:: Executing command --> '/sbin/service postgresql start' in working directory '/etc/yum.repos.d'
>2013-12-08 21:54:25::DEBUG::common_utils::1027::root:: output = Starting postgresql service: [  OK  ]
>
>2013-12-08 21:54:25::DEBUG::common_utils::1028::root:: stderr = 
>2013-12-08 21:54:25::DEBUG::common_utils::1029::root:: retcode = 0

Actions: View

Attachments on bug 1039459: 834223