Attachment 574503 Details for Bug 809094 – Bootstrap log

Bootstrap log

vds_bootstrap.351122.log (text/x-log), 26.41 KB, created by Jakub Libosvar on 2012-04-02 13:19:26 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Jakub Libosvar

Created: 2012-04-02 13:19:26 UTC

Size: 26.41 KB

patch

obsolete

>Mon, 02 Apr 2012 14:48:24 DEBUG    **** Start VDS Validation ****
>Mon, 02 Apr 2012 14:48:24 DEBUG    Entered VdsValidation(subject = '10.34.63.208', random_num = '6849af36-6803-4a58-a2ac-13504581e7e1', rev_num = 'None', installVirtualizationService = 'True', installGlusterService = 'False')
>Mon, 02 Apr 2012 14:48:24 DEBUG    Setting up Package Sacks
>Mon, 02 Apr 2012 14:48:25 DEBUG    yumSearch: found vdsm entries: [<YumAvailablePackageSqlite : vdsm-4.9.6-4.5.x86_64 (0x218dd10)>, <YumAvailablePackageSqlite : vdsm-4.9-112.7.el6_2.x86_64 (0x218ddd0)>, <YumAvailablePackageSqlite : vdsm-4.9-112.9.el6_2.x86_64 (0x218de50)>]
>Mon, 02 Apr 2012 14:48:25 DEBUG    Host properly registered with RHN/Satellite.
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='RHN_REGISTRATION' status='OK' message='Host properly registered with RHN/Satellite.'/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    yumSearchVersion: pkg vdsm-4.9.6-4.5.x86_64 starts with: vdsm-4.9
>Mon, 02 Apr 2012 14:48:25 DEBUG    yumSearchVersion: pkg vdsm-4.9-112.7.el6_2.x86_64 starts with: vdsm-4.9
>Mon, 02 Apr 2012 14:48:25 DEBUG    yumSearchVersion: pkg vdsm-4.9-112.9.el6_2.x86_64 starts with: vdsm-4.9
>Mon, 02 Apr 2012 14:48:25 DEBUG    Available VDSM matches requirements
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDSM_MAJOR_VER' status='OK' message='Available VDSM matches requirements'/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    virtExplorer testing
>Mon, 02 Apr 2012 14:48:25 DEBUG    CPU vendor is GenuineIntel
>Mon, 02 Apr 2012 14:48:25 DEBUG    virt support in cpu: True, in bios: True
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VT_SVM' status='OK' processor='Intel' message='Server supports virtualization'/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/uname', '-r']
>Mon, 02 Apr 2012 14:48:25 DEBUG    2.6.32-250.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='OS' status='OK' type='RHEL6' message='Supported platform version'/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='KERNEL' status='OK' version='250' message='Supported kernel version: 250'/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/sbin/grubby', '--update-kernel', 'DEFAULT', '--args', 'elevator=deadline']
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    error opening /etc/grub.conf for read: No such file or directory
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/sbin/grubby', '--update-kernel', 'DEFAULT', '--args', 'processor.max_cstate=1']
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    error opening /etc/grub.conf for read: No such file or directory
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='KernelArgs' status='WARN' message='Error adding kernel arg ~elevator=deadline~. Error adding kernel arg ~processor.max_cstate=1~. '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'cman.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    package cman.x86_64 is not installed
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='CONFLICTING PACKAGES' status='OK' result='cman.x86_64' message='package cman.x86_64 is not installed '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    Check required packages ...
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'SDL.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    SDL-1.2.14-2.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='SDL.x86_64' message='SDL-1.2.14-2.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'bridge-utils.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    bridge-utils-1.2-9.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='bridge-utils.x86_64' message='bridge-utils-1.2-9.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'mesa-libGLU.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    mesa-libGLU-7.11-4.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='mesa-libGLU.x86_64' message='mesa-libGLU-7.11-4.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'openssl.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    openssl-1.0.0-20.el6_2.3.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='openssl.x86_64' message='openssl-1.0.0-20.el6_2.3.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'm2crypto.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    m2crypto-0.20.2-9.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='m2crypto.x86_64' message='m2crypto-0.20.2-9.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'rsync.x86_64']
>Mon, 02 Apr 2012 14:48:25 DEBUG    rsync-3.0.6-5.el6_0.1.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='REQ PACKAGES' status='OK' result='rsync.x86_64' message='rsync-3.0.6-5.el6_0.1.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    Check VDS packages ...
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'qemu-kvm']
>Mon, 02 Apr 2012 14:48:25 DEBUG    qemu-kvm-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-kvm' message='qemu-kvm-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'qemu-kvm-tools']
>Mon, 02 Apr 2012 14:48:25 DEBUG    qemu-kvm-tools-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-kvm-tools' message='qemu-kvm-tools-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'vdsm']
>Mon, 02 Apr 2012 14:48:25 DEBUG    package vdsm is not installed
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='WARN' result='vdsm' message='package vdsm is not installed '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'vdsm-cli']
>Mon, 02 Apr 2012 14:48:25 DEBUG    vdsm-cli-4.9.6-4.5.noarch
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='vdsm-cli' message='vdsm-cli-4.9.6-4.5.noarch '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'libjpeg']
>Mon, 02 Apr 2012 14:48:25 DEBUG    libjpeg-6b-46.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='libjpeg' message='libjpeg-6b-46.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'spice-server']
>Mon, 02 Apr 2012 14:48:25 DEBUG    spice-server-0.10.1-4.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='spice-server' message='spice-server-0.10.1-4.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'pixman']
>Mon, 02 Apr 2012 14:48:25 DEBUG    pixman-0.18.4-1.el6_0.1.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='pixman' message='pixman-0.18.4-1.el6_0.1.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'seabios']
>Mon, 02 Apr 2012 14:48:25 DEBUG    seabios-0.6.1.2-15.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='seabios' message='seabios-0.6.1.2-15.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'qemu-img']
>Mon, 02 Apr 2012 14:48:25 DEBUG    qemu-img-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-img' message='qemu-img-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'fence-agents']
>Mon, 02 Apr 2012 14:48:25 DEBUG    package fence-agents is not installed
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='WARN' result='fence-agents' message='package fence-agents is not installed '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/bin/rpm', '-q', 'libselinux-python']
>Mon, 02 Apr 2012 14:48:25 DEBUG    libselinux-python-2.0.94-5.3.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    
>Mon, 02 Apr 2012 14:48:25 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='libselinux-python' message='libselinux-python-2.0.94-5.3.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:25 DEBUG    >>> vdsm should be installed
>Mon, 02 Apr 2012 14:48:25 DEBUG    >>> fence-agents should be installed
>Mon, 02 Apr 2012 14:48:25 DEBUG    Check development packages ...
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/usr/bin/yum', 'clean', 'all']
>Mon, 02 Apr 2012 14:48:25 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Cleaning repos: jboss rhel63-rel-eng-2 rhevm31 vdsm
>Cleaning up Everything
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:25 DEBUG    Install/Update VDS packages ...
>Mon, 02 Apr 2012 14:48:25 DEBUG    Install VDS packages ... ('qemu-kvm', 'qemu-kvm-tools', 'vdsm', 'vdsm-cli', 'libjpeg', 'spice-server', 'pixman', 'seabios', 'qemu-img', 'fence-agents', 'libselinux-python')
>Mon, 02 Apr 2012 14:48:25 DEBUG    Update VDS packages ...  ['vdsm', 'fence-agents']
>Mon, 02 Apr 2012 14:48:25 DEBUG    Installing qemu-kvm 1
>Mon, 02 Apr 2012 14:48:25 DEBUG    ['/usr/bin/yum', '-y', 'update', 'qemu-kvm']
>Mon, 02 Apr 2012 14:48:27 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/bin/rpm', '-q', 'qemu-kvm']
>Mon, 02 Apr 2012 14:48:27 DEBUG    qemu-kvm-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    
>Mon, 02 Apr 2012 14:48:27 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-kvm' message='qemu-kvm-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Installing qemu-kvm-tools 1
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/usr/bin/yum', '-y', 'update', 'qemu-kvm-tools']
>Mon, 02 Apr 2012 14:48:27 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/bin/rpm', '-q', 'qemu-kvm-tools']
>Mon, 02 Apr 2012 14:48:27 DEBUG    qemu-kvm-tools-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    
>Mon, 02 Apr 2012 14:48:27 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-kvm-tools' message='qemu-kvm-tools-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Installing vdsm-cli 1
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/usr/bin/yum', '-y', 'update', 'vdsm-cli']
>Mon, 02 Apr 2012 14:48:27 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/bin/rpm', '-q', 'vdsm-cli']
>Mon, 02 Apr 2012 14:48:27 DEBUG    vdsm-cli-4.9.6-4.5.noarch
>
>Mon, 02 Apr 2012 14:48:27 DEBUG    
>Mon, 02 Apr 2012 14:48:27 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='vdsm-cli' message='vdsm-cli-4.9.6-4.5.noarch '/>
>Mon, 02 Apr 2012 14:48:27 DEBUG    Installing libjpeg 1
>Mon, 02 Apr 2012 14:48:27 DEBUG    ['/usr/bin/yum', '-y', 'update', 'libjpeg']
>Mon, 02 Apr 2012 14:48:28 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/bin/rpm', '-q', 'libjpeg']
>Mon, 02 Apr 2012 14:48:28 DEBUG    libjpeg-6b-46.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    
>Mon, 02 Apr 2012 14:48:28 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='libjpeg' message='libjpeg-6b-46.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Installing spice-server 1
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/usr/bin/yum', '-y', 'update', 'spice-server']
>Mon, 02 Apr 2012 14:48:28 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/bin/rpm', '-q', 'spice-server']
>Mon, 02 Apr 2012 14:48:28 DEBUG    spice-server-0.10.1-4.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    
>Mon, 02 Apr 2012 14:48:28 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='spice-server' message='spice-server-0.10.1-4.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Installing pixman 1
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/usr/bin/yum', '-y', 'update', 'pixman']
>Mon, 02 Apr 2012 14:48:28 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/bin/rpm', '-q', 'pixman']
>Mon, 02 Apr 2012 14:48:28 DEBUG    pixman-0.18.4-1.el6_0.1.x86_64
>
>Mon, 02 Apr 2012 14:48:28 DEBUG    
>Mon, 02 Apr 2012 14:48:28 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='pixman' message='pixman-0.18.4-1.el6_0.1.x86_64 '/>
>Mon, 02 Apr 2012 14:48:28 DEBUG    Installing seabios 1
>Mon, 02 Apr 2012 14:48:28 DEBUG    ['/usr/bin/yum', '-y', 'update', 'seabios']
>Mon, 02 Apr 2012 14:48:29 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/bin/rpm', '-q', 'seabios']
>Mon, 02 Apr 2012 14:48:29 DEBUG    seabios-0.6.1.2-15.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    
>Mon, 02 Apr 2012 14:48:29 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='seabios' message='seabios-0.6.1.2-15.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Installing qemu-img 1
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/usr/bin/yum', '-y', 'update', 'qemu-img']
>Mon, 02 Apr 2012 14:48:29 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/bin/rpm', '-q', 'qemu-img']
>Mon, 02 Apr 2012 14:48:29 DEBUG    qemu-img-0.12.1.2-2.241.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    
>Mon, 02 Apr 2012 14:48:29 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='qemu-img' message='qemu-img-0.12.1.2-2.241.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Installing libselinux-python 1
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/usr/bin/yum', '-y', 'update', 'libselinux-python']
>Mon, 02 Apr 2012 14:48:29 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Update Process
>No Packages marked for Update
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/bin/rpm', '-q', 'libselinux-python']
>Mon, 02 Apr 2012 14:48:29 DEBUG    libselinux-python-2.0.94-5.3.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:29 DEBUG    
>Mon, 02 Apr 2012 14:48:29 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='libselinux-python' message='libselinux-python-2.0.94-5.3.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:29 DEBUG    Installing fence-agents 0
>Mon, 02 Apr 2012 14:48:29 DEBUG    ['/usr/bin/yum', '-y', 'install', 'fence-agents']
>Mon, 02 Apr 2012 14:48:33 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Install Process
>Resolving Dependencies
>--> Running transaction check
>---> Package fence-agents.x86_64 0:3.1.5-15.el6 will be installed
>--> Processing Dependency: /usr/bin/virsh for package: fence-agents-3.1.5-15.el6.x86_64
>--> Running transaction check
>---> Package libvirt-client.x86_64 0:0.9.10-4.el6 will be installed
>--> Finished Dependency Resolution
>
>Dependencies Resolved
>
>================================================================================
> Package             Arch        Version            Repository             Size
>================================================================================
>Installing:
> fence-agents        x86_64      3.1.5-15.el6       vdsm                  149 k
>Installing for dependencies:
> libvirt-client      x86_64      0.9.10-4.el6       rhel63-rel-eng-2      3.2 M
>
>Transaction Summary
>================================================================================
>Install       2 Package(s)
>
>Total download size: 3.3 M
>Installed size: 12 M
>Downloading Packages:
>--------------------------------------------------------------------------------
>Total                                           6.7 MB/s | 3.3 MB     00:00     
>Running rpm_check_debug
>Running Transaction Test
>Transaction Test Succeeded
>Running Transaction
>
  Installing : libvirt-client-0.9.10-4.el6.x86_64                           1/2 
