Plugins » Katello

Cloned from https://bugzilla.redhat.com/show_bug.cgi?id=1196031
Description of problem:
When running `katello-installer --upgrade` in step "Upgrade Step: migrate_pulp..." there is "sudo: sorry, you must have a tty to run sudo" error

Version-Release number of selected component (if applicable):
6.0.Z to Satellite-6.1.0-RHEL-6-20150224.0-Satellite-x86_64

How reproducible:
always on RHEL6 (?)

Steps to Reproduce:
1. Install 6.0.Z
2. Upgrade packages to Satellite-6.1.0-RHEL-6-20150224.0-Satellite-x86_64
3. # katello-installer --upgrade

Actual results:
Debug: Automatically imported kafo_configure from : 0 00:00:00
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:03
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:04
Debug: hiera(): Looking up apache::default_mods::m: 0 0.0/s 00:00:05
Debug: template[/usr/share/katello-installer/modul: 0 0.0/s 00:00:06
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:07
Debug: importing '/usr/share/katello-installer/mod: 0 0.0/s 00:00:10
Debug: hiera(): Cannot find datafile /var/lib/hier: 0 0.0/s 00:00:11
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:12
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:13
Debug: hiera(): Looking for data source common : 0 0.0/s 00:00:14
Debug: Automatically imported certs::katello from : 0 0.0/s 00:00:15
Debug: Automatically imported dhcp from dhcp into : 0 0.0/s 00:00:17
Debug: Automatically imported certs::puppet from c: 0 0.0/s 00:00:18
Debug: hiera(): Cannot find datafile /var/lib/hier: 0 0.0/s 00:00:19
Debug: template[/usr/share/katello-installer/modul: 0 0.0/s 00:00:20
Debug: template[/usr/share/katello-installer/modul: 0 0.0/s 00:00:21
Debug: Scope(Apache::Vhost[crane]): Retrieving tem: 0 0.0/s 00:00:22
Debug: template[/usr/share/katello-installer/modul: 0 0.0/s 00:00:23
Debug: Adding relationship from Pubkey[/etc/pki/ka: 0 0.0/s 00:00:25
Debug: Puppet::Type::Package::ProviderDpkg: file /: 0 0.0/s 00:00:26
Debug: /File[dav_fs.conf]/selrole: Found selrole d: 0 0.0/s 00:00:27
Debug: /File[/etc/tomcat6/server.xml]/selrole: Fou: 0 0.0/s 00:00:28
Debug: /File[/var/www/html/pub]/selrole: Found sel: 0 0.0/s 00:00:30
Debug: Puppet::Type::Foreman_smartproxy::ProviderR: 0 0.0/s 00:00:31
Debug: /File[authz_owner.load]/selrange: Found sel: 0 0.0/s 00:00:32
Debug: /File[/etc/httpd/conf.d/05-foreman-ssl.d/ka: 0 0.0/s 00:00:34
Debug: /File[/var/lib/puppet/concat/_etc_httpd_con: 0 0.0/s 00:00:35
Debug: /File[/var/lib/puppet/ssl/private_keys]/sel: 0 0.0/s 00:00:36
Debug: /Stage[main]/Dhcp/File[/etc/sysconfig/dhcpd: 0/594, 0%, 0.0/s, elapsed: 00:00:37
Debug: /Stage[main]/Apache::Default_mods/Apache::M: 0/594, 0%, 0.0/s, elapsed: 00:00:38
Info: Applying configuration version '1424819355' : 0/594, 0%, 0.0/s, elapsed: 00:00:39
Info: RESOURCE Package[mongodb_client] : 5/594, 0%, 0.0/s, elapsed: 00:00:41
Info: RESOURCE File[/etc/pki/katello] : 55/594, 9%, 3.6/s, elapsed: 00:00:42, ETA: 00:02:29
Notice: /Stage[main]/Foreman::Puppetmaster/File[/u: 64/594, 10%, 3.6/s, elapsed: 00:00:43, ETA: 00:02:27
Debug: Executing '/sbin/chkconfig named' : 125/594, 21%, 7.0/s, elapsed: 00:00:45, ETA: 00:01:07
Info: RESOURCE Apache::Mod[negotiation] : 130/594, 21%, 7.0/s, elapsed: 00:00:46, ETA: 00:01:06
Info: RESOURCE File[log_config.load] : 179/594, 30%, 7.0/s, elapsed: 00:00:48, ETA: 00:00:59
Debug: Executing '/sbin/chkconfig xinetd' : 246/594, 41%, 13.1/s, elapsed: 00:00:49, ETA: 00:00:26
Notice: /Stage[main]/Postgresql::Server::Config/Po: 260/594, 43%, 13.1/s, elapsed: 00:00:51, ETA: 00:00:25
Debug: /Stage[main]/Postgresql::Server::Config/Con: 272/594, 45%, 14.4/s, elapsed: 00:00:52, ETA: 00:00:22
Info: RESOURCE Dhcp::Pool[<something>]: 278/594, 46%, 14.4/s, elapsed: 00:00:53, ETA: 00:00:21
Info: RESOURCE Service[elasticsearch] : 290/594, 48%, 14.4/s, elapsed: 00:00:54, ETA: 00:00:21
Notice: /Stage[main]/Candlepin::Config/File[/etc/t: 330/594, 55%, 17.4/s, elapsed: 00:00:55, ETA: 00:00:15
Notice: /Stage[main]/Candlepin::Config/Concat[/etc: 337/594, 56%, 17.4/s, elapsed: 00:00:56, ETA: 00:00:14
Debug: /File[/var/lib/puppet/concat/_etc_httpd_con: 347/594, 58%, 17.4/s, elapsed: 00:00:57, ETA: 00:00:14
Info: RESOURCE Pubkey[/etc/pki/katello/certs/katel: 388/594, 65%, 20.4/s, elapsed: 00:00:58, ETA: 00:00:10
Info: RESOURCE Concat[/var/lib/pgsql/data/pg_hba.c: 412/594, 69%, 20.4/s, elapsed: 00:01:00, ETA: 00:00:08
Debug: Executing '/sbin/service postgresql start' : 422/594, 71%, 20.4/s, elapsed: 00:01:01, ETA: 00:00:08
Debug: Executing '/sbin/chkconfig postgresql' : 422/594, 71%, 18.0/s, elapsed: 00:01:03, ETA: 00:00:09
Notice: /Stage[main]/Postgresql::Server::Reload/Ex: 428/594, 72%, 18.0/s, elapsed: 00:01:05, ETA: 00:00:09
Debug: /Stage[main]/Candlepin::Database::Postgresq: 432/594, 72%, 18.0/s, elapsed: 00:01:06, ETA: 00:00:09
Debug: /Stage[main]/Foreman::Database::Postgresql/: 440/594, 74%, 15.5/s, elapsed: 00:01:07, ETA: 00:00:09
Notice: /Stage[main]/Mongodb::Server::Config/File[: 459/594, 77%, 15.5/s, elapsed: 00:01:08, ETA: 00:00:08
Debug: Executing '/sbin/chkconfig mongod' : 461/594, 77%, 10.2/s, elapsed: 00:01:11, ETA: 00:00:12
Debug: Executing '/sbin/service mongod stop' : 462/594, 77%, 10.2/s, elapsed: 00:01:13, ETA: 00:00:12
Debug: Executing '/sbin/service mongod start' : 462/594, 77%, 9.0/s, elapsed: 00:01:15, ETA: 00:00:14
Notice: /Stage[main]/Mongodb::Server::Service/Serv: 462/594, 77%, 6.0/s, elapsed: 00:01:20, ETA: 00:00:22
Info: RESOURCE File[/etc/sysconfig/katello] : 480/594, 80%, 6.0/s, elapsed: 00:01:21, ETA: 00:00:19
Debug: /Stage[main]/Foreman::Database::Postgresql/: 485/594, 81%, 6.0/s, elapsed: 00:01:22, ETA: 00:00:18
Debug: /Stage[main]/Foreman::Database::Postgresql/: 491/594, 82%, 4.4/s, elapsed: 00:01:23, ETA: 00:00:23
Notice: /Stage[main]/Qpid::Config/File[/etc/qpid/q: 499/594, 84%, 4.4/s, elapsed: 00:01:25, ETA: 00:00:21
Debug: /File[/etc/httpd/conf.d/ssl.conf]/seluser: : 515/594, 86%, 4.4/s, elapsed: 00:01:26, ETA: 00:00:18
Debug: /File[/etc/httpd/conf.d/cache.load]/selrole: 515/594, 86%, 4.4/s, elapsed: 00:01:27, ETA: 00:00:18
Notice: /Stage[main]/Crane::Apache/Apache::Vhost[c: 519/594, 87%, 4.3/s, elapsed: 00:01:28, ETA: 00:00:17
Debug: Executing '/bin/rpm Uvh --force /root/ssl: 528/594, 88%, 4.3/s, elapsed: 00:01:31, ETA: 00:00:15
Notice: /Stage[main]/Certs::Foreman_proxy/Cert[sun: 528/594, 88%, 3.8/s, elapsed: 00:01:32, ETA: 00:00:17
Notice: /Stage[main]/Puppet::Server::Rack/File[/et: 543/594, 91%, 3.8/s, elapsed: 00:01:33, ETA: 00:00:13
Debug: Executing 'diff u /etc/httpd/conf.d/25-pup: 547/594, 92%, 3.8/s, elapsed: 00:01:35, ETA: 00:00:12
Notice: /Stage[main]/Apache/Concat[/etc/httpd/conf: 557/594, 93%, 4.2/s, elapsed: 00:01:36, ETA: 00:00:08
Debug: /Stage[main]/Foreman::Config/Cron[daily sum: 569/594, 95%, 4.2/s, elapsed: 00:01:37, ETA: 00:00:05
Notice: /Stage[main]/Foreman::Config::Passenger/Ap: 581/594, 97%, 4.2/s, elapsed: 00:01:38, ETA: 00:00:03
Notice: /Stage[main]/Katello::Config/File[/etc/for: 586/594, 98%, 4.2/s, elapsed: 00:01:39, ETA: 00:00:01
Notice: /Stage[main]/Foreman::Database/Foreman_con: 591/594, 99%, 4.2/s, elapsed: 00:03:03
Notice: /Stage[main]/Foreman::Database/Foreman::Ra: 593/594, 99%, 4.2/s, elapsed: 00:04:43
Debug: /Stage[main]/Puppet::Server::Service/Servic: 593/594, 99%, 4.2/s, elapsed: 00:04:44
Info: RESOURCE File[/var/lib/tftpboot//pxelinux.cf: 593/594, 99%, 4.2/s, elapsed: 00:04:46
@ -1,6 +1,6 @ : 593/594, 99%, 4.2/s, elapsed: 00:04:47
Notice: /Stage[main]/Puppet::Agent::Service/Servic: 593/594, 99%, 2.8/s, elapsed: 00:04:51
Notice: /Stage[main]/Foreman_proxy::Config/Foreman: 593/594, 99%, 2.8/s, elapsed: 00:04:52
Info: Class[Foreman_proxy::Service]: Scheduling re: 593/594, 99%, 2.8/s, elapsed: 00:04:53
Info: RESOURCE Exec[add-ca-cert-to-nss-db] : 593/594, 99%, 2.8/s, elapsed: 00:04:54
Notice: /Stage[main]/Certs::Qpid/Exec[add-private: 593/594, 99%, 1.7/s, elapsed: 00:04:56
Debug: Executing '/sbin/chkconfig qpidd' : 593/594, 99%, 1.7/s, elapsed: 00:04:57
Notice: /Stage[main]/Qpid::Service/Service[qpidd]/: 593/594, 99%, 1.7/s, elapsed: 00:04:58
Debug: /Stage[main]/Certs::Candlepin/Exec[create c: 593/594, 99%, 1.7/s, elapsed: 00:04:59
Debug: /Stage[main]/Certs::Candlepin/Exec[create c: 593/594, 99%, 1.4/s, elapsed: 00:05:01
Notice: /Stage[main]/Certs::Candlepin/Exec[import : 593/594, 99%, 1.4/s, elapsed: 00:05:02
Debug: /Stage[main]/Certs::Candlepin/Exec[import c: 593/594, 99%, 1.4/s, elapsed: 00:05:03
Notice: /Stage[main]/Certs::Candlepin/Exec[import : 593/594, 99%, 1.4/s, elapsed: 00:05:04
Debug: Exec[import client certificate into Candlep: 593/594, 99%, 0.1/s, elapsed: 00:05:05, ETA: 00:00:14
Notice: /Stage[main]/Certs::Candlepin/Exec[import : 593/594, 99%, 0.1/s, elapsed: 00:05:07, ETA: 00:00:14
Debug: Executing '/sbin/chkconfig tomcat6' : 593/594, 99%, 0.1/s, elapsed: 00:05:08, ETA: 00:00:14
Notice: /Stage[main]/Candlepin::Service/Service[to: 593/594, 99%, 0.0/s, elapsed: 00:05:44, ETA: 00:05:00
Info: RESOURCE Package[pulp-nodes-parent] : 593/594, 99%, 0.0/s, elapsed: 00:05:45, ETA: 00:05:00
Notice: /Stage[main]/Pulp::Config/File[/etc/pulp/s: 593/594, 99%, 0.0/s, elapsed: 00:05:46, ETA: 00:05:00
Notice: /Stage[main]/Pulp::Config/Exec[selinux_pul: 593/594, 99%, 0.0/s, elapsed: 00:06:46
Debug: Executing '/sbin/service pulp_celerybeat re: 593/594, 99%, 0.0/s, elapsed: 00:06:47
Notice: /Stage[main]/Pulp::Service/Service[pulp_ce: 593/594, 99%, 0.0/s, elapsed: 00:06:49
[31m /Stage[main]/Pulp::Service/Service[pulp_resource_manager]: Failed to call refresh: Could not restart Service[pulp_resource_manager]: Execution of '/sbin/service pulp_resource_manager restart' returned 1: celery init v10.0.
[0mError: /Stage[main]/Pulp::Service/Service[pulp_res: 593/594, 99%, 0.0/s, elapsed: 00:06:50
[31m /Stage[main]/Pulp::Service/Service[pulp_resource_manager]: Could not restart Service[pulp_resource_manager]: Execution of '/sbin/service pulp_resource_manager restart' returned 1: celery init v10.0.
[0m[31m /Stage[main]/Pulp::Service/Service[pulp_workers]: Failed to call refresh: Could not restart Service[pulp_workers]: Execution of '/sbin/service pulp_workers restart' returned 1: celery init v10.0.
[0mError: /Stage[main]/Pulp::Service/Service[pulp_wor: 593/594, 99%, 0.0/s, elapsed: 00:06:52
[31m /Stage[main]/Pulp::Service/Service[pulp_workers]: Could not restart Service[pulp_workers]: Execution of '/sbin/service pulp_workers restart' returned 1: celery init v10.0.
[0mInfo: RESOURCE Service[httpd] : 593/594, 99%, 0.0/s, elapsed: 00:06:54
Debug: Executing '/sbin/service httpd start' : 593/594, 99%, 0.0/s, elapsed: 00:06:56
Notice: /Stage[main]/Apache::Service/Service[httpd: 593/594, 99%, 0.0/s, elapsed: 00:06:57
Debug: Exec[create katello entitlments queue](prov: 593/594, 99%, 0.0/s, elapsed: 00:06:58
Debug: /Stage[main]/Katello::Qpid/Exec[bind katell: 593/594, 99%, 0.0/s, elapsed: 00:07:00
Info: RESOURCE Exec[foreman-rake-db:seed] : 593/594, 99%, 0.0/s, elapsed: 00:07:01
Notice: /Stage[main]/Foreman::Database/Foreman::Ra: 593/594, 99%, 0.0/s, elapsed: 00:08:22
[31m /Stage[main]/Foreman::Database/Foreman::Rake[db:seed]/Exec[foreman-rake-db:seed]: Failed to call refresh: /usr/sbin/foreman-rake db:seed returned 1 instead of one of [0]
[0m[31m /Stage[main]/Foreman::Database/Foreman::Rake[db:seed]/Exec[foreman-rake-db:seed]: /usr/sbin/foreman-rake db:seed returned 1 instead of one of [0]
[0m
MARK-LWD-LOOP -- 2015-02-24 18:19:46 --
Notice: /Stage[main]/Foreman::Database/Foreman::Ra: 593/594, 99%, 0.0/s, elapsed: 00:11:00
Debug: Executing '/sbin/chkconfig foreman-tasks' : 593/594, 99%, 0.0/s, elapsed: 00:11:01
Info: RESOURCE Foreman::Plugin[discovery] : 593/594, 99%, 0.0/s, elapsed: 00:11:02
Notice: /Stage[main]/Foreman::Service/Exec[restart: 593/594, 99%, 0.0/s, elapsed: 00:11:03
Debug: /Stage[main]/Certs::Foreman/Exec[foreman_ce: 593/594, 99%, 0.0/s, elapsed: 00:12:26
Notice: /Stage[main]/Foreman_proxy::Service/Servic: 593/594, 99%, 0.0/s, elapsed: 00:12:29
Notice: /Stage[main]/Certs::Katello/Certs_bootstra: 593/594, 99%, 0.0/s, elapsed: 00:12:31
Info: RESOURCE Foreman_smartproxy[sun-x8420-01.rht: 593/594, 99%, 0.0/s, elapsed: 00:15:12
Debug: Class[Foreman_proxy::Register]: The contain: 593/594, 99%, 0.0/s, elapsed: 00:15:13
[32mDone [0m: 594/594, 100%, 0.0/s, elapsed: 00:15:19
[32mDone [0m: 594/594, 100%, 0.0/s, elapsed: 00:15:19
/usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:104:in `error': wrong number of arguments (23 for 1) (ArgumentError)
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:104:in `send'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:104:in `dump_buffer'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:104:in `each'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:104:in `dump_buffer'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:103:in `each'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:103:in `dump_buffer'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:94:in `dump_errors'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/logger.rb:99:in `dump_errors'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/exit_handler.rb:26:in `exit'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/kafo_configure.rb:122:in `exit'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/kafo_configure.rb:338:in `run_installation'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/kafo_configure.rb:109:in `execute'
from /usr/lib/ruby/gems/1.8/gems/clamp-0.6.2/lib/clamp/command.rb:67:in `run'
from /usr/lib/ruby/gems/1.8/gems/clamp-0.6.2/lib/clamp/command.rb:125:in `run'
from /usr/lib/ruby/gems/1.8/gems/kafo-0.6.5/lib/kafo/kafo_configure.rb:116:in `run'
from /usr/sbin/katello-installer:9
[1m[36mUpgrading...[0m
[1m[36mUpgrade Step: migrate_pulp...[0m
[1m[36mUpgrade Step: migrate_candlepin...[0m
[1m[36mUpgrade Step: migrate_foreman...[0m
[1m[36mUpgrade Step: Running installer...[0m
[1m[36mUpgrade Step: db:seed...[0m
[1m[36mUpgrade Step: Running errata import task (this may take a while)...[0m
[1m[31mSomething went wrong![0m Check the log for ERROR-level output
The full log is at [1m[36m/var/log/katello-installer/katello-installer.log[0m

But this bug reports first ERROR in the log:

[...]
[ INFO 2015-02-24 18:07:25 main] Upgrade Step: migrate_pulp...
[ERROR 2015-02-24 18:07:25 main] sudo: sorry, you must have a tty to run sudo
[...]

Another strange thing here is that in `katello-installer --upgrade` output no error is reported close to "Upgrade Step: migrate_pulp..." line.

Expected results:
No errors during upgrade