1. [root@ovirt host-deploy]# tail -n 1000 ovirt-host-deploy-20160412163333-node2.otv.loc-7302438e.log
  2. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: processor : 12
  3. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: vendor_id : GenuineIntel
  4. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu family : 6
  5. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model : 44
  6. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model name : Intel(R) Xeon(R) CPU E5620 @ 2.40GHz
  7. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: stepping : 2
  8. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: microcode : 0x14
  9. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu MHz : 1600.000
  10. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache size : 12288 KB
  11. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: physical id : 1
  12. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: siblings : 8
  13. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: core id : 0
  14. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu cores : 4
  15. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: apicid : 33
  16. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: initial apicid : 33
  17. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu : yes
  18. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu_exception : yes
  19. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpuid level : 11
  20. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: wp : yes
  21. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni pclmulqdq dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm pcid dca sse4_1 sse4_2 popcnt aes lahf_lm ida arat epb dtherm tpr_shadow vnmi flexpriority ept vpid
  22. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: bogomips : 4799.90
  23. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: clflush size : 64
  24. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache_alignment : 64
  25. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: address sizes : 40 bits physical, 48 bits virtual
  26. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: power management:
  27. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo:
  28. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: processor : 13
  29. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: vendor_id : GenuineIntel
  30. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu family : 6
  31. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model : 44
  32. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model name : Intel(R) Xeon(R) CPU E5620 @ 2.40GHz
  33. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: stepping : 2
  34. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: microcode : 0x14
  35. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu MHz : 2000.000
  36. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache size : 12288 KB
  37. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: physical id : 1
  38. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: siblings : 8
  39. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: core id : 1
  40. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu cores : 4
  41. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: apicid : 35
  42. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: initial apicid : 35
  43. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu : yes
  44. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu_exception : yes
  45. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpuid level : 11
  46. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: wp : yes
  47. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni pclmulqdq dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm pcid dca sse4_1 sse4_2 popcnt aes lahf_lm ida arat epb dtherm tpr_shadow vnmi flexpriority ept vpid
  48. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: bogomips : 4799.90
  49. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: clflush size : 64
  50. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache_alignment : 64
  51. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: address sizes : 40 bits physical, 48 bits virtual
  52. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: power management:
  53. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo:
  54. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: processor : 14
  55. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: vendor_id : GenuineIntel
  56. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu family : 6
  57. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model : 44
  58. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model name : Intel(R) Xeon(R) CPU E5620 @ 2.40GHz
  59. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: stepping : 2
  60. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: microcode : 0x14
  61. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu MHz : 1600.000
  62. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache size : 12288 KB
  63. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: physical id : 1
  64. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: siblings : 8
  65. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: core id : 9
  66. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu cores : 4
  67. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: apicid : 51
  68. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: initial apicid : 51
  69. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu : yes
  70. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu_exception : yes
  71. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpuid level : 11
  72. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: wp : yes
  73. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni pclmulqdq dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm pcid dca sse4_1 sse4_2 popcnt aes lahf_lm ida arat epb dtherm tpr_shadow vnmi flexpriority ept vpid
  74. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: bogomips : 4799.90
  75. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: clflush size : 64
  76. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache_alignment : 64
  77. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: address sizes : 40 bits physical, 48 bits virtual
  78. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: power management:
  79. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo:
  80. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: processor : 15
  81. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: vendor_id : GenuineIntel
  82. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu family : 6
  83. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model : 44
  84. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: model name : Intel(R) Xeon(R) CPU E5620 @ 2.40GHz
  85. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: stepping : 2
  86. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: microcode : 0x14
  87. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu MHz : 2000.000
  88. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache size : 12288 KB
  89. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: physical id : 1
  90. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: siblings : 8
  91. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: core id : 10
  92. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpu cores : 4
  93. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: apicid : 53
  94. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: initial apicid : 53
  95. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu : yes
  96. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: fpu_exception : yes
  97. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cpuid level : 11
  98. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: wp : yes
  99. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni pclmulqdq dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm pcid dca sse4_1 sse4_2 popcnt aes lahf_lm ida arat epb dtherm tpr_shadow vnmi flexpriority ept vpid
  100. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: bogomips : 4799.90
  101. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: clflush size : 64
  102. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: cache_alignment : 64
  103. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: address sizes : 40 bits physical, 48 bits virtual
  104. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo: power management:
  105. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.getVendor:52 cpuinfo:
  106. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware._prdmsr:125 prdmsr: 7
  107. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware._vmx_enabled_by_bios:140 vmx bios: True
  108. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware._cpuid:88 cpuid: (132802, 2099200, 43967487, 3219913727)
  109. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware._cpu_has_vmx_support:95 vmx support: True
  110. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware._isVirtualizationEnabled:189 virtualization support GenuineIntel (cpu: True, bios: True)
  111. 2016-04-12 16:33:20 DEBUG otopi.ovirt_host_deploy.hardware hardware.detect:201 Hardware supports virtualization
  112. 2016-04-12 16:33:20 INFO otopi.plugins.ovirt_host_deploy.vdsm.hardware hardware._validate_virtualization:74 Hardware supports virtualization
  113. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage validation METHOD otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._validation
  114. 2016-04-12 16:33:20 DEBUG otopi.plugins.ovirt_host_deploy.vdsm.packages packages._validation:85 Found vdsm {'display_name': 'vdsm', 'name': 'vdsm', 'epoch': '0', 'version': '999.9.9', 'release': '1', 'operation': 'installed', 'arch': 'noarch'}
  115. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage validation METHOD otopi.plugins.ovirt_host_deploy.vdsm.software.Plugin._validation
  116. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage validation METHOD otopi.plugins.ovirt_host_deploy.vmconsole.packages.Plugin._validation
  117. 2016-04-12 16:33:20 INFO otopi.context context.runSequence:427 Stage: Transaction setup
  118. 2016-04-12 16:33:20 DEBUG otopi.context context.runSequence:431 STAGE transaction-prepare
  119. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage transaction-prepare METHOD otopi.plugins.otopi.core.transaction.Plugin._main_prepare
  120. 2016-04-12 16:33:20 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/vdsm/vdsm.conf''
  121. 2016-04-12 16:33:20 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/vdsm/vdsm.conf' exists
  122. 2016-04-12 16:33:20 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/vdsm/vdsm.conf'->'/etc/vdsm/vdsm.conf.20160412163320'
  123. 2016-04-12 16:33:20 INFO otopi.context context.runSequence:427 Stage: Misc configuration
  124. 2016-04-12 16:33:20 DEBUG otopi.context context.runSequence:431 STAGE early_misc
  125. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage early_misc METHOD otopi.plugins.otopi.network.firewalld.Plugin._early_misc
  126. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  127. 2016-04-12 16:33:20 INFO otopi.context context.runSequence:427 Stage: Package installation
  128. 2016-04-12 16:33:20 DEBUG otopi.context context.runSequence:431 STAGE packages
  129. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.otopi.network.iptables.Plugin._packages
  130. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_common.vdsm.pki.Plugin._packages
  131. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_common.vmconsole.pki.Plugin._packages
  132. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.gluster.packages.Plugin._packages
  133. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  134. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.kdump.packages.Plugin._packages
  135. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  136. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron.Plugin._packages
  137. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  138. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_linuxbridge.Plugin._packages
  139. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  140. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_openvswitch.Plugin._packages
  141. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:148 condition False
  142. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.tune.tuned.Plugin._packages
  143. 2016-04-12 16:33:20 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._packages
  144. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service vdsmd exists
  145. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'vdsmd.service'), executable='None', cwd='None', env=None
  146. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'vdsmd.service'), rc=0
  147. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'vdsmd.service') stdout:
  148. LoadState=loaded
  150. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'vdsmd.service') stderr:
  153. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service vdsmd
  154. 2016-04-12 16:33:20 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'vdsmd.service'), executable='None', cwd='None', env=None
  155. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'vdsmd.service'), rc=0
  156. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'vdsmd.service') stdout:
  159. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'vdsmd.service') stderr:
  162. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service supervdsmd exists
  163. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'supervdsmd.service'), executable='None', cwd='None', env=None
  164. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'supervdsmd.service'), rc=0
  165. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'supervdsmd.service') stdout:
  166. LoadState=loaded
  168. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'supervdsmd.service') stderr:
  171. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service supervdsmd
  172. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'supervdsmd.service'), executable='None', cwd='None', env=None
  173. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'supervdsmd.service'), rc=0
  174. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'supervdsmd.service') stdout:
  177. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'supervdsmd.service') stderr:
  180. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.vdsmhooks.hooks.Plugin._packages
  181. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.ovirt_host_deploy.vmconsole.packages.Plugin._packages
  182. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.otopi.packagers.dnfpackager.Plugin._packages
  183. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  184. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage packages METHOD otopi.plugins.otopi.packagers.yumpackager.Plugin._packages
  185. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  186. 2016-04-12 16:33:23 INFO otopi.context context.runSequence:427 Stage: Misc configuration
  187. 2016-04-12 16:33:23 DEBUG otopi.context context.runSequence:431 STAGE misc
  188. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.otopi.system.command.Plugin._misc
  189. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.otopi.network.firewalld.Plugin._misc
  190. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  191. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.otopi.network.iptables.Plugin._store_iptables
  192. 2016-04-12 16:33:23 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/sysconfig/iptables''
  193. 2016-04-12 16:33:23 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/sysconfig/iptables' exists
  194. 2016-04-12 16:33:23 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/sysconfig/iptables'->'/etc/sysconfig/iptables.20160412163323'
  195. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.otopi.network.ssh.Plugin._append_key
  196. 2016-04-12 16:33:23 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/root/.ssh/authorized_keys''
  197. 2016-04-12 16:33:23 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/root/.ssh/authorized_keys' exists
  198. 2016-04-12 16:33:23 DEBUG otopi.filetransaction filetransaction.prepare:204 file '/root/.ssh/authorized_keys' already has content
  199. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.otopi.system.clock.Plugin._set_clock
  200. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.executeRaw:828 execute: ('/sbin/ntpq', '-c', 'rv'), executable='None', cwd='None', env=None
  201. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.executeRaw:878 execute-result: ('/sbin/ntpq', '-c', 'rv'), rc=0
  202. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.execute:936 execute-output: ('/sbin/ntpq', '-c', 'rv') stdout:
  205. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.execute:941 execute-output: ('/sbin/ntpq', '-c', 'rv') stderr:
  206. /sbin/ntpq: read: Connection refused
  208. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.executeRaw:828 execute: ('/bin/chronyc', 'waitsync', '1'), executable='None', cwd='None', env=None
  209. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.executeRaw:878 execute-result: ('/bin/chronyc', 'waitsync', '1'), rc=0
  210. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.execute:936 execute-output: ('/bin/chronyc', 'waitsync', '1') stdout:
  211. try: 1, refid: 95.213.132.250, correction: 0.000500882, skew: 0.012
  213. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock plugin.execute:941 execute-output: ('/bin/chronyc', 'waitsync', '1') stderr:
  216. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.system.clock clock._set_clock:100 clock is synchronized
  217. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_common.vmconsole.pki.Plugin._misc
  218. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.gluster.nrpe.Plugin._misc
  219. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  220. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.kdump.packages.Plugin._misc
  221. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  222. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.node.vdsm_reg.Plugin._misc
  223. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  224. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron.Plugin._misc
  225. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  226. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_linuxbridge.Plugin._misc
  227. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  228. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_openvswitch.Plugin._bridge
  229. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  230. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_openvswitch.Plugin._misc
  231. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:148 condition False
  232. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.tune.iosched.Plugin._misc
  233. 2016-04-12 16:33:23 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/udev/rules.d/12-ovirt-iosched.rules''
  234. 2016-04-12 16:33:23 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/udev/rules.d/12-ovirt-iosched.rules' missing
  235. 2016-04-12 16:33:23 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.tune.tuned.Plugin._misc
  236. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 starting service tuned
  237. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'start', 'tuned.service'), executable='None', cwd='None', env=None
  238. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'start', 'tuned.service'), rc=0
  239. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'start', 'tuned.service') stdout:
  242. 2016-04-12 16:33:23 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'start', 'tuned.service') stderr:
  245. 2016-04-12 16:33:23 DEBUG otopi.plugins.ovirt_host_deploy.tune.tuned plugin.executeRaw:828 execute: ('/sbin/tuned-adm', 'profile', 'virtual-host'), executable='None', cwd='None', env=None
  246. 2016-04-12 16:33:24 DEBUG otopi.plugins.ovirt_host_deploy.tune.tuned plugin.executeRaw:878 execute-result: ('/sbin/tuned-adm', 'profile', 'virtual-host'), rc=0
  247. 2016-04-12 16:33:24 DEBUG otopi.plugins.ovirt_host_deploy.tune.tuned plugin.execute:936 execute-output: ('/sbin/tuned-adm', 'profile', 'virtual-host') stdout:
  250. 2016-04-12 16:33:24 DEBUG otopi.plugins.ovirt_host_deploy.tune.tuned plugin.execute:941 execute-output: ('/sbin/tuned-adm', 'profile', 'virtual-host') stderr:
  253. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service tuned startup to True
  254. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'tuned.service'), executable='None', cwd='None', env=None
  255. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'tuned.service'), rc=0
  256. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'tuned.service') stdout:
  257. Id=tuned.service
  259. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'tuned.service') stderr:
  262. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'enable', u'tuned.service'), executable='None', cwd='None', env=None
  263. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'enable', u'tuned.service'), rc=0
  264. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'enable', u'tuned.service') stdout:
  267. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'enable', u'tuned.service') stderr:
  270. 2016-04-12 16:33:24 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.vdsm.bridge.Plugin._misc
  271. 2016-04-12 16:33:24 DEBUG otopi.context context._executeMethod:148 condition False
  272. 2016-04-12 16:33:24 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.vdsm.vdsmid.Plugin._store_id
  273. 2016-04-12 16:33:24 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/vdsm/vdsm.id''
  274. 2016-04-12 16:33:24 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/vdsm/vdsm.id' missing
  275. 2016-04-12 16:33:24 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_deploy.vdsmhooks.hooks.Plugin._hooks
  276. 2016-04-12 16:33:24 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_common.vdsm.pki.Plugin._misc
  277. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Setting up PKI
  278. .........................+++
  279. ...............................................................+++
  280. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  281. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  282. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Please issue VDSM certificate based on this certificate request
  283. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  284. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***D:MULTI-STRING VDSM_CERTIFICATE_REQUEST **BOUNDARY**
  285. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND -----BEGIN CERTIFICATE REQUEST-----
  286. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND MIICRDCCASwCADAAMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA+HSY
  287. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND WDgNfknZObPesKWNkKL/swVO6izTiz8PvuD+qGoGdQEKBWOxvOGiiUeobob2QlU8
  288. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND oN2DDUwcpx+FQjNL+vbRetQXk7qkkITzxr8NNcYglnkPf7HqUVlfZaULYhO38CjZ
  289. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND M7sqNL6SJfqMDqwWyIm8Nw4Oc7ImLHdgQSNkFZTXWlQWTjlNEV3d35QC4GNE18jG
  290. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND Vl52uQJTP+QhKYorJIgFrrY1wDKYmM0bEHXKascv9kEdkio6EBEFt2dNR76qE0Kr
  291. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND TFWJokzWaweGvn/cR/Enepk9plGzL1jKVrZ0YGKoar+Uc1bXXUo5FrJ2ORfUKpdD
  292. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND IChKMeM1RNFsUDFAZwIDAQABoAAwDQYJKoZIhvcNAQEFBQADggEBAErUgG7KxIok
  293. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND 3/C7vwaUtajuG+Z3l6R7hmY7W4tG/HEU0rPmSvlVDoG4uzKuxqy1gLf+NlZN8nz5
  294. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND /yxWwim49/99YK2YAfX4fe3KjbPvsBglTWZhwwb9vVyWfo6fWrp76Iie7JrPzBsS
  295. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND aRotjbE2PqErAgwxrHXOztQC/jirFkvc2hUum/ynrCI6CVCr4ZjM5hRVdWsc+Bf0
  296. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND pOziz28ltqeRRo9noW6e5+UurcHj/tKLC9yk9+5py06Z3uZFDaWUgnTS3RCgmqgN
  297. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND GnE3bDa6m0cX96WoKlEZBYv4gRjuSpK8KhoLiBidkpNJF8uUieE3GDay5Mcvi1NI
  298. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND Pb5I4kKGJ6s=
  299. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND -----END CERTIFICATE REQUEST-----
  300. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND **BOUNDARY**
  301. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:MULTI-STRING VDSM_CERTIFICATE_CHAIN **BOUNDARY** --=451b80dc-996f-ABORT-9e4f-2b29ef6d1141=--
  302. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  303. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  304. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Please input VDSM certificate chain that matches certificate request, top is issuer
  305. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  306. 2016-04-12 16:33:24 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### type '**BOUNDARY**' in own line to mark end, '--=451b80dc-996f-ABORT-9e4f-2b29ef6d1141=--' aborts
  307. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE -----BEGIN CERTIFICATE-----
  308. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE MIIDojCCAoqgAwIBAgICEAAwDQYJKoZIhvcNAQEFBQAwPTELMAkGA1UEBhMCVVMxEDAOBgNVBAoT
  309. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE B290di5sb2MxHDAaBgNVBAMTE292aXJ0Lm90di5sb2MuMTI4MDAwHhcNMTYwNDExMTA0NzI0WhcN
  310. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE MjYwNDEwMTA0NzI0WjA9MQswCQYDVQQGEwJVUzEQMA4GA1UEChMHb3R2LmxvYzEcMBoGA1UEAxMT
  311. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE b3ZpcnQub3R2LmxvYy4xMjgwMDCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBALi7Pak8
  312. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE xwDXyH+ZjKsq408FHd/e5/v5gAbDfU3CNgl+BNygK2omMY/VfD8CTzgnn6fXtJ48jtya8pmEyJLs
  313. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Owp51lL3v42fNfDSgoWd+wyKBEaGTllMSt9f8287/lJCbImc/3IbWdP8gN3r4ls7QTOaDC3H7D6X
  314. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE AgYj2ANz8ep3uTKliCRBbXg6dJo/xqyGxQ4aFVncDHYIBlDpxl8dNzZR8vXByaOznv1vKBRgCA7b
  315. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE H8kCMcXFILCH6RSzXOqSAnbB2yy4C5rEydQU4d5vvcR9axfItrQj2VDsRqRy97vV4jxHnbna4MAC
  316. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE aC6SV17TrteWfz2IqlLwk4lQdwFZmuMCAwEAAaOBqzCBqDAdBgNVHQ4EFgQUmxJInyaBGbx83gq+
  317. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE domKbedNtDIwZgYDVR0jBF8wXYAUmxJInyaBGbx83gq+domKbedNtDKhQaQ/MD0xCzAJBgNVBAYT
  318. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE AlVTMRAwDgYDVQQKEwdvdHYubG9jMRwwGgYDVQQDExNvdmlydC5vdHYubG9jLjEyODAwggIQADAP
  319. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE BgNVHRMBAf8EBTADAQH/MA4GA1UdDwEB/wQEAwIBBjANBgkqhkiG9w0BAQUFAAOCAQEAqFTWDkG6
  320. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE NJtpEIZ4HGKwQfEh/YU14OmAVVt/6BxS6Q8XKsgmVJV4vYpTXpwOeIdMublHwzD4m0JFm9l8lzsv
  321. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 87nQLDtNfGiJf1XuuCDBk4P8iW7mQKBhqk3Xfo3RC7cCKuhbekzAovKOS4iBOCYLONaQeDKmujGO
  322. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE RoeChV3gDy5S/YlvhVYH5KxiHv8AR8NRCf7YJIs7gUmvTXleR5Uvft7ocgAC2vE1yCGPIIz6WQx7
  323. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 77Rbrz2e9GRoXiowEraKPCrQheKr/adeBy573CEWY3VRKo1m4cvMnyKvmHEYzc4+09Jc5O/twMrj
  324. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE BUClbokSW0ZBUPC6D1CtjquiOuEKpQ==
  325. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE -----END CERTIFICATE-----
  326. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Certificate:
  327. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Data:
  328. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Version: 3 (0x2)
  329. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Serial Number: 4107 (0x100b)
  330. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Signature Algorithm: sha1WithRSAEncryption
  331. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Issuer: C=US, O=otv.loc, CN=ovirt.otv.loc.12800
  332. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Validity
  333. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Not Before: Apr 11 11:33:24 2016 GMT
  334. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Not After : Apr 11 11:33:25 2021 GMT
  335. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Subject: O=otv.loc, CN=node2.otv.loc
  336. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Subject Public Key Info:
  337. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Public Key Algorithm: rsaEncryption
  338. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Public-Key: (2048 bit)
  339. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Modulus:
  340. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 00:f8:74:98:58:38:0d:7e:49:d9:39:b3:de:b0:a5:
  341. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 8d:90:a2:ff:b3:05:4e:ea:2c:d3:8b:3f:0f:be:e0:
  342. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE fe:a8:6a:06:75:01:0a:05:63:b1:bc:e1:a2:89:47:
  343. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE a8:6e:86:f6:42:55:3c:a0:dd:83:0d:4c:1c:a7:1f:
  344. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 85:42:33:4b:fa:f6:d1:7a:d4:17:93:ba:a4:90:84:
  345. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE f3:c6:bf:0d:35:c6:20:96:79:0f:7f:b1:ea:51:59:
  346. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 5f:65:a5:0b:62:13:b7:f0:28:d9:33:bb:2a:34:be:
  347. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 92:25:fa:8c:0e:ac:16:c8:89:bc:37:0e:0e:73:b2:
  348. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 26:2c:77:60:41:23:64:15:94:d7:5a:54:16:4e:39:
  349. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 4d:11:5d:dd:df:94:02:e0:63:44:d7:c8:c6:56:5e:
  350. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 76:b9:02:53:3f:e4:21:29:8a:2b:24:88:05:ae:b6:
  351. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 35:c0:32:98:98:cd:1b:10:75:ca:6a:c7:2f:f6:41:
  352. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 1d:92:2a:3a:10:11:05:b7:67:4d:47:be:aa:13:42:
  353. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE ab:4c:55:89:a2:4c:d6:6b:07:86:be:7f:dc:47:f1:
  354. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 27:7a:99:3d:a6:51:b3:2f:58:ca:56:b6:74:60:62:
  355. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE a8:6a:bf:94:73:56:d7:5d:4a:39:16:b2:76:39:17:
  356. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE d4:2a:97:43:20:28:4a:31:e3:35:44:d1:6c:50:31:
  357. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 40:67
  358. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Exponent: 65537 (0x10001)
  359. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 extensions:
  360. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 Subject Key Identifier:
  361. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE F5:48:6D:FC:FC:3E:E9:3F:98:7C:7D:07:B8:BF:0B:17:4F:5D:32:43
  362. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Authority Information Access:
  363. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE CA Issuers - URI:http://ovirt.otv.loc:80/ovirt-engine/services/pki-resource?resource=ca-certificate&format=X509-PEM-CA
  364. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 Authority Key Identifier:
  365. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE keyid:9B:12:48:9F:26:81:19:BC:7C:DE:0A:BE:76:89:8A:6D:E7:4D:B4:32
  366. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE DirName:/C=US/O=otv.loc/CN=ovirt.otv.loc.12800
  367. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE serial:10:00
  368. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 Basic Constraints:
  369. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE CA:FALSE
  370. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 Key Usage: critical
  371. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Digital Signature, Key Encipherment
  372. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE X509v3 Extended Key Usage: critical
  373. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE TLS Web Server Authentication, TLS Web Client Authentication
  374. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE Signature Algorithm: sha1WithRSAEncryption
  375. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 26:12:fe:6a:b3:9d:8e:fd:67:cf:3f:90:e8:af:ae:4f:ba:6a:
  376. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE c0:c6:40:0f:61:7a:e4:0f:2a:49:2f:5d:cd:f3:8c:b4:03:ae:
  377. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 5a:4e:90:c4:38:10:cf:6f:ee:20:60:92:48:34:96:32:93:5f:
  378. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 81:01:d6:b7:a0:9d:09:71:f0:f7:d9:58:8a:65:f1:6f:36:28:
  379. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE f9:1d:b4:c2:8d:d4:1e:c3:91:6f:85:2d:05:d6:5b:4b:d3:da:
  380. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 17:30:6b:be:bd:03:91:b5:2c:6f:56:55:b4:4e:87:6e:7e:46:
  381. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 13:96:73:92:74:5f:67:8a:d4:72:55:5e:83:d2:bc:05:23:5f:
  382. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 45:68:a6:1a:3f:ab:71:65:df:2b:7c:8a:9f:8f:21:1e:61:19:
  383. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 3b:9c:35:20:d6:bb:0c:bd:4f:83:6a:de:8b:4f:84:88:ba:8a:
  384. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 9e:43:7f:66:8a:97:55:15:5d:03:2e:e2:b4:1a:4f:75:f2:0b:
  385. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 23:ae:c9:e8:4b:39:1a:6a:71:cb:89:7a:f5:6e:33:0c:fa:1c:
  386. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 32:ba:1a:9b:1d:f8:41:fd:8b:a2:25:bc:4b:ea:ee:5a:35:07:
  387. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 9d:8e:3e:73:0d:ab:d9:17:c7:db:09:30:09:9c:2e:9a:8c:b8:
  388. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 32:9a:51:cf:17:a2:aa:bb:6f:de:01:44:d4:5b:f3:b0:71:0c:
  389. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE 0e:65:82:01
  390. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE -----BEGIN CERTIFICATE-----
  391. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE MIIEMTCCAxmgAwIBAgICEAswDQYJKoZIhvcNAQEFBQAwPTELMAkGA1UEBhMCVVMx
  392. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE EDAOBgNVBAoTB290di5sb2MxHDAaBgNVBAMTE292aXJ0Lm90di5sb2MuMTI4MDAw
  393. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE HhcNMTYwNDExMTEzMzI0WhcNMjEwNDExMTEzMzI1WjAqMRAwDgYDVQQKEwdvdHYu
  394. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE bG9jMRYwFAYDVQQDEw1ub2RlMi5vdHYubG9jMIIBIjANBgkqhkiG9w0BAQEFAAOC
  395. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE AQ8AMIIBCgKCAQEA+HSYWDgNfknZObPesKWNkKL/swVO6izTiz8PvuD+qGoGdQEK
  396. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE BWOxvOGiiUeobob2QlU8oN2DDUwcpx+FQjNL+vbRetQXk7qkkITzxr8NNcYglnkP
  397. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE f7HqUVlfZaULYhO38CjZM7sqNL6SJfqMDqwWyIm8Nw4Oc7ImLHdgQSNkFZTXWlQW
  398. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE TjlNEV3d35QC4GNE18jGVl52uQJTP+QhKYorJIgFrrY1wDKYmM0bEHXKascv9kEd
  399. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE kio6EBEFt2dNR76qE0KrTFWJokzWaweGvn/cR/Enepk9plGzL1jKVrZ0YGKoar+U
  400. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE c1bXXUo5FrJ2ORfUKpdDIChKMeM1RNFsUDFAZwIDAQABo4IBTDCCAUgwHQYDVR0O
  401. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE BBYEFPVIbfz8Puk/mHx9B7i/CxdPXTJDMIGBBggrBgEFBQcBAQR1MHMwcQYIKwYB
  402. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE BQUHMAKGZWh0dHA6Ly9vdmlydC5vdHYubG9jOjgwL292aXJ0LWVuZ2luZS9zZXJ2
  403. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE aWNlcy9wa2ktcmVzb3VyY2U/cmVzb3VyY2U9Y2EtY2VydGlmaWNhdGUmZm9ybWF0
  404. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE PVg1MDktUEVNLUNBMGYGA1UdIwRfMF2AFJsSSJ8mgRm8fN4KvnaJim3nTbQyoUGk
  405. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE PzA9MQswCQYDVQQGEwJVUzEQMA4GA1UEChMHb3R2LmxvYzEcMBoGA1UEAxMTb3Zp
  406. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE cnQub3R2LmxvYy4xMjgwMIICEAAwCQYDVR0TBAIwADAOBgNVHQ8BAf8EBAMCBaAw
  407. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE IAYDVR0lAQH/BBYwFAYIKwYBBQUHAwEGCCsGAQUFBwMCMA0GCSqGSIb3DQEBBQUA
  408. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE A4IBAQAmEv5qs52O/WfPP5Dor65PumrAxkAPYXrkDypJL13N84y0A65aTpDEOBDP
  409. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE b+4gYJJINJYyk1+BAda3oJ0JcfD32ViKZfFvNij5HbTCjdQew5FvhS0F1ltL09oX
  410. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE MGu+vQORtSxvVlW0TodufkYTlnOSdF9nitRyVV6D0rwFI19FaKYaP6txZd8rfIqf
  411. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE jyEeYRk7nDUg1rsMvU+Dat6LT4SIuoqeQ39mipdVFV0DLuK0Gk918gsjrsnoSzka
  412. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE anHLiXr1bjMM+hwyuhqbHfhB/YuiJbxL6u5aNQedjj5zDavZF8fbCTAJnC6ajLgy
  413. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE mlHPF6Kqu2/eAUTUW/OwcQwOZYIB
  414. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE -----END CERTIFICATE-----
  415. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE **BOUNDARY**
  416. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/certs/cacert.pem''
  417. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/certs/cacert.pem' exists
  418. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/certs/cacert.pem'->'/etc/pki/vdsm/certs/cacert.pem.20160412163325'
  419. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/libvirt-spice/ca-cert.pem''
  420. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/libvirt-spice/ca-cert.pem' exists
  421. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/libvirt-spice/ca-cert.pem'->'/etc/pki/vdsm/libvirt-spice/ca-cert.pem.20160412163325'
  422. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/libvirt/../CA/cacert.pem''
  423. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/libvirt/../CA/cacert.pem' missing
  424. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/certs/vdsmcert.pem''
  425. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/certs/vdsmcert.pem' exists
  426. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/certs/vdsmcert.pem'->'/etc/pki/vdsm/certs/vdsmcert.pem.20160412163325'
  427. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/libvirt-spice/server-cert.pem''
  428. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/libvirt-spice/server-cert.pem' exists
  429. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/libvirt-spice/server-cert.pem'->'/etc/pki/vdsm/libvirt-spice/server-cert.pem.20160412163325'
  430. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/libvirt/clientcert.pem''
  431. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/libvirt/clientcert.pem' missing
  432. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/keys/vdsmkey.pem''
  433. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/keys/vdsmkey.pem' exists
  434. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/keys/vdsmkey.pem'->'/etc/pki/vdsm/keys/vdsmkey.pem.20160412163325'
  435. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/vdsm/libvirt-spice/server-key.pem''
  436. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:200 file '/etc/pki/vdsm/libvirt-spice/server-key.pem' exists
  437. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:234 backup '/etc/pki/vdsm/libvirt-spice/server-key.pem'->'/etc/pki/vdsm/libvirt-spice/server-key.pem.20160412163325'
  438. 2016-04-12 16:33:25 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/libvirt/private/clientkey.pem''
  439. 2016-04-12 16:33:25 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/libvirt/private/clientkey.pem' missing
  440. 2016-04-12 16:33:25 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_host_common.vmconsole.pki.Plugin._miscLate
  441. 2016-04-12 16:33:25 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Setting up Serial Console PKI
  442. ....+++
  443. ...............................+++
  444. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  445. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  446. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Please issue serial console certificate based on this certificate request
  447. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  448. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***D:MULTI-STRING VMCONSOLE_CERTIFICATE_REQUEST **BOUNDARY**
  449. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND -----BEGIN CERTIFICATE REQUEST-----
  450. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND MIICRDCCASwCADAAMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAudpI
  451. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND RSX0TxI+n/eXKRnHBnmR1XTo0BBsP2m86YRE4LVgcId/FEzF6T98NWlMOcFnLbuq
  452. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND JplAvixOXhHambikgHe5g6Q11gSEa7kwL/SPUf6nDwl8hAU/KoGWQ0BV0V5MmGId
  453. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND K3SaQn0zZXIpIzKI7gkPqihbjf73BDwwWxpgMGmy3EswIxII8xicF6fstmn65CR6
  454. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND yk/swAIwU3OaQR7DM1joHgHQyYsuOz2kSJIBWGS2cFeBpMZnoTCsE4L2jz9PwTtV
  455. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND DaTJrE2rBUuGMuOoh+AKwtTcURyp16TM9FV6Ciyh/8G7FN2z00+Ho7BcByMaQRvv
  456. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND HzsaJGZrRPVUd1hK2QIDAQABoAAwDQYJKoZIhvcNAQEFBQADggEBAIVJU5oIH6C+
  457. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND 3sMhne4H7DS6FhT/2ivhYhXALus4NAqXmD7rAiQ1i0rcMz0SPz6sHWg7Tc+OPVNR
  458. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND mDPuT6I6h3k40t9E0k9gb08k89Ltu1Gu27CFtu252kkr1z5bdhWy9VceiZOl/oU8
  459. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND o367SqxtdwWliPExZN1vnNWang/ZpOYV0lwSRY5/TeVlfvRUyZwRca4syshUJ64l
  460. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND RKrSxecirYsctdeK//j67dFDy+KONQj9nP+uX6tz9ktiBwitYfiCHUWw1AoCAco4
  461. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND yZMsG7qsr9aRa7ciy280PNH7AlUDboiIMqmBFAq9h5MAPxRgmtn8jo/CxRZ70xYJ
  462. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND /Jb6i0gmj/Q=
  463. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND -----END CERTIFICATE REQUEST-----
  464. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND **BOUNDARY**
  465. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:VALUE VMCONSOLE_CERTIFICATE
  466. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  467. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  468. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Please input serial console certificate chain that matches certificate request, top is issuer
  469. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  470. 2016-04-12 16:33:26 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Response is VALUE VMCONSOLE_CERTIFICATE=type:value or ABORT VMCONSOLE_CERTIFICATE
  471. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE VALUE VMCONSOLE_CERTIFICATE=str:[email protected] AAAAHHNzaC1yc2EtY2VydC12MDFAb3BlbnNzaC5jb20AAAAgCrebr12pjWIpSb0Qp8ah1X5/BWgnOyInVBlJ3D4TIpoAAAADAQABAAABAQC52khFJfRPEj6f95cpGccGeZHVdOjQEGw/abzphETgtWBwh38UTMXpP3w1aUw5wWctu6ommUC+LE5eEdqZuKSAd7mDpDXWBIRruTAv9I9R/qcPCXyEBT8qgZZDQFXRXkyYYh0rdJpCfTNlcikjMojuCQ+qKFuN/vcEPDBbGmAwabLcSzAjEgjzGJwXp+y2afrkJHrKT+zAAjBTc5pBHsMzWOgeAdDJiy47PaRIkgFYZLZwV4GkxmehMKwTgvaPP0/BO1UNpMmsTasFS4Yy46iH4ArC1NxRHKnXpMz0VXoKLKH/wbsU3bPTT4ejsFwHIxpBG+8fOxokZmtE9VR3WErZAAAAAAAAAAAAAAACAAAADW5vZGUyLm90di5sb2MAAAARAAAADW5vZGUyLm90di5sb2MAAAAAVwzO9wAAAABgct6HAAAAAAAAAAAAAAAAAAABFwAAAAdzc2gtcnNhAAAAAwEAAQAAAQEAuLs9qTzHANfIf5mMqyrjTwUd397n+/mABsN9TcI2CX4E3KAraiYxj9V8PwJPOCefp9e0njyO3JrymYTIkuw7CnnWUve/jZ818NKChZ37DIoERoZOWUxK31/zbzv+UkJsiZz/chtZ0/yA3eviWztBM5oMLcfsPpcCBiPYA3Px6ne5MqWIJEFteDp0mj/GrIbFDhoVWdwMdggGUOnGXx03NlHy9cHJo7Oe/W8oFGAIDtsfyQIxxcUgsIfpFLNc6pICdsHbLLgLmsTJ1BTh3m+9xH1rF8i2tCPZUOxGpHL3u9XiPEedudrgwAJoLpJXXtOu15Z/PYiqUvCTiVB3AVma4wAAAQ8AAAAHc3NoLXJzYQAAAQCqp3nAA5WoeueDru6yu2UmBl1dncfnPdAlJ8GlZz+05oLe6bh8mdC3TXuWdq7aMtLLM34mt3ezuQpXWNdOVlIwfPc8s6ZlyuUYhY6faZfL2DmYYwVz1QfK2oZSGmYTc9Y3LFtu6t7bO8yAOGUkV25dihUiqBEnWf3R3ZGuyaxPSeLS7tTSpD3W2xR1zorykclx7MUMyQ/2toCnZCwk7z0nIOLJPYjbMFjbyVRh3LfdufOH2xlhTXjyWvTCd3TZwKMN4EpjxJum6r0WDA1L6H7VKloUbHvJ2ldqcHFMGPwDlROmjEJHVZm2sS5/BmtSgFnDZwEEN/tp3xcBXUGBHpcL /etc/pki/ovirt-engine/certs/node2.otv.loc-ssh.pub
  472. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/ovirt-vmconsole/ca.pub''
  473. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/ovirt-vmconsole/ca.pub' missing
  474. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub''
  475. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub' missing
  476. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction._prepare:76 preparing 'File transaction for '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa''
  477. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.prepare:198 file '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa' missing
  478. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN
  479. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/certificate=str:'[email protected] AAAAHHNzaC1yc2EtY2VydC12MDFAb3BlbnNzaC5jb20AAAAgCrebr12pjWIpSb0Qp8ah1X5/BWgnOyInVBlJ3D4TIpoAAAADAQABAAABAQC52khFJfRPEj6f95cpGccGeZHVdOjQEGw/abzphETgtWBwh38UTMXpP3w1aUw5wWctu6ommUC+LE5eEdqZuKSAd7mDpDXWBIRruTAv9I9R/qcPCXyEBT8qgZZDQFXRXkyYYh0rdJpCfTNlcikjMojuCQ+qKFuN/vcEPDBbGmAwabLcSzAjEgjzGJwXp+y2afrkJHrKT+zAAjBTc5pBHsMzWOgeAdDJiy47PaRIkgFYZLZwV4GkxmehMKwTgvaPP0/BO1UNpMmsTasFS4Yy46iH4ArC1NxRHKnXpMz0VXoKLKH/wbsU3bPTT4ejsFwHIxpBG+8fOxokZmtE9VR3WErZAAAAAAAAAAAAAAACAAAADW5vZGUyLm90di5sb2MAAAARAAAADW5vZGUyLm90di5sb2MAAAAAVwzO9wAAAABgct6HAAAAAAAAAAAAAAAAAAABFwAAAAdzc2gtcnNhAAAAAwEAAQAAAQEAuLs9qTzHANfIf5mMqyrjTwUd397n+/mABsN9TcI2CX4E3KAraiYxj9V8PwJPOCefp9e0njyO3JrymYTIkuw7CnnWUve/jZ818NKChZ37DIoERoZOWUxK31/zbzv+UkJsiZz/chtZ0/yA3eviWztBM5oMLcfsPpcCBiPYA3Px6ne5MqWIJEFteDp0mj/GrIbFDhoVWdwMdggGUOnGXx03NlHy9cHJo7Oe/W8oFGAIDtsfyQIxxcUgsIfpFLNc6pICdsHbLLgLmsTJ1BTh3m+9xH1rF8i2tCPZUOxGpHL3u9XiPEedudrgwAJoLpJXXtOu15Z/PYiqUvCTiVB3AVma4wAAAQ8AAAAHc3NoLXJzYQAAAQCqp3nAA5WoeueDru6yu2UmBl1dncfnPdAlJ8GlZz+05oLe6bh8mdC3TXuWdq7aMtLLM34mt3ezuQpXWNdOVlIwfPc8s6ZlyuUYhY6faZfL2DmYYwVz1QfK2oZSGmYTc9Y3LFtu6t7bO8yAOGUkV25dihUiqBEnWf3R3ZGuyaxPSeLS7tTSpD3W2xR1zorykclx7MUMyQ/2toCnZCwk7z0nIOLJPYjbMFjbyVRh3LfdufOH2xlhTXjyWvTCd3TZwKMN4EpjxJum6r0WDA1L6H7VKloUbHvJ2ldqcHFMGPwDlROmjEJHVZm2sS5/BmtSgFnDZwEEN/tp3xcBXUGBHpcL /etc/pki/ovirt-engine/certs/node2.otv.loc-ssh.pub'
  480. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:514 ENVIRONMENT DUMP - END
  481. 2016-04-12 16:33:28 INFO otopi.context context.runSequence:427 Stage: Transaction commit
  482. 2016-04-12 16:33:28 DEBUG otopi.context context.runSequence:431 STAGE cleanup
  483. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage cleanup METHOD otopi.plugins.otopi.core.transaction.Plugin._main_end
  484. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa''
  485. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/ovirt-vmconsole/host-ssh_host_rsa
  486. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  487. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub''
  488. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub
  489. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  490. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/ovirt-vmconsole/ca.pub''
  491. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/ovirt-vmconsole/ca.pub
  492. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  493. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/libvirt/private/clientkey.pem''
  494. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/libvirt/private
  495. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  496. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/libvirt-spice/server-key.pem''
  497. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/libvirt-spice/server-key.pem
  498. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  499. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/keys/vdsmkey.pem''
  500. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/keys/vdsmkey.pem
  501. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  502. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/libvirt/clientcert.pem''
  503. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/libvirt/clientcert.pem
  504. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  505. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/libvirt-spice/server-cert.pem''
  506. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/libvirt-spice/server-cert.pem
  507. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  508. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/certs/vdsmcert.pem''
  509. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/certs/vdsmcert.pem
  510. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  511. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/libvirt/../CA/cacert.pem''
  512. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/libvirt
  513. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  514. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/libvirt-spice/ca-cert.pem''
  515. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/libvirt-spice/ca-cert.pem
  516. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  517. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/pki/vdsm/certs/cacert.pem''
  518. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/pki/vdsm/certs/cacert.pem
  519. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  520. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/vdsm/vdsm.id''
  521. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/vdsm/vdsm.id
  522. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  523. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/udev/rules.d/12-ovirt-iosched.rules''
  524. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/udev/rules.d/12-ovirt-iosched.rules
  525. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  526. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/root/.ssh/authorized_keys''
  527. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/sysconfig/iptables''
  528. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/sysconfig/iptables
  529. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  530. 2016-04-12 16:33:28 DEBUG otopi.transaction transaction.commit:162 committing 'File transaction for '/etc/vdsm/vdsm.conf''
  531. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:331 Executing restorecon for /etc/vdsm/vdsm.conf
  532. 2016-04-12 16:33:28 DEBUG otopi.filetransaction filetransaction.commit:345 restorecon result rc=0, stdout=, stderr=
  533. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN
  534. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/modifiedFiles=list:'['/etc/pki/ovirt-vmconsole/host-ssh_host_rsa', '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub', '/etc/pki/ovirt-vmconsole/ca.pub', '/etc/pki/libvirt/private/clientkey.pem', '/etc/pki/vdsm/libvirt-spice/server-key.pem', '/etc/pki/vdsm/keys/vdsmkey.pem', '/etc/pki/libvirt/clientcert.pem', '/etc/pki/vdsm/libvirt-spice/server-cert.pem', '/etc/pki/vdsm/certs/vdsmcert.pem', '/etc/pki/libvirt/../CA/cacert.pem', '/etc/pki/vdsm/libvirt-spice/ca-cert.pem', '/etc/pki/vdsm/certs/cacert.pem', '/etc/vdsm/vdsm.id', '/etc/udev/rules.d/12-ovirt-iosched.rules', '/etc/sysconfig/iptables', '/etc/vdsm/vdsm.conf']'
  535. 2016-04-12 16:33:28 DEBUG otopi.context context.dumpEnvironment:514 ENVIRONMENT DUMP - END
  536. 2016-04-12 16:33:28 INFO otopi.context context.runSequence:427 Stage: Closing up
  537. 2016-04-12 16:33:28 DEBUG otopi.context context.runSequence:431 STAGE closeup
  538. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.otopi.network.firewalld.Plugin._closeup
  539. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  540. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.otopi.network.iptables.Plugin._closeup
  541. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service firewalld exists
  542. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'firewalld.service'), executable='None', cwd='None', env=None
  543. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'firewalld.service'), rc=0
  544. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'firewalld.service') stdout:
  545. LoadState=not-found
  547. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'firewalld.service') stderr:
  550. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service iptables startup to True
  551. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'iptables.service'), executable='None', cwd='None', env=None
  552. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'iptables.service'), rc=0
  553. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'iptables.service') stdout:
  554. Id=iptables.service
  556. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'iptables.service') stderr:
  559. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'enable', u'iptables.service'), executable='None', cwd='None', env=None
  560. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'enable', u'iptables.service'), rc=0
  561. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'enable', u'iptables.service') stdout:
  564. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'enable', u'iptables.service') stderr:
  567. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service iptables
  568. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'iptables.service'), executable='None', cwd='None', env=None
  569. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'iptables.service'), rc=0
  570. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'iptables.service') stdout:
  573. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'iptables.service') stderr:
  576. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 starting service iptables
  577. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'start', 'iptables.service'), executable='None', cwd='None', env=None
  578. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'start', 'iptables.service'), rc=0
  579. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'start', 'iptables.service') stdout:
  582. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'start', 'iptables.service') stderr:
  585. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_common.vdsm.pki.Plugin._closeup
  586. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_common.vmconsole.pki.Plugin._closeup
  587. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.core.misc.Plugin._closeup
  588. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  589. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.gluster.glusterpmd.Plugin._closeup
  590. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  591. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.gluster.nrpe.Plugin._closeup
  592. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service nrpe exists
  593. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'nrpe.service'), executable='None', cwd='None', env=None
  594. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'nrpe.service'), rc=0
  595. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'nrpe.service') stdout:
  596. LoadState=not-found
  598. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'nrpe.service') stderr:
  601. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.gluster.packages.Plugin._closeup
  602. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  603. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.kdump.packages.Plugin._closeup
  604. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  605. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.node.vdsm_reg.Plugin._closeup
  606. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  607. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_linuxbridge.Plugin._closeup
  608. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  609. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.openstack.neutron_openvswitch.Plugin._closeup
  610. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:148 condition False
  611. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._closeup
  612. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service libvirt-guests exists
  613. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirt-guests.service'), executable='None', cwd='None', env=None
  614. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirt-guests.service'), rc=0
  615. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirt-guests.service') stdout:
  616. LoadState=loaded
  618. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirt-guests.service') stderr:
  621. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service libvirt-guests
  622. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'libvirt-guests.service'), executable='None', cwd='None', env=None
  623. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'libvirt-guests.service'), rc=0
  624. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'libvirt-guests.service') stdout:
  627. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'libvirt-guests.service') stderr:
  630. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service libvirt-guests startup to False
  631. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'libvirt-guests.service'), executable='None', cwd='None', env=None
  632. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'libvirt-guests.service'), rc=0
  633. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'libvirt-guests.service') stdout:
  634. Id=libvirt-guests.service
  636. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'libvirt-guests.service') stderr:
  639. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'disable', u'libvirt-guests.service'), executable='None', cwd='None', env=None
  640. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'disable', u'libvirt-guests.service'), rc=0
  641. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'disable', u'libvirt-guests.service') stdout:
  644. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'disable', u'libvirt-guests.service') stderr:
  647. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service vdsmd startup to True
  648. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'vdsmd.service'), executable='None', cwd='None', env=None
  649. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'vdsmd.service'), rc=0
  650. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'vdsmd.service') stdout:
  651. Id=vdsmd.service
  653. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'vdsmd.service') stderr:
  656. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'enable', u'vdsmd.service'), executable='None', cwd='None', env=None
  657. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'enable', u'vdsmd.service'), rc=0
  658. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'enable', u'vdsmd.service') stdout:
  661. 2016-04-12 16:33:28 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'enable', u'vdsmd.service') stderr:
  664. 2016-04-12 16:33:28 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._reconfigure
  665. 2016-04-12 16:33:28 DEBUG otopi.plugins.ovirt_host_deploy.vdsm.packages plugin.executeRaw:828 execute: ('/bin/vdsm-tool', 'configure', '--force'), executable='None', cwd='None', env=None
  666. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.vdsm.packages plugin.executeRaw:878 execute-result: ('/bin/vdsm-tool', 'configure', '--force'), rc=0
  667. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.vdsm.packages plugin.execute:936 execute-output: ('/bin/vdsm-tool', 'configure', '--force') stdout:
  669. Checking configuration status...
  671. Current revision of multipath.conf detected, preserving
  672. libvirt is already configured for vdsm
  673. SUCCESS: ssl configured to true. No conflicts
  675. Running configure...
  676. Reconfiguration of libvirt is done.
  678. Done configuring modules to VDSM.
  680. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.vdsm.packages plugin.execute:941 execute-output: ('/bin/vdsm-tool', 'configure', '--force') stderr:
  683. 2016-04-12 16:33:30 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.tune.iosched.Plugin._refresh
  684. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.executeRaw:828 execute: ['/bin/udevadm', 'trigger', '--type=devices', '--action=change'], executable='None', cwd='None', env=None
  685. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.executeRaw:878 execute-result: ['/bin/udevadm', 'trigger', '--type=devices', '--action=change'], rc=0
  686. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.execute:936 execute-output: ['/bin/udevadm', 'trigger', '--type=devices', '--action=change'] stdout:
  689. 2016-04-12 16:33:30 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.execute:941 execute-output: ['/bin/udevadm', 'trigger', '--type=devices', '--action=change'] stderr:
  692. 2016-04-12 16:33:30 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._start
  693. 2016-04-12 16:33:30 INFO otopi.plugins.ovirt_host_deploy.vdsm.packages packages._start:178 Stopping libvirtd
  694. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service libvirtd exists
  695. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirtd.service'), executable='None', cwd='None', env=None
  696. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirtd.service'), rc=0
  697. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirtd.service') stdout:
  698. LoadState=loaded
  700. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'libvirtd.service') stderr:
  703. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service libvirtd
  704. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'libvirtd.service'), executable='None', cwd='None', env=None
  705. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'libvirtd.service'), rc=0
  706. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'libvirtd.service') stdout:
  709. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'libvirtd.service') stderr:
  712. 2016-04-12 16:33:30 INFO otopi.plugins.ovirt_host_deploy.vdsm.packages packages._start:182 Starting vdsm
  713. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service NetworkManager exists
  714. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'NetworkManager.service'), executable='None', cwd='None', env=None
  715. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'NetworkManager.service'), rc=0
  716. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'NetworkManager.service') stdout:
  717. LoadState=loaded
  719. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'NetworkManager.service') stderr:
  722. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service NetworkManager
  723. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'NetworkManager.service'), executable='None', cwd='None', env=None
  724. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'NetworkManager.service'), rc=0
  725. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'NetworkManager.service') stdout:
  728. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'NetworkManager.service') stderr:
  731. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service NetworkManager startup to False
  732. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'NetworkManager.service'), executable='None', cwd='None', env=None
  733. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'NetworkManager.service'), rc=0
  734. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'NetworkManager.service') stdout:
  735. Id=NetworkManager.service
  737. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'NetworkManager.service') stderr:
  740. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'disable', u'NetworkManager.service'), executable='None', cwd='None', env=None
  741. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'disable', u'NetworkManager.service'), rc=0
  742. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'disable', u'NetworkManager.service') stdout:
  745. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'disable', u'NetworkManager.service') stderr:
  748. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service network exists
  749. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'network.service'), executable='None', cwd='None', env=None
  750. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'network.service'), rc=0
  751. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'network.service') stdout:
  752. LoadState=loaded
  754. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'network.service') stderr:
  757. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.status:105 check service network status
  758. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'status', 'network.service'), executable='None', cwd='None', env=None
  759. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'status', 'network.service'), rc=0
  760. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'status', 'network.service') stdout:
  761. ● network.service - LSB: Bring up/down networking
  762. Loaded: loaded (/etc/rc.d/init.d/network)
  763. Active: active (exited) since Пн 2016-04-11 21:57:57 YEKT; 18h ago
  764. Docs: man:systemd-sysv-generator(8)
  766. апр 11 21:57:53 node2.otv.loc systemd[1]: Starting LSB: Bring up/down networking...
  767. апр 11 21:57:55 node2.otv.loc network[880]: Активируется интерфейс loopback: [ OK ]
  768. апр 11 21:57:57 node2.otv.loc network[880]: Активируется интерфейс bond0: [ OK ]
  769. апр 11 21:57:57 node2.otv.loc systemd[1]: Started LSB: Bring up/down networking.
  771. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'status', 'network.service') stderr:
  774. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service network startup to True
  775. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'network.service'), executable='None', cwd='None', env=None
  776. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'network.service'), rc=0
  777. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'network.service') stdout:
  778. Id=network.service
  780. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'network.service') stderr:
  783. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'enable', u'network.service'), executable='None', cwd='None', env=None
  784. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'enable', u'network.service'), rc=0
  785. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'enable', u'network.service') stdout:
  788. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'enable', u'network.service') stderr:
  789. network.service is not a native service, redirecting to /sbin/chkconfig.
  790. Executing /sbin/chkconfig network on
  792. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 starting service vdsmd
  793. 2016-04-12 16:33:30 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'start', 'vdsmd.service'), executable='None', cwd='None', env=None
  794. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'start', 'vdsmd.service'), rc=0
  795. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'start', 'vdsmd.service') stdout:
  798. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'start', 'vdsmd.service') stderr:
  801. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.vmconsole.packages.Plugin._start
  802. 2016-04-12 16:33:33 INFO otopi.plugins.ovirt_host_deploy.vmconsole.packages packages._start:93 Starting ovirt-vmconsole-host-sshd
  803. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:88 check if service ovirt-vmconsole-host-sshd exists
  804. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'LoadState', 'ovirt-vmconsole-host-sshd.service'), executable='None', cwd='None', env=None
  805. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'LoadState', 'ovirt-vmconsole-host-sshd.service'), rc=0
  806. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'ovirt-vmconsole-host-sshd.service') stdout:
  807. LoadState=loaded
  809. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'LoadState', 'ovirt-vmconsole-host-sshd.service') stderr:
  812. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 stopping service ovirt-vmconsole-host-sshd
  813. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'stop', 'ovirt-vmconsole-host-sshd.service'), executable='None', cwd='None', env=None
  814. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'stop', 'ovirt-vmconsole-host-sshd.service'), rc=0
  815. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'stop', 'ovirt-vmconsole-host-sshd.service') stdout:
  818. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'stop', 'ovirt-vmconsole-host-sshd.service') stderr:
  821. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd systemd.state:145 starting service ovirt-vmconsole-host-sshd
  822. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'start', 'ovirt-vmconsole-host-sshd.service'), executable='None', cwd='None', env=None
  823. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'start', 'ovirt-vmconsole-host-sshd.service'), rc=0
  824. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'start', 'ovirt-vmconsole-host-sshd.service') stdout:
  827. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'start', 'ovirt-vmconsole-host-sshd.service') stderr:
  830. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:114 set service ovirt-vmconsole-host-sshd startup to True
  831. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'show', '-p', 'Id', 'ovirt-vmconsole-host-sshd.service'), executable='None', cwd='None', env=None
  832. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'show', '-p', 'Id', 'ovirt-vmconsole-host-sshd.service'), rc=0
  833. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'ovirt-vmconsole-host-sshd.service') stdout:
  834. Id=ovirt-vmconsole-host-sshd.service
  836. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'show', '-p', 'Id', 'ovirt-vmconsole-host-sshd.service') stderr:
  839. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:828 execute: ('/bin/systemctl', 'enable', u'ovirt-vmconsole-host-sshd.service'), executable='None', cwd='None', env=None
  840. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:878 execute-result: ('/bin/systemctl', 'enable', u'ovirt-vmconsole-host-sshd.service'), rc=0
  841. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:936 execute-output: ('/bin/systemctl', 'enable', u'ovirt-vmconsole-host-sshd.service') stdout:
  844. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:941 execute-output: ('/bin/systemctl', 'enable', u'ovirt-vmconsole-host-sshd.service') stderr:
  845. Created symlink from /etc/systemd/system/multi-user.target.wants/ovirt-vmconsole-host-sshd.service to /usr/lib/systemd/system/ovirt-vmconsole-host-sshd.service.
  847. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.otopi.system.reboot.Plugin._closeup
  848. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:148 condition False
  849. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:142 Stage closeup METHOD otopi.plugins.ovirt_host_deploy.node.persist.Plugin._closeup
  850. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:148 condition False
  851. 2016-04-12 16:33:33 INFO otopi.context context.runSequence:427 Stage: Pre-termination
  852. 2016-04-12 16:33:33 DEBUG otopi.context context.runSequence:431 STAGE pre-terminate
  853. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:142 Stage pre-terminate METHOD otopi.plugins.otopi.core.misc.Plugin._preTerminate
  854. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN
  855. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/aborted=bool:'False'
  856. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/debug=int:'0'
  857. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/error=bool:'False'
  858. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/exceptionInfo=list:'[]'
  859. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/executionDirectory=str:'/root'
  860. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/exitCode=list:'[{'priority': 90001, 'code': 0}]'
  861. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/log=bool:'True'
  862. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/pluginGroups=str:'otopi:ovirt-host-common:ovirt-host-deploy'
  863. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/pluginPath=str:'/tmp/ovirt-nOWbuMXM8f/otopi-plugins'
  864. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV BASE/suppressEnvironmentKeys=list:'[]'
  865. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/chkconfig=str:'/sbin/chkconfig'
  866. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/chronyc=str:'/bin/chronyc'
  867. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/date=str:'/bin/date'
  868. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/dmidecode=str:'/sbin/dmidecode'
  869. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/firewall-cmd=NoneType:'None'
  870. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/hwclock=str:'/sbin/hwclock'
  871. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/initctl=NoneType:'None'
  872. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/ip=str:'/sbin/ip'
  873. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/nmcli=str:'/bin/nmcli'
  874. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/ntpq=str:'/sbin/ntpq'
  875. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/openssl=str:'/bin/openssl'
  876. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/openstack-config=NoneType:'None'
  877. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/ovs-vsctl=NoneType:'None'
  878. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/rc=NoneType:'None'
  879. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/rc-update=NoneType:'None'
  880. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/reboot=str:'/sbin/reboot'
  881. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/service=str:'/sbin/service'
  882. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/systemctl=str:'/bin/systemctl'
  883. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/tuned-adm=str:'/sbin/tuned-adm'
  884. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/udevadm=str:'/bin/udevadm'
  885. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV COMMAND/vdsm-tool=str:'/bin/vdsm-tool'
  886. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/configFileAppend=NoneType:'None'
  887. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/configFileName=str:'/etc/ovirt-host-deploy.conf'
  888. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/failOnPrioOverride=bool:'False'
  889. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/internalPackageTransaction=Transaction:'transaction'
  890. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logDir=str:'/tmp'
  891. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logFileHandle=file:'<open file '/tmp/ovirt-host-deploy-20160412163318-06sxpy.log', mode 'a' at 0x27c7270>'
  892. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logFileName=str:'/tmp/ovirt-host-deploy-20160412163318-06sxpy.log'
  893. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logFileNamePrefix=str:'ovirt-host-deploy'
  894. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logFilter=_MyLoggerFilter:'filter'
  895. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logFilterKeys=list:'[]'
  896. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/logRemoveAtExit=bool:'False'
  897. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/mainTransaction=Transaction:'transaction'
  898. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/modifiedFiles=list:'['/etc/pki/ovirt-vmconsole/host-ssh_host_rsa', '/etc/pki/ovirt-vmconsole/host-ssh_host_rsa-cert.pub', '/etc/pki/ovirt-vmconsole/ca.pub', '/etc/pki/libvirt/private/clientkey.pem', '/etc/pki/vdsm/libvirt-spice/server-key.pem', '/etc/pki/vdsm/keys/vdsmkey.pem', '/etc/pki/libvirt/clientcert.pem', '/etc/pki/vdsm/libvirt-spice/server-cert.pem', '/etc/pki/vdsm/certs/vdsmcert.pem', '/etc/pki/libvirt/../CA/cacert.pem', '/etc/pki/vdsm/libvirt-spice/ca-cert.pem', '/etc/pki/vdsm/certs/cacert.pem', '/etc/vdsm/vdsm.id', '/etc/udev/rules.d/12-ovirt-iosched.rules', '/etc/sysconfig/iptables', '/etc/vdsm/vdsm.conf']'
  899. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV CORE/randomizeEvents=bool:'False'
  900. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV DIALOG/boundary=str:'**BOUNDARY**'
  901. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV DIALOG/cliVersion=int:'1'
  902. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV DIALOG/customization=bool:'True'
  903. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV DIALOG/dialect=str:'machine'
  904. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV GLUSTER/enable=bool:'False'
  905. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV GLUSTER/monitoringEnable=bool:'False'
  906. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV GLUSTER/monitoringServer=NoneType:'None'
  907. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV INFO/PACKAGE_NAME=str:'otopi'
  908. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV INFO/PACKAGE_VERSION=str:'1.4.1'
  909. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV KDUMP/enable=bool:'False'
  910. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV KDUMP/supported=bool:'False'
  911. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/firewalldAvailable=bool:'False'
  912. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/firewalldDisableServices=list:'[]'
  913. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/firewalldEnable=bool:'False'
  914. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/iptablesEnable=bool:'True'
  915. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/iptablesRules=list:'['', '# oVirt default firewall configuration. Automatically generated by vdsm bootstrap script.', '*filter', ':INPUT ACCEPT [0:0]', ':FORWARD ACCEPT [0:0]', ':OUTPUT ACCEPT [0:0]', '-A INPUT -m state --state ESTABLISHED,RELATED -j ACCEPT', '-A INPUT -p icmp -j ACCEPT', '-A INPUT -i lo -j ACCEPT', '# vdsm', '-A INPUT -p tcp --dport 54321 -j ACCEPT', '# rpc.statd', '-A INPUT -p tcp --dport 111 -j ACCEPT', '-A INPUT -p udp --dport 111 -j ACCEPT', '# SSH', '-A INPUT -p tcp --dport 22 -j ACCEPT', '# snmp', '-A INPUT -p udp --dport 161 -j ACCEPT', '', '', '# libvirt tls', '-A INPUT -p tcp --dport 16514 -j ACCEPT', '', '# serial consoles', '-A INPUT -p tcp -m multiport --dports 2223 -j ACCEPT', '', '# guest consoles', '-A INPUT -p tcp -m multiport --dports 5900:6923 -j ACCEPT', '', '# migration', '-A INPUT -p tcp -m multiport --dports 49152:49216 -j ACCEPT', '', '', '# Reject any other input traffic', '-A INPUT -j REJECT --reject-with icmp-host-prohibited', '-A FORWARD -m physdev ! --physdev-is-bridged -j REJECT --reject-with icmp-host-prohibited', 'COMMIT']'
  916. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/sshEnable=bool:'True'
  917. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/sshKey=str:'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCmZa9QiDV4H8dxDEvgbjXrqK348ehyfY2QA2dnfp/tfvlMrgzUoJedlo4IdyHaXJ2VzvA/KyPj7yDH1XP6+R93KNvn7SPS3GydMKGxqjwMA5N4lfJqW1RZsFA6QVYWiDykCBSK2P+oTrxGQjvVPbSzj4xbVsv947Pg1fPcIe54WEHttxUGAV04pOVrMYPmM6dwIwsHRs23nNOsIR/LruZEye6/VwkQ95k1CWaglJP50kKTtcJ6CDp2lgE2ZBppiDF5sbCmm0q+4Tncqtvp69tDh34H/t7M3wUVMOUOfVCOISg9GDPJYPCvvOPir8z/upMse77HshXaM0z00imTW8mN ovirt-engine'
  918. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV NETWORK/sshUser=str:'root'
  919. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV ODEPLOY/INTERFACE_VERSION=str:'3'
  920. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV ODEPLOY/forceReboot=bool:'False'
  921. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV ODEPLOY/installIncomplete=bool:'False'
  922. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV ODEPLOY/installIncompleteReasons=list:'[]'
  923. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV ODEPLOY/offlinePackager=bool:'True'
  924. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV OPENSTACK/neutronEnable=bool:'False'
  925. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV OPENSTACK/neutronLinuxBridgeEnable=bool:'False'
  926. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV OPENSTACK/neutronOpenvswitchEnable=bool:'False'
  927. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV OPENSTACK/neutronOpenvswitchIntegrationBridge=str:'br-int'
  928. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV OVIRT_ENGINE/correlationId=str:'7302438e'
  929. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/dnfDisabledPlugins=list:'[]'
  930. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/dnfExpireCache=bool:'True'
  931. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/dnfRollback=bool:'True'
  932. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/dnfpackagerEnabled=bool:'True'
  933. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/keepAliveInterval=int:'30'
  934. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/yumDisabledPlugins=list:'[]'
  935. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/yumEnabledPlugins=list:'[]'
  936. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/yumExpireCache=bool:'True'
  937. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/yumRollback=bool:'True'
  938. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV PACKAGER/yumpackagerEnabled=bool:'True'
  939. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/clockMaxGap=int:'5'
  940. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/clockSet=bool:'True'
  941. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/commandPath=str:'/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
  942. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/reboot=bool:'False'
  943. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/rebootAllow=bool:'True'
  944. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV SYSTEM/rebootDeferTime=int:'10'
  945. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV TUNE/tunedProfile=NoneType:'None'
  946. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/certificateChain=NoneType:'None'
  947. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/certificateEnrollment=str:'inline'
  948. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/checkVirtHardware=bool:'True'
  949. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/configOverride=bool:'True'
  950. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/connectionRetries=int:'60'
  951. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/connectionTimeout=int:'10'
  952. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/disableNetworkManager=bool:'True'
  953. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/engineAddress=NoneType:'None'
  954. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/engineHost=str:'ovirt.otv.loc'
  955. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/enginePort=int:'80'
  956. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/keySize=int:'2048'
  957. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/managementBridgeName=NoneType:'None'
  958. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/node=bool:'False'
  959. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/nodeHasOwnBridges=bool:'False'
  960. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/nodePluginVdsmFeatures=list:'[]'
  961. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/vdsmId=unicode:'00020003-0004-0005-0006-000700080009'
  962. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM/vdsmMinimumVersion=str:'4.9'
  963. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM_CONFIG/addresses/management_port=str:'54321'
  964. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VDSM_CONFIG/vars/ssl=str:'true'
  965. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VIRT/enable=bool:'True'
  966. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/caKey=str:'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC4uz2pPMcA18h/mYyrKuNPBR3f3uf7+YAGw31NwjYJfgTcoCtqJjGP1Xw/Ak84J5+n17SePI7cmvKZhMiS7DsKedZS97+NnzXw0oKFnfsMigRGhk5ZTErfX/NvO/5SQmyJnP9yG1nT/IDd6+JbO0Ezmgwtx+w+lwIGI9gDc/Hqd7kypYgkQW14OnSaP8ashsUOGhVZ3Ax2CAZQ6cZfHTc2UfL1wcmjs579bygUYAgO2x/JAjHFxSCwh+kUs1zqkgJ2wdssuAuaxMnUFOHeb73EfWsXyLa0I9lQ7Eakcve71eI8R5252uDAAmguklde067Xln89iKpS8JOJUHcBWZrj'
  967. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/certificate=str:'[email protected] AAAAHHNzaC1yc2EtY2VydC12MDFAb3BlbnNzaC5jb20AAAAgCrebr12pjWIpSb0Qp8ah1X5/BWgnOyInVBlJ3D4TIpoAAAADAQABAAABAQC52khFJfRPEj6f95cpGccGeZHVdOjQEGw/abzphETgtWBwh38UTMXpP3w1aUw5wWctu6ommUC+LE5eEdqZuKSAd7mDpDXWBIRruTAv9I9R/qcPCXyEBT8qgZZDQFXRXkyYYh0rdJpCfTNlcikjMojuCQ+qKFuN/vcEPDBbGmAwabLcSzAjEgjzGJwXp+y2afrkJHrKT+zAAjBTc5pBHsMzWOgeAdDJiy47PaRIkgFYZLZwV4GkxmehMKwTgvaPP0/BO1UNpMmsTasFS4Yy46iH4ArC1NxRHKnXpMz0VXoKLKH/wbsU3bPTT4ejsFwHIxpBG+8fOxokZmtE9VR3WErZAAAAAAAAAAAAAAACAAAADW5vZGUyLm90di5sb2MAAAARAAAADW5vZGUyLm90di5sb2MAAAAAVwzO9wAAAABgct6HAAAAAAAAAAAAAAAAAAABFwAAAAdzc2gtcnNhAAAAAwEAAQAAAQEAuLs9qTzHANfIf5mMqyrjTwUd397n+/mABsN9TcI2CX4E3KAraiYxj9V8PwJPOCefp9e0njyO3JrymYTIkuw7CnnWUve/jZ818NKChZ37DIoERoZOWUxK31/zbzv+UkJsiZz/chtZ0/yA3eviWztBM5oMLcfsPpcCBiPYA3Px6ne5MqWIJEFteDp0mj/GrIbFDhoVWdwMdggGUOnGXx03NlHy9cHJo7Oe/W8oFGAIDtsfyQIxxcUgsIfpFLNc6pICdsHbLLgLmsTJ1BTh3m+9xH1rF8i2tCPZUOxGpHL3u9XiPEedudrgwAJoLpJXXtOu15Z/PYiqUvCTiVB3AVma4wAAAQ8AAAAHc3NoLXJzYQAAAQCqp3nAA5WoeueDru6yu2UmBl1dncfnPdAlJ8GlZz+05oLe6bh8mdC3TXuWdq7aMtLLM34mt3ezuQpXWNdOVlIwfPc8s6ZlyuUYhY6faZfL2DmYYwVz1QfK2oZSGmYTc9Y3LFtu6t7bO8yAOGUkV25dihUiqBEnWf3R3ZGuyaxPSeLS7tTSpD3W2xR1zorykclx7MUMyQ/2toCnZCwk7z0nIOLJPYjbMFjbyVRh3LfdufOH2xlhTXjyWvTCd3TZwKMN4EpjxJum6r0WDA1L6H7VKloUbHvJ2ldqcHFMGPwDlROmjEJHVZm2sS5/BmtSgFnDZwEEN/tp3xcBXUGBHpcL /etc/pki/ovirt-engine/certs/node2.otv.loc-ssh.pub'
  968. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/certificateEnrollment=str:'inline'
  969. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/enable=bool:'True'
  970. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/keySize=int:'2048'
  971. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:510 ENV VMCONSOLE/support=int:'1'
  972. 2016-04-12 16:33:33 DEBUG otopi.context context.dumpEnvironment:514 ENVIRONMENT DUMP - END
  973. 2016-04-12 16:33:33 DEBUG otopi.context context._executeMethod:142 Stage pre-terminate METHOD otopi.plugins.otopi.dialog.cli.Plugin._pre_terminate
  974. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
  975. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  976. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Processing ended, use 'quit' to quit
  977. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### COMMAND>
  978. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE env-get -k BASE/error
  979. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***D:VALUE BASE/error=bool:False
  980. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
  981. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  982. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Processing ended, use 'quit' to quit
  983. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### COMMAND>
  984. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE env-get -k ODEPLOY/installIncomplete
  985. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***D:VALUE ODEPLOY/installIncomplete=bool:False
  986. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
  987. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  988. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Processing ended, use 'quit' to quit
  989. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### COMMAND>
  990. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE env-get -k SYSTEM/reboot
  991. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***D:VALUE SYSTEM/reboot=bool:False
  992. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
  993. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  994. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Processing ended, use 'quit' to quit
  995. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### COMMAND>
  996. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE noop
  997. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
  998. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ###
  999. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### Processing ended, use 'quit' to quit
  1000. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:SEND ### COMMAND>
  1001. 2016-04-12 16:33:33 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:219 DIALOG:RECEIVE log