Attachment 633681 Details for Bug 870314 – vdsm-reg.log

vdsm-reg.log

vdsm-reg.log (text/x-log), 9.89 KB, created by Meng Liang on 2012-10-26 07:02:05 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Meng Liang

Created: 2012-10-26 07:02:05 UTC

Size: 9.89 KB

patch

obsolete

>MainThread::INFO::2012-10-26 06:52:23,408::vdsm-reg-setup::256::vdsRegistrator::After daemonize - My pid is 13410
>MainThread::DEBUG::2012-10-26 06:52:23,412::vdsm-reg-setup::37::root::__init__ begin.
>MainThread::DEBUG::2012-10-26 06:52:23,422::deployUtil::369::root::_getMGTIface: read host name: 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:23,423::deployUtil::376::root::_getMGTIface: using host name 10.66.108.198 strIP= 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:23,424::deployUtil::382::root::_getMGTIface IP=10.66.108.198 strIface=rhevm
>MainThread::DEBUG::2012-10-26 06:52:23,432::deployUtil::400::root::getMGTIP: Host parsed interfaces:
>{'bond4': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond0': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond1': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond2': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond3': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'lo': {'hwaddr': '', 'netmask': '255.0.0.0', 'addr': '127.0.0.1'}, 'em1': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '', 'addr': ''}, 'rhevm': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '255.255.252.0', 'addr': '10.66.10.108'}}
>
>MainThread::DEBUG::2012-10-26 06:52:23,433::deployUtil::405::root::getMGTIP: Host MGT IP=10.66.10.108
>MainThread::DEBUG::2012-10-26 06:52:23,434::deployUtil::136::root::['/usr/sbin/dmidecode', '-s', 'system-uuid']
>MainThread::DEBUG::2012-10-26 06:52:23,438::deployUtil::144::root::4C4C4544-0054-4D10-8038-C6C04F353358
>
>MainThread::DEBUG::2012-10-26 06:52:23,439::deployUtil::145::root::
>MainThread::DEBUG::2012-10-26 06:52:23,441::deployUtil::347::root::getHostID: 4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3
>MainThread::DEBUG::2012-10-26 06:52:23,442::vdsm-reg-setup::63::root::Setup::__init__ vars: {'vdcRegPort': '54321', 'ovirtUID': '4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3', 'ovirtName': '', 'fInitOK': True, 'registered': False, 'ovirtURL': '10.66.10.108', 'vdcName': '10.66.108.198', 'vdcPORT': '443', 'VDCTime': None, 'ticket': '', 'vdcURI': '/RHEVManagerWeb/VdsAutoRegistration.aspx', 'vdsmDir': '/usr/share/vdsm', 'vdcURL': '10.66.108.198'}
>MainThread::DEBUG::2012-10-26 06:52:23,443::vdsm-reg-setup::66::root::validate start
>MainThread::DEBUG::2012-10-26 06:52:23,444::vdsm-reg-setup::73::root::validate end. return: False
>MainThread::DEBUG::2012-10-26 06:52:31,453::vdsm-reg-setup::282::vdsRegistrator::Total retry count: 1, waited: 8 seconds.
>MainThread::DEBUG::2012-10-26 06:52:31,454::vdsm-reg-setup::37::root::__init__ begin.
>MainThread::DEBUG::2012-10-26 06:52:31,455::deployUtil::369::root::_getMGTIface: read host name: 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:31,456::deployUtil::376::root::_getMGTIface: using host name 10.66.108.198 strIP= 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:31,458::deployUtil::382::root::_getMGTIface IP=10.66.108.198 strIface=rhevm
>MainThread::DEBUG::2012-10-26 06:52:31,463::deployUtil::400::root::getMGTIP: Host parsed interfaces:
>{'bond4': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond0': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond1': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond2': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond3': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'lo': {'hwaddr': '', 'netmask': '255.0.0.0', 'addr': '127.0.0.1'}, 'em1': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '', 'addr': ''}, 'rhevm': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '255.255.252.0', 'addr': '10.66.10.108'}}
>
>MainThread::DEBUG::2012-10-26 06:52:31,464::deployUtil::405::root::getMGTIP: Host MGT IP=10.66.10.108
>MainThread::DEBUG::2012-10-26 06:52:31,465::deployUtil::136::root::['/usr/sbin/dmidecode', '-s', 'system-uuid']
>MainThread::DEBUG::2012-10-26 06:52:31,468::deployUtil::144::root::4C4C4544-0054-4D10-8038-C6C04F353358
>
>MainThread::DEBUG::2012-10-26 06:52:31,469::deployUtil::145::root::
>MainThread::DEBUG::2012-10-26 06:52:31,471::deployUtil::347::root::getHostID: 4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3
>MainThread::DEBUG::2012-10-26 06:52:31,472::vdsm-reg-setup::63::root::Setup::__init__ vars: {'vdcRegPort': '54321', 'ovirtUID': '4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3', 'ovirtName': '', 'fInitOK': True, 'registered': False, 'ovirtURL': '10.66.10.108', 'vdcName': '10.66.108.198', 'vdcPORT': '443', 'VDCTime': None, 'ticket': '', 'vdcURI': '/RHEVManagerWeb/VdsAutoRegistration.aspx', 'vdsmDir': '/usr/share/vdsm', 'vdcURL': '10.66.108.198'}
>MainThread::DEBUG::2012-10-26 06:52:31,473::vdsm-reg-setup::66::root::validate start
>MainThread::DEBUG::2012-10-26 06:52:31,474::vdsm-reg-setup::73::root::validate end. return: False
>MainThread::DEBUG::2012-10-26 06:52:41,481::vdsm-reg-setup::282::vdsRegistrator::Total retry count: 2, waited: 10 seconds.
>MainThread::DEBUG::2012-10-26 06:52:41,482::vdsm-reg-setup::37::root::__init__ begin.
>MainThread::DEBUG::2012-10-26 06:52:41,484::deployUtil::369::root::_getMGTIface: read host name: 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:41,485::deployUtil::376::root::_getMGTIface: using host name 10.66.108.198 strIP= 10.66.108.198
>MainThread::DEBUG::2012-10-26 06:52:41,489::deployUtil::382::root::_getMGTIface IP=10.66.108.198 strIface=rhevm
>MainThread::DEBUG::2012-10-26 06:52:41,493::deployUtil::400::root::getMGTIP: Host parsed interfaces:
>{'bond4': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond0': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond1': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond2': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'bond3': {'hwaddr': '00:00:00:00:00:00', 'netmask': '', 'addr': ''}, 'lo': {'hwaddr': '', 'netmask': '255.0.0.0', 'addr': '127.0.0.1'}, 'em1': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '', 'addr': ''}, 'rhevm': {'hwaddr': '78:2B:CB:9A:72:A3', 'netmask': '255.255.252.0', 'addr': '10.66.10.108'}}
>
>MainThread::DEBUG::2012-10-26 06:52:41,495::deployUtil::405::root::getMGTIP: Host MGT IP=10.66.10.108
>MainThread::DEBUG::2012-10-26 06:52:41,496::deployUtil::136::root::['/usr/sbin/dmidecode', '-s', 'system-uuid']
>MainThread::DEBUG::2012-10-26 06:52:41,499::deployUtil::144::root::4C4C4544-0054-4D10-8038-C6C04F353358
>
>MainThread::DEBUG::2012-10-26 06:52:41,501::deployUtil::145::root::
>MainThread::DEBUG::2012-10-26 06:52:41,502::deployUtil::347::root::getHostID: 4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3
>MainThread::DEBUG::2012-10-26 06:52:41,503::vdsm-reg-setup::63::root::Setup::__init__ vars: {'vdcRegPort': '54321', 'ovirtUID': '4C4C4544-0054-4D10-8038-C6C04F353358_78:2b:cb:9a:72:a3', 'ovirtName': 'test', 'fInitOK': True, 'registered': False, 'ovirtURL': '10.66.10.108', 'vdcName': '10.66.108.198', 'vdcPORT': '443', 'VDCTime': None, 'ticket': '', 'vdcURI': '/RHEVManagerWeb/VdsAutoRegistration.aspx', 'vdsmDir': '/usr/share/vdsm', 'vdcURL': '10.66.108.198'}
>MainThread::DEBUG::2012-10-26 06:52:41,504::vdsm-reg-setup::66::root::validate start
>MainThread::DEBUG::2012-10-26 06:52:41,505::vdsm-reg-setup::73::root::validate end. return: True
>MainThread::DEBUG::2012-10-26 06:52:41,506::vdsm-reg-setup::180::root::execute start.
>MainThread::DEBUG::2012-10-26 06:52:41,507::deployUtil::418::root::Bridge rhevm already exists.
>MainThread::DEBUG::2012-10-26 06:52:41,508::vdsm-reg-setup::184::root::execute: found existing management bridge. Skipping rename.
>MainThread::DEBUG::2012-10-26 06:52:41,509::deployUtil::1451::root::getRemoteFile start. IP = 10.66.108.198 port = 443 fileName = "/engine.ssh.key.txt"
>MainThread::DEBUG::2012-10-26 06:52:41,543::deployUtil::1488::root::/engine.ssh.key.txt status: 200 reason: OK
>MainThread::DEBUG::2012-10-26 06:52:41,544::deployUtil::1507::root::getRemoteFile end.
>MainThread::DEBUG::2012-10-26 06:52:41,545::deployUtil::667::root::handleSSHKey start
>MainThread::DEBUG::2012-10-26 06:52:41,612::deployUtil::696::root::handleSSHKey: persist authorized_keys
>MainThread::DEBUG::2012-10-26 06:52:41,614::deployUtil::699::root::handleSSHKey end
>MainThread::DEBUG::2012-10-26 06:52:41,615::vdsm-reg-setup::196::root::execute: after getAuthKeysFile: True
>MainThread::DEBUG::2012-10-26 06:52:41,616::vdsm-reg-setup::114::root::registerVDS begin.
>MainThread::DEBUG::2012-10-26 06:52:41,617::vdsm-reg-setup::124::root::registerVDS URI= /RHEVManagerWeb/VdsAutoRegistration.aspx?vds_ip=10.66.10.108&__VIEWSTATE=&vds_unique_id=4C4C4544-0054-4D10-8038-C6C04F353358_78%3A2b%3Acb%3A9a%3A72%3Aa3&vds_name=test&ticket=&port=54321
>
>MainThread::DEBUG::2012-10-26 06:52:41,884::vdsm-reg-setup::155::root::registerVDS status: 200 reason: OK
>MainThread::DEBUG::2012-10-26 06:52:41,885::vdsm-reg-setup::165::root::registerVDS time read: 2012-10-26T06:52:42
>MainThread::DEBUG::2012-10-26 06:52:41,886::vdsm-reg-setup::174::root::registerVDS end.
>MainThread::DEBUG::2012-10-26 06:52:41,887::vdsm-reg-setup::201::root::execute: after registerVDS: True
>MainThread::DEBUG::2012-10-26 06:52:41,888::vdsm-reg-setup::206::root::Registration status: True
>MainThread::DEBUG::2012-10-26 06:52:41,889::deployUtil::707::root::setHostTime start.
>MainThread::DEBUG::2012-10-26 06:52:41,893::deployUtil::136::root::['/usr/sbin/hwclock', '--set', '--utc', '--date=2012-10-26 06:52:42 UTC']
>MainThread::DEBUG::2012-10-26 06:52:42,401::deployUtil::144::root::
>MainThread::DEBUG::2012-10-26 06:52:42,405::deployUtil::145::root::
>MainThread::DEBUG::2012-10-26 06:52:42,406::deployUtil::136::root::['/usr/sbin/hwclock', '-s']
>MainThread::DEBUG::2012-10-26 06:52:43,000::deployUtil::144::root::
>MainThread::DEBUG::2012-10-26 06:52:43,001::deployUtil::145::root::
>MainThread::DEBUG::2012-10-26 06:52:43,002::deployUtil::730::root::setHostTime end. Return:True
>MainThread::DEBUG::2012-10-26 06:52:43,003::vdsm-reg-setup::212::root::Node time in sync with RHEV-M server
>MainThread::DEBUG::2012-10-26 06:52:43,004::vdsm-reg-setup::282::vdsRegistrator::Total retry count: 3, waited: 7 seconds.
>MainThread::INFO::2012-10-26 06:52:43,005::vdsm-reg-setup::290::vdsRegistrator::Exiting ....

Actions: View

Attachments on bug 870314: 633681