>
  Installing : fence-agents-3.1.5-15.el6.x86_64                             2/2 
>Installed products updated.
>
  Verifying  : fence-agents-3.1.5-15.el6.x86_64                             1/2 
>
  Verifying  : libvirt-client-0.9.10-4.el6.x86_64                           2/2 
>
>Installed:
>  fence-agents.x86_64 0:3.1.5-15.el6                                            
>
>Dependency Installed:
>  libvirt-client.x86_64 0:0.9.10-4.el6                                          
>
>Complete!
>
>Mon, 02 Apr 2012 14:48:33 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:33 DEBUG    ['/bin/rpm', '-q', 'fence-agents']
>Mon, 02 Apr 2012 14:48:33 DEBUG    fence-agents-3.1.5-15.el6.x86_64
>
>Mon, 02 Apr 2012 14:48:33 DEBUG    
>Mon, 02 Apr 2012 14:48:33 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='fence-agents' message='fence-agents-3.1.5-15.el6.x86_64 '/>
>Mon, 02 Apr 2012 14:48:33 DEBUG    Installing vdsm 0
>Mon, 02 Apr 2012 14:48:33 DEBUG    ['/usr/bin/yum', '-y', 'install', 'vdsm']
>Mon, 02 Apr 2012 14:48:37 DEBUG    Loaded plugins: product-id, subscription-manager
>Updating certificate-based repositories.
>Setting up Install Process
>Resolving Dependencies
>--> Running transaction check
>---> Package vdsm.x86_64 0:4.9.6-4.5 will be installed
>--> Processing Dependency: libvirt-python >= 0.9.8 for package: vdsm-4.9.6-4.5.x86_64
>--> Processing Dependency: libvirt >= 0.9.8 for package: vdsm-4.9.6-4.5.x86_64
>--> Running transaction check
>---> Package libvirt.x86_64 0:0.9.10-4.el6 will be installed
>---> Package libvirt-python.x86_64 0:0.9.10-4.el6 will be installed
>--> Finished Dependency Resolution
>
>Dependencies Resolved
>
>================================================================================
> Package             Arch        Version            Repository             Size
>================================================================================
>Installing:
> vdsm                x86_64      4.9.6-4.5          rhevm31               614 k
>Installing for dependencies:
> libvirt             x86_64      0.9.10-4.el6       rhel63-rel-eng-2      1.8 M
> libvirt-python      x86_64      0.9.10-4.el6       rhel63-rel-eng-2      376 k
>
>Transaction Summary
>================================================================================
>Install       3 Package(s)
>
>Total download size: 2.8 M
>Installed size: 8.3 M
>Downloading Packages:
>--------------------------------------------------------------------------------
>Total                                           5.1 MB/s | 2.8 MB     00:00     
>Running rpm_check_debug
>Running Transaction Test
>Transaction Test Succeeded
>Running Transaction
>
  Installing : libvirt-0.9.10-4.el6.x86_64                                  1/3 
