[Users] ovirt-engine-dwh-setup fails

Hello! ovirt-image-uploader-3.3.3-1.fc19.noarch ovirt-engine-dbscripts-3.3.4-1.fc19.noarch ovirt-host-deploy-1.1.3-1.fc19.noarch ovirt-engine-webadmin-portal-3.3.4-1.fc19.noarch ovirt-host-deploy-offline-1.1.3-1.fc19.noarch ovirt-engine-setup-3.3.4-1.fc19.noarch ovirt-engine-backend-3.3.4-1.fc19.noarch ovirt-host-deploy-java-1.1.3-1.fc19.noarch ovirt-engine-3.3.4-1.fc19.noarch ovirt-engine-dwh-3.3.4-1.fc19.noarch ovirt-engine-reports-3.3.4-1.fc19.noarch ovirt-engine-restapi-3.3.4-1.fc19.noarch ovirt-log-collector-3.3.4-1.fc19.noarch ovirt-iso-uploader-3.3.3-1.fc19.noarch ovirt-engine-lib-3.3.4-1.fc19.noarch ovirt-engine-tools-3.3.4-1.fc19.noarch ovirt-release-fedora-10.0.1-3.noarch ovirt-engine-cli-3.3.0.6-1.fc19.noarch ovirt-engine-websocket-proxy-3.3.4-1.fc19.noarch ovirt-engine-sdk-python-3.3.3.1-1.fc19.noarch ovirt-release-11.0.2-1.noarch ovirt-engine-userportal-3.3.4-1.fc19.noarch Trying to run ovirt-engine-dwh-setup I get Stopping ovirt-engine... [ DONE ] Error encountered while installing ovirt-engine-dwh, please consult the log file: ........ logfile follows more /var/log/ovirt-engine/ovirt-engine-dwh-setup-2014_03_17_14_59_39.log 2014-03-17 14:59:39::DEBUG::ovirt-engine-dwh-setup::430::root:: starting main() 2014-03-17 14:59:39::DEBUG::common_utils::451::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-03-17 14:59:39::DEBUG::common_utils::912::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 '/var/lib/pgsql/data' 2014-03-17 14:59:39::DEBUG::common_utils::967::root:: output = option_value 3.3.0 2014-03-17 14:59:39::DEBUG::common_utils::968::root:: stderr = 2014-03-17 14:59:39::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:39::DEBUG::common_utils::153::root:: Value of MinimalETLVersion is 3.3.0 2014-03-17 14:59:39::DEBUG::common_utils::912::root:: Executing command --> 'rpm -q --queryformat %{VERSION}-%{RELEASE} ovirt-engine-dwh' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:39::DEBUG::common_utils::967::root:: output = 3.3.4-1.fc19 2014-03-17 14:59:39::DEBUG::common_utils::968::root:: stderr = 2014-03-17 14:59:39::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:39::DEBUG::common_utils::617::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.4-1.fc19 2014-03-17 14:59:39::DEBUG::common_utils::622::root:: found version, 3.3 2014-03-17 14:59:39::DEBUG::common_utils::624::root:: found minorVersion 4 2014-03-17 14:59:39::DEBUG::common_utils::626::root:: found release 1 2014-03-17 14:59:39::DEBUG::common_utils::617::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.0-0 2014-03-17 14:59:39::DEBUG::common_utils::622::root:: found version, 3.3 2014-03-17 14:59:39::DEBUG::common_utils::624::root:: found minorVersion 0 2014-03-17 14:59:39::DEBUG::common_utils::626::root:: found release 0 2014-03-17 14:59:39::DEBUG::common_utils::491::root:: checking ovirt-engine service 2014-03-17 14:59:39::DEBUG::common_utils::482::root:: checking the status of ovirt-engine 2014-03-17 14:59:39::DEBUG::common_utils::260::root:: getting status for ovirt-engine 2014-03-17 14:59:39::DEBUG::common_utils::277::root:: executing action ovirt-engine on service status 2014-03-17 14:59:39::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service ovirt-engine status' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:39::DEBUG::common_utils::967::root:: output = ovirt-engine.service - oVirt Engine Loaded: loaded (/usr/lib/systemd/system/ovirt-engine.service; enabled) Active: inactive (dead) since Mon 2014-03-17 14:58:56 EET; 43s ago Main PID: 5794 (code=exited, status=0/SUCCESS) CGroup: name=systemd:/system/ovirt-engine.service Mar 17 14:52:31 vpo-rhevm.stfd.ro systemd[1]: Started oVirt Engine. Mar 17 14:52:32 vpo-rhevm.stfd.ro ovirt-engine.py[5794]: 2014-03-17 14:52:32,340 ovirt-engine: WARNING _setupEngineApps:176 Application directory '/usr/share/ovirt-engine/ovirt-engine-report s.war' does not exist, it will be ignored Mar 17 14:58:55 vpo-rhevm.stfd.ro systemd[1]: Stopping oVirt Engine... Mar 17 14:58:56 vpo-rhevm.stfd.ro systemd[1]: Stopped oVirt Engine. 2014-03-17 14:59:39::DEBUG::common_utils::968::root:: stderr = Redirecting to /bin/systemctl status ovirt-engine.service 2014-03-17 14:59:39::DEBUG::common_utils::969::root:: retcode = 3 2014-03-17 14:59:39::DEBUG::common_utils::590::root:: Stopping ovirt-engine-dwhd 2014-03-17 14:59:39::DEBUG::common_utils::581::root:: checking the status of dwhd 2014-03-17 14:59:39::DEBUG::common_utils::260::root:: getting status for ovirt-engine-dwhd 2014-03-17 14:59:39::DEBUG::common_utils::277::root:: executing action ovirt-engine-dwhd on service status 2014-03-17 14:59:39::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service ovirt-engine-dwhd status' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:40::DEBUG::common_utils::967::root:: output = /etc/init.d/ovirt-engine-dwhd is stopped 2014-03-17 14:59:40::DEBUG::common_utils::968::root:: stderr = 2014-03-17 14:59:40::DEBUG::common_utils::969::root:: retcode = 1 2014-03-17 14:59:40::DEBUG::common_utils::912::root:: Executing command --> 'rpm -q --queryformat %{VERSION}-%{RELEASE} ovirt-engine-dwh' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:40::DEBUG::common_utils::967::root:: output = 3.3.4-1.fc19 2014-03-17 14:59:40::DEBUG::common_utils::968::root:: stderr = 2014-03-17 14:59:40::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:40::DEBUG::common_utils::617::root:: setting regex (\d+\.\d+)\.(\d+)\-(\d+) againts 3.3.4-1.fc19 2014-03-17 14:59:40::DEBUG::common_utils::622::root:: found version, 3.3 2014-03-17 14:59:40::DEBUG::common_utils::624::root:: found minorVersion 4 2014-03-17 14:59:40::DEBUG::common_utils::626::root:: found release 1 2014-03-17 14:59:40::DEBUG::ovirt-engine-dwh-setup::391::root:: Setting etlVersion 2014-03-17 14:59:40::DEBUG::ovirt-engine-dwh-setup::392::root:: editing etl connectivity file 2014-03-17 14:59:40::DEBUG::common_utils::912::root:: Executing command --> '/sbin/ip addr' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:40::DEBUG::common_utils::967::root:: output = 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo valid_lft forever preferred_lft forever inet6 ::1/128 scope host valid_lft forever preferred_lft forever 2: bond0: <NO-CARRIER,BROADCAST,MULTICAST,MASTER,UP> mtu 1500 qdisc noqueue state DOWN group default link/ether c2:71:02:2b:9b:01 brd ff:ff:ff:ff:ff:ff 3: ens32: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000 link/ether 00:0c:29:7f:5b:4b brd ff:ff:ff:ff:ff:ff inet 10.125.1.171/24 brd 10.125.1.255 scope global ens32 valid_lft forever preferred_lft forever inet6 fe80::20c:29ff:fe7f:5b4b/64 scope link valid_lft forever preferred_lft forever 4: ;vdsmdummy;: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN group default link/ether 72:06:8c:05:e3:a3 brd ff:ff:ff:ff:ff:ff 2014-03-17 14:59:40::DEBUG::common_utils::968::root:: stderr = 2014-03-17 14:59:40::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:40::DEBUG::common_utils::755::root:: Found IP Address: 10.125.1.171 2014-03-17 14:59:40::DEBUG::common_utils::1406::root:: Updating pghba postgres use 2014-03-17 14:59:40::DEBUG::common_utils::529::root:: checking the status of postgresql 2014-03-17 14:59:40::DEBUG::common_utils::260::root:: getting status for postgresql 2014-03-17 14:59:40::DEBUG::common_utils::277::root:: executing action postgresql on service status 2014-03-17 14:59:40::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service postgresql status' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:40::DEBUG::common_utils::967::root:: output = postgresql.service - PostgreSQL database server Loaded: loaded (/usr/lib/systemd/system/postgresql.service; enabled) Active: active (running) since Mon 2014-03-17 14:59:32 EET; 8s ago Process: 6503 ExecStop=/usr/bin/pg_ctl stop -D ${PGDATA} -s -m fast (code=exited, status=0/SUCCESS) Process: 6514 ExecStart=/usr/bin/pg_ctl start -D ${PGDATA} -s -o -p ${PGPORT} -w -t 300 (code=exited, status=0/SUCCESS) Process: 6507 ExecStartPre=/usr/bin/postgresql-check-db-dir ${PGDATA} (code=exited, status=0/SUCCESS) Main PID: 6517 (postgres) CGroup: name=systemd:/system/postgresql.service ├─6517 /usr/bin/postgres -D /var/lib/pgsql/data -p 5432 ├─6518 postgres: logger process ├─6520 postgres: checkpointer process ├─6521 postgres: writer process ├─6522 postgres: wal writer process ├─6523 postgres: autovacuum launcher process └─6524 postgres: stats collector process Mar 17 14:59:31 vpo-rhevm.stfd.ro systemd[1]: Starting PostgreSQL database server... Mar 17 14:59:32 vpo-rhevm.stfd.ro systemd[1]: Started PostgreSQL database server. 2014-03-17 14:59:40::DEBUG::common_utils::968::root:: stderr = Redirecting to /bin/systemctl status postgresql.service 2014-03-17 14:59:40::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:40::DEBUG::common_utils::573::root:: stopping postgresql 2014-03-17 14:59:40::DEBUG::common_utils::226::root:: stopping postgresql 2014-03-17 14:59:40::DEBUG::common_utils::277::root:: executing action postgresql on service stop 2014-03-17 14:59:40::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service postgresql stop' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:41::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:41::DEBUG::common_utils::968::root:: stderr = Redirecting to /bin/systemctl stop postgresql.service 2014-03-17 14:59:41::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:41::DEBUG::common_utils::529::root:: checking the status of postgresql 2014-03-17 14:59:41::DEBUG::common_utils::260::root:: getting status for postgresql 2014-03-17 14:59:41::DEBUG::common_utils::277::root:: executing action postgresql on service status 2014-03-17 14:59:41::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service postgresql status' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:41::DEBUG::common_utils::967::root:: output = postgresql.service - PostgreSQL database server Loaded: loaded (/usr/lib/systemd/system/postgresql.service; enabled) Active: inactive (dead) since Mon 2014-03-17 14:59:41 EET; 119ms ago Process: 6567 ExecStop=/usr/bin/pg_ctl stop -D ${PGDATA} -s -m fast (code=exited, status=0/SUCCESS) Process: 6514 ExecStart=/usr/bin/pg_ctl start -D ${PGDATA} -s -o -p ${PGPORT} -w -t 300 (code=exited, status=0/SUCCESS) Process: 6507 ExecStartPre=/usr/bin/postgresql-check-db-dir ${PGDATA} (code=exited, status=0/SUCCESS) Main PID: 6517 (code=exited, status=0/SUCCESS) CGroup: name=systemd:/system/postgresql.service Mar 17 14:59:31 vpo-rhevm.stfd.ro systemd[1]: Starting PostgreSQL database server... Mar 17 14:59:32 vpo-rhevm.stfd.ro systemd[1]: Started PostgreSQL database server. Mar 17 14:59:40 vpo-rhevm.stfd.ro systemd[1]: Stopping PostgreSQL database server... Mar 17 14:59:41 vpo-rhevm.stfd.ro systemd[1]: Stopped PostgreSQL database server. 2014-03-17 14:59:41::DEBUG::common_utils::968::root:: stderr = Redirecting to /bin/systemctl status postgresql.service 2014-03-17 14:59:41::DEBUG::common_utils::969::root:: retcode = 3 2014-03-17 14:59:41::DEBUG::common_utils::568::root:: starting postgresql 2014-03-17 14:59:41::DEBUG::common_utils::216::root:: starting postgresql 2014-03-17 14:59:41::DEBUG::common_utils::277::root:: executing action postgresql on service start 2014-03-17 14:59:41::DEBUG::common_utils::912::root:: Executing command --> '/sbin/service postgresql start' in working directory '/var/lib/pgsql/data' 2014-03-17 14:59:42::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:43::DEBUG::common_utils::968::root:: stderr = Redirecting to /bin/systemctl start postgresql.service 2014-03-17 14:59:43::DEBUG::common_utils::969::root:: retcode = 0 2014-03-17 14:59:43::DEBUG::common_utils::1460::root:: starting runPostgresSuQuery database: template1 query: "select 1;" 2014-03-17 14:59:43::DEBUG::common_utils::912::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tA -c "select 1;"' in working directory '/var/lib/ pgsql/data' 2014-03-17 14:59:43::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:43::DEBUG::common_utils::968::root:: stderr = Password for user postgres: psql: fe_sendauth: no password supplied 2014-03-17 14:59:43::DEBUG::common_utils::969::root:: retcode = 2 2014-03-17 14:59:45::DEBUG::common_utils::1460::root:: starting runPostgresSuQuery database: template1 query: "select 1;" 2014-03-17 14:59:45::DEBUG::common_utils::912::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tA -c "select 1;"' in working directory '/var/lib/ pgsql/data' 2014-03-17 14:59:45::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:45::DEBUG::common_utils::968::root:: stderr = Password for user postgres: psql: fe_sendauth: no password supplied 2014-03-17 14:59:45::DEBUG::common_utils::969::root:: retcode = 2 2014-03-17 14:59:47::DEBUG::common_utils::1460::root:: starting runPostgresSuQuery database: template1 query: "select 1;" 2014-03-17 14:59:47::DEBUG::common_utils::912::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tA -c "select 1;"' in working directory '/var/lib/ pgsql/data' 2014-03-17 14:59:47::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:47::DEBUG::common_utils::968::root:: stderr = Password for user postgres: psql: fe_sendauth: no password supplied 2014-03-17 14:59:47::DEBUG::common_utils::969::root:: retcode = 2 2014-03-17 14:59:49::DEBUG::common_utils::1460::root:: starting runPostgresSuQuery database: template1 query: "select 1;" 2014-03-17 14:59:49::DEBUG::common_utils::912::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tA -c "select 1;"' in working directory '/var/lib/ pgsql/data' 2014-03-17 14:59:49::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:49::DEBUG::common_utils::968::root:: stderr = Password for user postgres: psql: fe_sendauth: no password supplied 2014-03-17 14:59:49::DEBUG::common_utils::969::root:: retcode = 2 2014-03-17 14:59:51::DEBUG::common_utils::1460::root:: starting runPostgresSuQuery database: template1 query: "select 1;" 2014-03-17 14:59:51::DEBUG::common_utils::912::root:: Executing command --> '/bin/su -l postgres -c /usr/bin/psql -U postgres -d template1 -tA -c "select 1;"' in working directory '/var/lib/ pgsql/data' 2014-03-17 14:59:52::DEBUG::common_utils::967::root:: output = 2014-03-17 14:59:52::DEBUG::common_utils::968::root:: stderr = Password for user postgres: psql: fe_sendauth: no password supplied 2014-03-17 14:59:52::DEBUG::common_utils::969::root:: retcode = 2 2014-03-17 14:59:54::ERROR::ovirt-engine-dwh-setup::716::root:: Exception caught! 2014-03-17 14:59:54::ERROR::ovirt-engine-dwh-setup::717::root:: Traceback (most recent call last): File "/usr/bin/ovirt-engine-dwh-setup", line 474, in main pg_updated = utils.configHbaIdent() File "/usr/share/ovirt-engine-dwh/common_utils.py", line 1431, in configHbaIdent restartPostgres(newval=='md5') File "/usr/share/ovirt-engine-dwh/common_utils.py", line 887, in restartPostgres startPostgres() File "/usr/share/ovirt-engine-dwh/common_utils.py", line 556, in startPostgres 'Error: postgresql service couldn\'t be started. Stopping.' RuntimeError: Error: postgresql service couldn't be started. Stopping.