>
  Installing : libvirt-python-0.9.10-4.el6.x86_64                           2/3 
>
  Installing : vdsm-4.9.6-4.5.x86_64                                        3/3 
>Installed products updated.
>
  Verifying  : libvirt-python-0.9.10-4.el6.x86_64                           1/3 
>
  Verifying  : libvirt-0.9.10-4.el6.x86_64                                  2/3 
>
  Verifying  : vdsm-4.9.6-4.5.x86_64                                        3/3 
>
>Installed:
>  vdsm.x86_64 0:4.9.6-4.5                                                       
>
>Dependency Installed:
>  libvirt.x86_64 0:0.9.10-4.el6       libvirt-python.x86_64 0:0.9.10-4.el6      
>
>Complete!
>
>Mon, 02 Apr 2012 14:48:37 DEBUG    Unable to read consumer identity
>
>Mon, 02 Apr 2012 14:48:37 DEBUG    ['/bin/rpm', '-q', 'vdsm']
>Mon, 02 Apr 2012 14:48:37 DEBUG    vdsm-4.9.6-4.5.x86_64
>
>Mon, 02 Apr 2012 14:48:37 DEBUG    
>Mon, 02 Apr 2012 14:48:37 DEBUG    <BSTRAP component='VDS PACKAGES' status='OK' result='vdsm' message='vdsm-4.9.6-4.5.x86_64 '/>
>Mon, 02 Apr 2012 14:48:37 DEBUG    makeConfig: generating conf.
>Mon, 02 Apr 2012 14:48:37 DEBUG    makeConfig: writing the following to /etc/vdsm/vdsm.conf
>Mon, 02 Apr 2012 14:48:37 DEBUG    ['# Auto-generated by vds_bootstrap at:2012-04-02 14:48:37.433346\n', '\n', '[vars]\n', 'trust_store_path = /etc/pki/vdsm\n', 'ssl = true\n', '\n', '[addresses]\n', 'management_port = 54321\n']
>Mon, 02 Apr 2012 14:48:37 DEBUG    <BSTRAP component='CreateConf' status='OK' message='Basic configuration set'/>
>Mon, 02 Apr 2012 14:48:37 DEBUG    <BSTRAP component='CheckLocalHostname' status='OK' message='Local hostname is correct.'/>
>Mon, 02 Apr 2012 14:48:37 DEBUG    Bridge rhevm already exists.
>Mon, 02 Apr 2012 14:48:37 DEBUG    Bridge management already exists. Skipping bridge creation.
>Mon, 02 Apr 2012 14:48:37 DEBUG    <BSTRAP component='SetNetworking' status='OK' message='Bridge management already exists. Skipping bridge creation.'/>
>Mon, 02 Apr 2012 14:48:37 DEBUG    getAddress Entry. url=http://jl-rhevm31.rhev.lab.eng.brq.redhat.com:8080/Components/vds/
>Mon, 02 Apr 2012 14:48:37 DEBUG    getAddress return. address=jl-rhevm31.rhev.lab.eng.brq.redhat.com port=8080
>Mon, 02 Apr 2012 14:48:37 DEBUG    getRemoteFile start. IP = jl-rhevm31.rhev.lab.eng.brq.redhat.com port = 8080 fileName = "/engine.ssh.key.txt"
>Mon, 02 Apr 2012 14:49:07 DEBUG    /engine.ssh.key.txt failed in HTTPS. Retrying using HTTP.
>Traceback (most recent call last):
>  File "/tmp/deployUtil.py", line 1369, in getRemoteFile
>    conn.sock = getSSLSocket(sock, certPath)
>  File "/tmp/deployUtil.py", line 1213, in getSSLSocket
>    cert_reqs=ssl.CERT_REQUIRED)
>  File "/usr/lib64/python2.6/ssl.py", line 338, in wrap_socket
>    suppress_ragged_eofs=suppress_ragged_eofs)
>  File "/usr/lib64/python2.6/ssl.py", line 120, in __init__
>    self.do_handshake()
>  File "/usr/lib64/python2.6/ssl.py", line 279, in do_handshake
>    self._sslobj.do_handshake()
>SSLError: _ssl.c:475: The handshake operation timed out
>Mon, 02 Apr 2012 14:49:07 DEBUG    getRemoteFile end.
>Mon, 02 Apr 2012 14:49:07 DEBUG    handleSSHKey start
>Mon, 02 Apr 2012 14:49:07 DEBUG    handleSSHKey end
>Mon, 02 Apr 2012 14:49:07 DEBUG    <BSTRAP component='SetSSHAccess' status='OK' message='SUCCESS'/>
>Mon, 02 Apr 2012 14:49:07 DEBUG    <BSTRAP component='Firewall' status='OK' message='overridden firewall successfully'/>
>Mon, 02 Apr 2012 14:49:07 DEBUG    setHostTime start.
>Mon, 02 Apr 2012 14:49:07 DEBUG    ['/usr/sbin/hwclock', '--set', '--utc', '--date=2012-04-02 12:49:10 UTC']
>Mon, 02 Apr 2012 14:49:09 DEBUG    
>Mon, 02 Apr 2012 14:49:09 DEBUG    
>Mon, 02 Apr 2012 14:49:09 DEBUG    ['/usr/sbin/hwclock', '-s']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    setHostTime end. Return:True
>Mon, 02 Apr 2012 14:49:12 DEBUG    <BSTRAP component='SET_SYSTEM_TIME' status='OK' message='setSystemTime ended successfully'/>
>Mon, 02 Apr 2012 14:49:12 DEBUG    chkConfig: ignoring uninstalled service: cpuspeed
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/service', 'libvirt-guests', 'stop']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Can't connect to default. Skipping.
>
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', 'libvirt-guests', 'off']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', '--level', '345', 'iscsid', 'on']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', '--level', '345', 'multipathd', 'on']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', '--level', '345', 'ntpd', 'on']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', '--level', '345', 'libvirtd', 'on']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/sbin/chkconfig', '--level', '345', 'iptables', 'on']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    <BSTRAP component='VerifyServices' status='OK' message='Needed services set'/>
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/usr/bin/openssl', 'genrsa', '-out', '/etc/pki/vdsm/keys/vdsmkey.pem', '1024']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    Generating RSA private key, 1024 bit long modulus
>................++++++
>.................++++++
>e is 65537 (0x10001)
>
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/usr/bin/openssl', 'req', '-new', '-key', '/etc/pki/vdsm/keys/vdsmkey.pem', '-config', '/tmp/req_6849af36-6803-4a58-a2ac-13504581e7e1.conf', '-out', '/tmp/cert_6849af36-6803-4a58-a2ac-13504581e7e1.req']
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    
>Mon, 02 Apr 2012 14:49:12 DEBUG    ['/usr/bin/openssl', 'dhparam', '-out', '/etc/pki/vdsm/keys/dh.pem', '1024']
>Mon, 02 Apr 2012 14:49:13 DEBUG    
>Mon, 02 Apr 2012 14:49:13 DEBUG    Generating DH parameters, 1024 bit long safe prime, generator 2
>This is going to take a long time
>...........+....................................................+...............................................................................................................+.........................................................................+................................++*++*++*
>
>Mon, 02 Apr 2012 14:49:13 DEBUG    <BSTRAP component='Encryption setup' status='OK' message='Ended successfully'/>
>Mon, 02 Apr 2012 14:49:13 DEBUG    <BSTRAP component='RHEV_INSTALL' status='OK'/>
>Mon, 02 Apr 2012 14:49:13 DEBUG    **** End VDS Validation ****

Actions: View

Attachments on bug 809094: 574503