Skip to content

Instantly share code, notes, and snippets.

@krig
Created October 25, 2017 08:27
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save krig/e4ed6fc6b861658a8826b1838ca9ac5e to your computer and use it in GitHub Desktop.
Save krig/e4ed6fc6b861658a8826b1838ca9ac5e to your computer and use it in GitHub Desktop.
crmsh regression test suite output py3
Wed Oct 25 08:21:29 UTC 2017: BEGIN testcase confbasic
----------
testcase confbasic failed
output is in crmtestout/confbasic.out
diff (from crmtestout/confbasic.diff):
--- /usr/share/crmsh/tests/testcases/confbasic.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:21:31.832475548 +0000
@@ -22,2 +22,3 @@
.INP: master m d4
+ERROR: 21: Cannot create ms with ID 'm': Found existing ms with same ID.
.INP: primitive s5 ocf:pacemaker:Stateful operations $id-ref=d1-ops
----------
Wed Oct 25 08:21:31 UTC 2017: END testcase confbasic
Wed Oct 25 08:21:31 UTC 2017: BEGIN testcase confbasic-xml
Wed Oct 25 08:21:33 UTC 2017: END testcase confbasic-xml
Wed Oct 25 08:21:33 UTC 2017: BEGIN testcase edit
----------
testcase edit failed
output is in crmtestout/edit.out
diff (from crmtestout/edit.diff):
--- /usr/share/crmsh/tests/testcases/edit.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:21:35.127490534 +0000
@@ -10,3 +10,7 @@
.INP: filter "sed '$aprimitive p2 ocf:heartbeat:Dummy'"
+ERROR: 9: memoryview: a bytes-like object is required, not 'str'
+INFO: 9: from: sed '$aprimitive p2 ocf:heartbeat:Dummy'
.INP: filter "sed '$agroup g1 p1 p2'"
+ERROR: 10: memoryview: a bytes-like object is required, not 'str'
+INFO: 10: from: sed '$agroup g1 p1 p2'
.INP: show
@@ -18,3 +22,2 @@
op_params OCF_CHECK_LEVEL=10
-primitive p2 Dummy
primitive st stonith:null \
@@ -24,3 +27,2 @@
op monitor interval=60m
-group g1 p1 p2
property cib-bootstrap-options: \
@@ -28,2 +30,3 @@
.INP: filter "sed 's/p2/p3/;$aprimitive p3 ocf:heartbeat:Dummy'" g1
+ERROR: 12: object g1 does not exist
.INP: show
@@ -35,4 +38,2 @@
op_params OCF_CHECK_LEVEL=10
-primitive p2 Dummy
-primitive p3 Dummy
primitive st stonith:null \
@@ -42,3 +43,2 @@
op monitor interval=60m
-group g1 p1 p3
property cib-bootstrap-options: \
@@ -46,7 +46,15 @@
.INP: filter "sed '$aclone c1 p2'"
+ERROR: 14: memoryview: a bytes-like object is required, not 'str'
+INFO: 14: from: sed '$aclone c1 p2'
.INP: filter "sed 's/p2/g1/'" c1
+ERROR: 15: object c1 does not exist
.INP: filter "sed '/clone/s/g1/p2/'" c1 g1
+ERROR: 16: object c1 does not exist
.INP: filter "sed '/clone/s/p2/g1/;s/p3/p2/'" c1 g1
+ERROR: 17: object c1 does not exist
.INP: filter "sed '1,$d'" c1 g1
+ERROR: 18: object c1 does not exist
.INP: filter "sed -e '$aclone c1 g1' -e '$agroup g1 p1 p2'"
+ERROR: 19: memoryview: a bytes-like object is required, not 'str'
+INFO: 19: from: sed -e '$aclone c1 g1' -e '$agroup g1 p1 p2'
.INP: location l1 p3 100: node1
@@ -55,3 +63,7 @@
.INP: filter "sed '/cl1/s/p3/p2/'"
+ERROR: 23: memoryview: a bytes-like object is required, not 'str'
+INFO: 23: from: sed '/cl1/s/p3/p2/'
.INP: filter "sed '/cl1/d'"
+ERROR: 24: memoryview: a bytes-like object is required, not 'str'
+INFO: 24: from: sed '/cl1/d'
.INP: primitive d1 ocf:heartbeat:Dummy
@@ -61,29 +73,46 @@
.INP: filter "sed '/g2/s/d1/p1/;/g1/s/p1/d1/'"
-ERROR: 29: Cannot create group:g1: Child primitive:d1 already in group:g2
+ERROR: 29: memoryview: a bytes-like object is required, not 'str'
+INFO: 29: from: sed '/g2/s/d1/p1/;/g1/s/p1/d1/'
.INP: filter "sed '/g1/s/d1/p1/;/g2/s/p1/d1/'"
+ERROR: 30: memoryview: a bytes-like object is required, not 'str'
+INFO: 30: from: sed '/g1/s/d1/p1/;/g2/s/p1/d1/'
.INP: filter "sed '$alocation loc-d1 d1 rule $id=r1 -inf: not_defined webserver rule $id=r2 webserver: defined webserver'"
+ERROR: 31: memoryview: a bytes-like object is required, not 'str'
+INFO: 31: from: sed '$alocation loc-d1 d1 rule $id=r1 -inf: not_defined webserver rule $id=r2 webserver: defined webserver'
.INP: filter "sed 's/not_defined webserver/& or mem number:lte 0/'" loc-d1
+ERROR: 32: object loc-d1 does not exist
.INP: filter "sed 's/ or mem number:lte 0//'" loc-d1
+ERROR: 33: object loc-d1 does not exist
.INP: filter "sed 's/not_defined webserver/& rule -inf: not_defined a2/'" loc-d1
+ERROR: 34: object loc-d1 does not exist
.INP: filter "sed 's/not_defined webserver/& or mem number:lte 0/'" loc-d1
+ERROR: 35: object loc-d1 does not exist
.INP: modgroup g1 add d3
+ERROR: 36: configure.modgroup: group g1 does not exist
.INP: modgroup g1 remove p1
+ERROR: 37: configure.modgroup: group g1 does not exist
.INP: modgroup g1 add p1 after p2
+ERROR: 38: configure.modgroup: group g1 does not exist
.INP: modgroup g1 remove p1
+ERROR: 39: configure.modgroup: group g1 does not exist
.INP: modgroup g1 add p1 before p2
+ERROR: 40: configure.modgroup: group g1 does not exist
.INP: modgroup g1 add p1
-ERROR: 1: syntax in group: child p1 listed more than once in group g1 parsing 'group g1 p1 p2 d3 p1'
+ERROR: 41: configure.modgroup: group g1 does not exist
.INP: modgroup g1 remove st
-ERROR: 42: configure.modgroup: st is not member of g1
+ERROR: 42: configure.modgroup: group g1 does not exist
.INP: modgroup g1 remove c1
-ERROR: 43: configure.modgroup: c1 is not member of g1
+ERROR: 43: configure.modgroup: group g1 does not exist
.INP: modgroup g1 remove nosuch
-ERROR: 44: configure.modgroup: nosuch is not member of g1
+ERROR: 44: configure.modgroup: group g1 does not exist
.INP: modgroup g1 add c1
-ERROR: 45: a group may contain only primitives; c1 is clone
+ERROR: 45: configure.modgroup: group g1 does not exist
.INP: modgroup g1 add nosuch
-ERROR: 46: g1 refers to missing object nosuch
+ERROR: 46: configure.modgroup: group g1 does not exist
.INP: filter "sed 's/^/# this is a comment\n/'" loc-d1
+ERROR: 47: object loc-d1 does not exist
.INP: rsc_defaults $id="rsc_options" failure-timeout=10m
.INP: filter "sed 's/2m/60s/'" cib-bootstrap-options
+ERROR: 49: memoryview: a bytes-like object is required, not 'str'
+INFO: 49: from: sed 's/2m/60s/'
.INP: show rsc_options
@@ -94,8 +123,11 @@
property cib-bootstrap-options: \
- default-action-timeout=60s \
+ default-action-timeout=2m \
stonith-enabled=true
.INP: filter 'sed "s/stonith-enabled=true//"'
+ERROR: 53: memoryview: a bytes-like object is required, not 'str'
+INFO: 53: from: sed "s/stonith-enabled=true//"
.INP: show cib-bootstrap-options
property cib-bootstrap-options: \
- default-action-timeout=60s
+ default-action-timeout=2m \
+ stonith-enabled=true
.INP: primitive d4 ocf:heartbeat:Dummy
@@ -114,2 +146,12 @@
.INP: verify
+ERROR: 63: element rsc_location: validity error : IDREF attribute rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+Errors found during check: config not valid
.EXT crm_resource --show-metadata stonith:null
@@ -120,2 +162,7 @@
.EXT cib metadata
+WARNING: 63: cl1: resource c1 does not exist
+WARNING: 63: cl1: resource p3 does not exist
+WARNING: 63: l1: resource p3 does not exist
+WARNING: 63: o1: resource p3 does not exist
+WARNING: 63: o1: resource c1 does not exist
.INP: show
@@ -133,4 +180,2 @@
op_params OCF_CHECK_LEVEL=10
-primitive p2 Dummy
-primitive p3 Dummy
primitive st stonith:null \
@@ -140,11 +185,6 @@
op monitor interval=60m
-group g1 p1 p2 d3
group g2 d1 d2
-clone c1 g1
tag t-d45 d4 d5
+colocation cl1 inf: c1 p3
location l1 p3 100: node1
-location loc-d1 d1 \
- rule -inf: not_defined webserver or mem number:lte 0 \
- rule -inf: not_defined a2 \
- rule webserver: defined webserver
order o-d456 d4 d5 d6
@@ -152,3 +192,4 @@
property cib-bootstrap-options: \
- default-action-timeout=60s
+ default-action-timeout=2m \
+ stonith-enabled=true
rsc_defaults rsc_options: \
@@ -156 +197,31 @@
.INP: commit
+ERROR: 65: element rsc_location: validity error : IDREF attribute rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+Errors found during check: config not valid
+WARNING: 65: cl1: resource c1 does not exist
+WARNING: 65: cl1: resource p3 does not exist
+WARNING: 65: l1: resource p3 does not exist
+WARNING: 65: o1: resource p3 does not exist
+WARNING: 65: o1: resource c1 does not exist
+ERROR: 65: element rsc_location: validity error : IDREF attribute rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute first references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_colocation: validity error : IDREF attribute with-rsc references an unknown ID "p3"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_order: validity error : IDREF attribute then references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+element rsc_colocation: validity error : IDREF attribute rsc references an unknown ID "c1"
+Errors found during check: config not valid
+WARNING: 65: cl1: resource c1 does not exist
+WARNING: 65: cl1: resource p3 does not exist
+WARNING: 65: l1: resource p3 does not exist
+WARNING: 65: o1: resource p3 does not exist
+WARNING: 65: o1: resource c1 does not exist
----------
Wed Oct 25 08:21:35 UTC 2017: END testcase edit
Wed Oct 25 08:21:35 UTC 2017: BEGIN testcase rset
----------
testcase rset failed
output is in crmtestout/rset.out
diff (from crmtestout/rset.diff):
--- /usr/share/crmsh/tests/testcases/rset.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:21:36.552993647 +0000
@@ -17,23 +17,16 @@
.INP: delete d2
-INFO: 16: constraint order:o1 updated
-INFO: 16: constraint colocation:c1 updated
-INFO: 16: constraint colocation:c2 updated
-INFO: 16: constraint colocation:c3 updated
.INP: show o1 c1 c2 c3
-colocation c1 inf: d4 ( d1 d3 )
-colocation c2 inf: d1 d3 d4
-colocation c3 inf: ( d3 d4 ) ( d1 )
-order o1 Serialize: d1 ( d3 d4 )
+colocation c1 inf: d4 ( d1 d2 d3 )
+colocation c2 inf: d1 d2 d3 d4
+colocation c3 inf: ( d3 d4 ) ( d1 d2 )
+order o1 Serialize: d1 d2 ( d3 d4 )
.INP: delete d4
-INFO: 18: constraint order:o1 updated
-INFO: 18: constraint colocation:c1 updated
-INFO: 18: constraint colocation:c2 updated
-INFO: 18: constraint colocation:c3 updated
.INP: show o1 c1 c2 c3
-colocation c1 inf: ( d1 d3 )
-colocation c2 inf: d3 d1
-colocation c3 inf: d3 d1
-order o1 Serialize: d1 d3
+colocation c1 inf: d4 ( d1 d2 d3 )
+colocation c2 inf: d1 d2 d3 d4
+colocation c3 inf: ( d3 d4 ) ( d1 d2 )
+order o1 Serialize: d1 d2 ( d3 d4 )
.INP: _test
.INP: verify
+ERROR: 21: Warnings found during check: config may not be valid
.EXT crm_resource --show-metadata stonith:ssh
@@ -46,3 +39,5 @@
primitive d1 ocf:pacemaker:Dummy
+primitive d2 Dummy
primitive d3 Dummy
+primitive d4 Dummy
primitive d5 Dummy
@@ -51,6 +46,8 @@
op start timeout=60s interval=0
-colocation c1 inf: ( d1 d3 )
-colocation c2 inf: d3 d1
-colocation c3 inf: d3 d1
-order o1 Serialize: d1 d3
+colocation c1 inf: d4 ( d1 d2 d3 )
+colocation c2 inf: d1 d2 d3 d4
+colocation c3 inf: ( d3 d4 ) ( d1 d2 )
+order o1 Serialize: d1 d2 ( d3 d4 )
.INP: commit
+ERROR: 23: Warnings found during check: config may not be valid
+ERROR: 23: Warnings found during check: config may not be valid
----------
Wed Oct 25 08:21:36 UTC 2017: END testcase rset
Wed Oct 25 08:21:36 UTC 2017: BEGIN testcase rset-xml
----------
testcase rset-xml failed
output is in crmtestout/rset-xml.out
diff (from crmtestout/rset-xml.diff):
<diff crm_feature_set="3.0.14" format="1" digest="2868f832727256100af68af48ce7fa7d">
<diff-removed>
<cib>
<configuration>
<constraints>
<rsc_colocation rsc="d3" with-rsc="d1" id="c2"/>
<rsc_order first="d1" then="d3" id="o1"/>
<rsc_colocation rsc="d3" with-rsc="d1" id="c3"/>
</constraints>
</configuration>
</cib>
</diff-removed>
<diff-added>
<cib>
<configuration>
<resources>
<primitive id="d2" class="ocf" provider="heartbeat" type="Dummy" __crm_diff_marker__="added:top"/>
<primitive id="d4" class="ocf" provider="heartbeat" type="Dummy" __crm_diff_marker__="added:top"/>
</resources>
<constraints>
<rsc_order id="o1" kind="Serialize" first="d1" then="d3">
<resource_set id="o1-0" __crm_diff_marker__="added:top">
<resource_ref id="d1"/>
<resource_ref id="d2"/>
</resource_set>
<resource_set sequential="false" id="o1-1" __crm_diff_marker__="added:top">
<resource_ref id="d3"/>
<resource_ref id="d4"/>
</resource_set>
</rsc_order>
<rsc_colocation id="c1" score="INFINITY">
<resource_set id="c1-0" __crm_diff_marker__="added:top">
<resource_ref id="d4"/>
</resource_set>
<resource_set sequential="false" id="c1-1">
<resource_ref id="d2" __crm_diff_marker__="added:top"/>
</resource_set>
</rsc_colocation>
<rsc_colocation id="c2" score="INFINITY" rsc="d3" with-rsc="d1">
<resource_set id="c2-0" __crm_diff_marker__="added:top">
<resource_ref id="d1"/>
<resource_ref id="d2"/>
<resource_ref id="d3"/>
<resource_ref id="d4"/>
</resource_set>
</rsc_colocation>
<rsc_colocation id="c3" score="INFINITY" rsc="d3" with-rsc="d1">
<resource_set sequential="false" id="c3-0" __crm_diff_marker__="added:top">
<resource_ref id="d3"/>
<resource_ref id="d4"/>
</resource_set>
<resource_set sequential="false" id="c3-1" __crm_diff_marker__="added:top">
<resource_ref id="d1"/>
<resource_ref id="d2"/>
</resource_set>
</rsc_colocation>
</constraints>
</configuration>
</cib>
</diff-added>
</diff>
----------
Wed Oct 25 08:21:37 UTC 2017: END testcase rset-xml
Wed Oct 25 08:21:37 UTC 2017: BEGIN testcase delete
----------
testcase delete failed
output is in crmtestout/delete.out
diff (from crmtestout/delete.diff):
--- /usr/share/crmsh/tests/testcases/delete.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:21:39.407174792 +0000
@@ -39,2 +39,3 @@
node node1
+primitive d2 ocf:pacemaker:Dummy
primitive p1 ocf:pacemaker:Dummy
@@ -48,3 +49,2 @@
.INP: delete p1
-INFO: 20: hanging location:d1-pref deleted
.INP: _test
@@ -52,2 +52,4 @@
node node1
+primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -57,4 +59,6 @@
op monitor interval=60m timeout=60s
+location d1-pref p1 100: node1
.INP: primitive d1 ocf:pacemaker:Dummy
.INP: location d1-pref d1 100: node1
+ERROR: 24: Cannot create location with ID 'd1-pref': Found existing location with same ID.
.INP: _test
@@ -62,5 +66,5 @@
.INP: primitive d2 ocf:pacemaker:Dummy
+ERROR: 27: Cannot create primitive with ID 'd2': Found existing primitive with same ID.
.INP: _test
.INP: group g1 d2 d1
-INFO: 29: modified location:d1-pref from d1 to g1
.INP: delete d2
@@ -69,2 +73,4 @@
primitive d1 ocf:pacemaker:Dummy
+primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -74,7 +80,6 @@
op monitor interval=60m timeout=60s
-group g1 d1
-location d1-pref g1 100: node1
+group g1 d2 d1
+location d1-pref p1 100: node1
.INP: _test
.INP: delete g1
-INFO: 33: modified location:d1-pref from g1 to d1
.INP: show
@@ -82,2 +87,4 @@
primitive d1 ocf:pacemaker:Dummy
+primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -87,3 +94,4 @@
op monitor interval=60m timeout=60s
-location d1-pref d1 100: node1
+group g1 d2 d1
+location d1-pref p1 100: node1
.INP: verify
@@ -95,9 +103,7 @@
.INP: primitive d2 ocf:pacemaker:Dummy
+ERROR: 37: Cannot create primitive with ID 'd2': Found existing primitive with same ID.
.INP: group g1 d2 d1
-INFO: 38: modified location:d1-pref from d1 to g1
+ERROR: 38: Cannot create group with ID 'g1': Found existing group with same ID.
.INP: clone c1 g1
-INFO: 39: modified location:d1-pref from g1 to c1
.INP: delete g1
-INFO: 40: modified location:d1-pref from c1 to g1
-INFO: 40: modified location:d1-pref from g1 to d2
.INP: show
@@ -106,2 +112,3 @@
primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -111,8 +118,10 @@
op monitor interval=60m timeout=60s
-location d1-pref d2 100: node1
+group g1 d2 d1
+clone c1 g1
+location d1-pref p1 100: node1
.INP: _test
.INP: group g1 d2 d1
-INFO: 43: modified location:d1-pref from d2 to g1
+ERROR: 43: Cannot create group with ID 'g1': Found existing group with same ID.
.INP: clone c1 g1
-INFO: 44: modified location:d1-pref from g1 to c1
+ERROR: 44: Cannot create clone with ID 'c1': Found existing clone with same ID.
.INP: _test
@@ -120,4 +129,2 @@
.INP: delete g1
-INFO: 47: modified location:d1-pref from c1 to g1
-INFO: 47: modified location:d1-pref from g1 to d2
.INP: show
@@ -126,2 +133,3 @@
primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -131,15 +139,17 @@
op monitor interval=60m timeout=60s
-location d1-pref d2 100: node1
+group g1 d2 d1
+clone c1 g1
+location d1-pref p1 100: node1
.INP: _test
.INP: group g1 d2 d1
-INFO: 50: modified location:d1-pref from d2 to g1
+ERROR: 50: Cannot create group with ID 'g1': Found existing group with same ID.
.INP: clone c1 g1
-INFO: 51: modified location:d1-pref from g1 to c1
+ERROR: 51: Cannot create clone with ID 'c1': Found existing clone with same ID.
.INP: # delete primitive and its group and their clone
.INP: delete d2 d1 c1 g1
-INFO: 53: modified location:d1-pref from c1 to g1
-INFO: 53: modified location:d1-pref from g1 to d2
-INFO: 53: hanging location:d1-pref deleted
.INP: show
node node1
+primitive d1 ocf:pacemaker:Dummy
+primitive d2 ocf:pacemaker:Dummy
+primitive p1 ocf:pacemaker:Dummy
primitive st stonith:ssh \
@@ -149,2 +159,5 @@
op monitor interval=60m timeout=60s
+group g1 d2 d1
+clone c1 g1
+location d1-pref p1 100: node1
.INP: _test
----------
Wed Oct 25 08:21:39 UTC 2017: END testcase delete
Wed Oct 25 08:21:39 UTC 2017: BEGIN testcase node
Wed Oct 25 08:21:43 UTC 2017: END testcase node
Wed Oct 25 08:21:43 UTC 2017: BEGIN testcase resource
----------
testcase resource failed
output is in crmtestout/resource.out
diff (from crmtestout/resource.diff):
--- /usr/share/crmsh/tests/testcases/resource.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:21:59.301771818 +0000
@@ -825,6 +825,6 @@
.TRY configure rename p3 p4
-.EXT crm_resource --show-metadata ocf:pacemaker:Dummy
-.EXT crm_resource --show-metadata ocf:heartbeat:Delay
.EXT crm_resource --show-metadata stonith:null
.EXT stonithd metadata
+.EXT crm_resource --show-metadata ocf:pacemaker:Dummy
+.EXT crm_resource --show-metadata ocf:heartbeat:Delay
.INP: configure
@@ -857,6 +857,6 @@
.TRY configure primitive p3 Dummy
-.EXT crm_resource --show-metadata ocf:pacemaker:Dummy
-.EXT crm_resource --show-metadata ocf:heartbeat:Delay
.EXT crm_resource --show-metadata stonith:null
.EXT stonithd metadata
+.EXT crm_resource --show-metadata ocf:pacemaker:Dummy
+.EXT crm_resource --show-metadata ocf:heartbeat:Delay
.EXT crm_resource --show-metadata ocf:heartbeat:Dummy
@@ -920,5 +920,6 @@
.TRY configure ms msg g
+ERROR: Cannot create ms:msg: Child group:g already in clone:cg
.TRY resource scores
.EXT crm_simulate -sUL
-3 of 6 resources DISABLED and 0 BLOCKED from being started due to failures
+5 of 6 resources DISABLED and 0 BLOCKED from being started due to failures
@@ -932,5 +933,5 @@
Stopped: [ node1 ]
+ Clone Set: cg [g]
+ Stopped (disabled): [ node1 ]
p3 (ocf::heartbeat:Dummy): Stopped ( disabled )
- Master/Slave Set: msg [g]
- Stopped: [ node1 ]
@@ -945,5 +946,3 @@
native_color: p2:0 allocation score on node1: -INFINITY
-p2:0 promotion score on none: 0
-native_color: p3 allocation score on node1: -INFINITY
-clone_color: msg allocation score on node1: 0
+clone_color: cg allocation score on node1: 0
clone_color: g:0 allocation score on node1: 0
@@ -956,3 +955,3 @@
native_color: p4:0 allocation score on node1: -INFINITY
-g:0 promotion score on none: 0
+native_color: p3 allocation score on node1: -INFINITY
Remaining: node1 capacity:
----------
Wed Oct 25 08:21:59 UTC 2017: END testcase resource
Wed Oct 25 08:21:59 UTC 2017: BEGIN testcase file
----------
testcase file failed
output is in crmtestout/file.out
diff (from crmtestout/file.diff):
--- /usr/share/crmsh/tests/testcases/file.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:22:01.635458570 +0000
@@ -30,6 +30,2 @@
.INP: load update sample.txt
-.EXT crm_resource --show-metadata ocf:pacemaker:Dummy
-.EXT crm_resource --show-metadata ocf:heartbeat:Delay
-.EXT crm_resource --show-metadata stonith:null
-.EXT stonithd metadata
.EXT crmd metadata
----------
Wed Oct 25 08:22:01 UTC 2017: END testcase file
Wed Oct 25 08:22:01 UTC 2017: BEGIN testcase shadow
Wed Oct 25 08:22:03 UTC 2017: END testcase shadow
Wed Oct 25 08:22:03 UTC 2017: BEGIN testcase ra
----------
testcase ra failed
output is in crmtestout/ra.out
diff (from crmtestout/ra.diff):
--- /usr/share/crmsh/tests/testcases/ra.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:22:04.402099094 +0000
@@ -87,5 +87,11 @@
-pcmk_delay_max (time, [0s]): Enable random delay for stonith actions and specify the maximum of random delay
+pcmk_delay_max (time, [0s]): Enable a random delay for stonith actions and specify the maximum of random delay.
This prevents double fencing when using slow devices such as sbd.
- Use this to enable random delay for stonith actions and specify the maximum of random delay.
+ Use this to enable a random delay for stonith actions.
+ The overall delay is derived from this random delay value adding a static delay so that the sum is kept below the maximum delay.
+
+pcmk_delay_base (time, [0s]): Enable a base delay for stonith actions and specify base delay value.
+ This prevents double fencing when different delays are configured on the nodes.
+ Use this to enable a static delay for stonith actions.
+ The overall delay is derived from a random delay value adding this static delay so that the sum is kept below the maximum delay.
@@ -117,2 +123,13 @@
+pcmk_on_action (string, [on]): Advanced use only: An alternate command to run instead of 'on'
+ Some devices do not support the standard commands or may provide additional ones.
+ Use this to specify an alternate, device-specific, command that implements the 'on' action.
+
+pcmk_on_timeout (time, [60s]): Advanced use only: Specify an alternate timeout to use for on actions instead of stonith-timeout
+ Some devices need much more/less time to complete than normal.
+ Use this to specify an alternate, device-specific, timeout for 'on' actions.
+
+pcmk_on_retries (integer, [2]): Advanced use only: The maximum number of times to retry the 'on' command within the timeout period
+ Some devices do not support multiple connections. Operations may 'fail' if the device is busy with another task so Pacemaker will automatically retry the operation, if there is time remaining. Use this option to alter the number of times Pacemaker retries 'on' actions before giving up.
+
pcmk_list_action (string, [list]): Advanced use only: An alternate command to run instead of 'list'
----------
Wed Oct 25 08:22:04 UTC 2017: END testcase ra
Wed Oct 25 08:22:04 UTC 2017: BEGIN testcase acl
Wed Oct 25 08:22:05 UTC 2017: END testcase acl
Wed Oct 25 08:22:06 UTC 2017: BEGIN testcase history
----------
testcase history failed
output is in crmtestout/history.out
diff (from crmtestout/history.diff):
--- /usr/share/crmsh/tests/testcases/history.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:22:07.636059442 +0000
@@ -6,377 +6,30 @@
.EXT tar -xj < history-test.tar.bz2
-Source: history-test.tar.bz2
-Created on: Fri 14 Dec 19:08:38 UTC 2012
-By: unknown
-Period: 2012-12-14 20:06:34 - 2012-12-14 20:08:44
-Nodes: xen-d xen-e
-Groups:
-Clones:
-Resources: d1 s-libvirt
-Transitions: 43 44* 45 46 47 48* 272* 49* 50*
-.INP: events
-Dec 14 20:06:35 xen-d corosync[5649]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:06:35 xen-e corosync[24218]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:06:36 xen-d corosync[5649]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: lost: xen-d 906822154
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: pe_fence_node: Node xen-d will be fenced because it is un-expectedly down
-Dec 14 20:07:54 xen-e crmd: [24228]: notice: te_fence_node: Executing reboot fencing operation (12) on xen-d (timeout=60000)
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: stage6: Scheduling Node xen-d for STONITH
-Dec 14 20:07:56 xen-e stonith-ng: [24224]: notice: log_operation: Operation 'reboot' [24519] (call 0 from c0c111a5-d332-48f7-9375-739b91e04f0e) for host 'xen-d' with device 's-libvirt' returned: 0
-Dec 14 20:08:23 xen-d corosync[1874]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:08:23 xen-d corosync[1874]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-Dec 14 20:08:40 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:d1 start[4] (pid 5833)
-Dec 14 20:07:19 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_start_0 (call=4, rc=0, cib-update=14, confirmed=true) ok
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: rsc:s-libvirt start[4] (pid 24264)
-Dec 14 20:07:20 xen-e external/libvirt(s-libvirt)[24271]: [24288]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:21 xen-e crmd: [24228]: info: process_lrm_event: LRM operation s-libvirt_start_0 (call=4, rc=0, cib-update=66, confirmed=true) ok
-Dec 14 20:07:22 xen-e external/libvirt(s-libvirt)[24296]: [24313]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 stop[6] (pid 5926)
-Dec 14 20:07:29 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_stop_0 (call=6, rc=0, cib-update=17, confirmed=true) ok
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 start[7] (pid 5929)
-Dec 14 20:07:29 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_start_0 (call=7, rc=0, cib-update=18, confirmed=true) ok
-Dec 14 20:07:29 xen-e external/libvirt(s-libvirt)[24321]: [24338]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24387]: ERROR: Failed to get status for xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: ERROR: setlocale: No such file or directory
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: error: Cannot recv data: Warning: Identity file /root/.ssh/xen not accessible: No such file or directory.
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: Permission denied (publickey,keyboard-interactive). : Connection reset by peer
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: error: failed to connect to the hypervisor
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: rsc:s-libvirt stop[6] (pid 24417)
-Dec 14 20:07:37 xen-e crmd: [24228]: info: process_lrm_event: LRM operation s-libvirt_stop_0 (call=6, rc=0, cib-update=74, confirmed=true) ok
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: rsc:s-libvirt start[7] (pid 24418)
-Dec 14 20:07:39 xen-e external/libvirt(s-libvirt)[24425]: [24442]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:40 xen-e crmd: [24228]: info: process_lrm_event: LRM operation s-libvirt_start_0 (call=7, rc=0, cib-update=75, confirmed=true) ok
-Dec 14 20:07:41 xen-e external/libvirt(s-libvirt)[24463]: [24480]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:48 xen-e external/libvirt(s-libvirt)[24488]: [24505]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:55 xen-e external/libvirt(s-libvirt)[24525]: [24540]: notice: Domain xen-d was rebooted
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:56 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_start_0 (call=9, rc=0, cib-update=96, confirmed=true) ok
-Dec 14 20:07:57 xen-e external/libvirt(s-libvirt)[24555]: [24588]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:07 xen-e external/libvirt(s-libvirt)[24599]: [24616]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:15 xen-e external/libvirt(s-libvirt)[24630]: [24647]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:22 xen-e external/libvirt(s-libvirt)[24658]: [24678]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 start[4] (pid 2405)
-Dec 14 20:08:26 xen-d crmd: [1948]: info: process_lrm_event: LRM operation d1_start_0 (call=4, rc=0, cib-update=9, confirmed=true) ok
-Dec 14 20:08:29 xen-e external/libvirt(s-libvirt)[24689]: [24706]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:36 xen-e external/libvirt(s-libvirt)[24717]: [24734]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_stop_0 (call=11, rc=0, cib-update=125, confirmed=true) ok
-Dec 14 20:08:43 xen-e external/libvirt(s-libvirt)[24748]: [24786]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:06:36 xen-e crmd: [24228]: notice: ais_dispatch_message: Membership 1289820: quorum acquired
-Dec 14 20:06:36 xen-d crmd: [5660]: notice: ais_dispatch_message: Membership 1289820: quorum acquired
-Dec 14 20:07:54 xen-e crmd: [24228]: notice: ais_dispatch_message: Membership 1289824: quorum lost
-Dec 14 20:08:24 xen-d crmd: [1948]: notice: ais_dispatch_message: Membership 1289828: quorum acquired
-Dec 14 20:08:40 xen-e crmd: [24228]: notice: ais_dispatch_message: Membership 1289828: quorum acquired
-Dec 14 20:06:57 xen-e pengine: [24227]: ERROR: unpack_resources: Resource start-up disabled since no STONITH resources have been defined
-Dec 14 20:06:57 xen-e pengine: [24227]: ERROR: unpack_resources: Either configure some or disable STONITH with the stonith-enabled option
-Dec 14 20:06:57 xen-e pengine: [24227]: ERROR: unpack_resources: NOTE: Clusters with shared data need STONITH to ensure data integrity
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24387]: ERROR: Failed to get status for xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: ERROR: setlocale: No such file or directory
-Dec 14 20:07:37 xen-e stonith-ng: [24224]: ERROR: log_operation: s-libvirt: Performing: stonith -t external/libvirt -S
-Dec 14 20:07:37 xen-e stonith: [24366]: ERROR: external/libvirt device not accessible.
-Dec 14 20:07:37 xen-e stonith-ng: [24224]: ERROR: log_operation: s-libvirt: failed: 1
-Dec 14 20:07:43 xen-d stonith-ng: [5656]: ERROR: ais_dispatch: Receiving message body failed: (2) Library error: Resource temporarily unavailable (11)
-Dec 14 20:07:43 xen-d cib: [5655]: ERROR: ais_dispatch: Receiving message body failed: (2) Library error: Resource temporarily unavailable (11)
-Dec 14 20:07:43 xen-d attrd: [5658]: ERROR: ais_dispatch: Receiving message body failed: (2) Library error: Resource temporarily unavailable (11)
-Dec 14 20:07:43 xen-d crmd: [5660]: ERROR: ais_dispatch: Receiving message body failed: (2) Library error: Resource temporarily unavailable (11)
-Dec 14 20:07:43 xen-d stonith-ng: [5656]: ERROR: ais_dispatch: AIS connection failed
-Dec 14 20:07:43 xen-d cib: [5655]: ERROR: ais_dispatch: AIS connection failed
-Dec 14 20:07:43 xen-d attrd: [5658]: ERROR: ais_dispatch: AIS connection failed
-Dec 14 20:07:43 xen-d crmd: [5660]: ERROR: ais_dispatch: AIS connection failed
-Dec 14 20:07:43 xen-d stonith-ng: [5656]: ERROR: stonith_peer_ais_destroy: AIS connection terminated
-Dec 14 20:07:43 xen-d cib: [5655]: ERROR: cib_ais_destroy: Corosync connection lost! Exiting.
-Dec 14 20:07:43 xen-d attrd: [5658]: CRIT: attrd_ais_destroy: Lost connection to OpenAIS service!
-Dec 14 20:07:43 xen-d attrd: [5658]: ERROR: attrd_cib_connection_destroy: Connection to the CIB terminated...
-Dec 14 20:07:43 xen-d crmd: [5660]: CRIT: stonith_dispatch_internal: Lost connection to the STONITH service [5656/callback].
-Dec 14 20:07:43 xen-d crmd: [5660]: CRIT: stonith_dispatch_internal: Lost connection to the STONITH service [5656/command].
-Dec 14 20:07:43 xen-d crmd: [5660]: CRIT: tengine_stonith_connection_destroy: Fencing daemon connection failed
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: te_connect_stonith: Sign-in failed: triggered a retry
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: attrd_connection_destroy: Lost connection to attrd
-Dec 14 20:07:44 xen-d crmd: [5660]: CRIT: cib_native_dispatch: Lost connection to the CIB service [5655/callback].
-Dec 14 20:07:44 xen-d crmd: [5660]: CRIT: cib_native_dispatch: Lost connection to the CIB service [5655/command].
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: crmd_cib_connection_destroy: Connection to the CIB terminated...
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: do_log: FSA: Input I_ERROR from crmd_cib_connection_destroy() received in state S_NOT_DC
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: do_recover: Action A_RECOVER (0000000001000000) not supported
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: do_log: FSA: Input I_TERMINATE from do_recover() received in state S_RECOVERY
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: verify_stopped: Resource d1 was active at shutdown. You may ignore this error if it is unmanaged.
-Dec 14 20:07:44 xen-d crmd: [5660]: ERROR: do_exit: Could not recover from internal error
-.INP: node xen-d
-Dec 14 20:06:35 xen-d corosync[5649]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:06:36 xen-d corosync[5649]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: lost: xen-d 906822154
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: pe_fence_node: Node xen-d will be fenced because it is un-expectedly down
-Dec 14 20:07:54 xen-e crmd: [24228]: notice: te_fence_node: Executing reboot fencing operation (12) on xen-d (timeout=60000)
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: stage6: Scheduling Node xen-d for STONITH
-Dec 14 20:07:56 xen-e stonith-ng: [24224]: notice: log_operation: Operation 'reboot' [24519] (call 0 from c0c111a5-d332-48f7-9375-739b91e04f0e) for host 'xen-d' with device 's-libvirt' returned: 0
-Dec 14 20:08:23 xen-d corosync[1874]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:08:23 xen-d corosync[1874]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-.INP: node xen-e
-Dec 14 20:06:35 xen-e corosync[24218]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-Dec 14 20:08:40 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-.INP: node .*
-Dec 14 20:06:35 xen-d corosync[5649]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:06:35 xen-e corosync[24218]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:06:36 xen-d corosync[5649]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-Dec 14 20:07:54 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: lost: xen-d 906822154
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: pe_fence_node: Node xen-d will be fenced because it is un-expectedly down
-Dec 14 20:07:54 xen-e crmd: [24228]: notice: te_fence_node: Executing reboot fencing operation (12) on xen-d (timeout=60000)
-Dec 14 20:07:54 xen-e pengine: [24227]: WARN: stage6: Scheduling Node xen-d for STONITH
-Dec 14 20:07:56 xen-e stonith-ng: [24224]: notice: log_operation: Operation 'reboot' [24519] (call 0 from c0c111a5-d332-48f7-9375-739b91e04f0e) for host 'xen-d' with device 's-libvirt' returned: 0
-Dec 14 20:08:23 xen-d corosync[1874]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-Dec 14 20:08:23 xen-d corosync[1874]: [pcmk ] info: pcmk_peer_update: memb: xen-d 906822154
-Dec 14 20:08:40 xen-e corosync[24218]: [pcmk ] info: pcmk_peer_update: memb: xen-e 923599370
-.INP: exclude pcmk_peer_update
-.INP: exclude
-pcmk_peer_update
-.INP: node xen-e
-Dec 14 20:06:35 xen-e corosync[24218]: [MAIN ] Corosync Cluster Engine ('1.4.3'): started and ready to provide service.
-.INP: exclude clear
-.INP: exclude corosync|crmd|pengine|stonith-ng|cib|attrd|mgmtd|sshd
-.INP: log
-Dec 14 20:06:35 xen-d lrmd: [5657]: info: max-children set to 4 (2 processors online)
-Dec 14 20:06:35 xen-d lrmd: [5657]: info: enabling coredumps
-Dec 14 20:06:35 xen-d lrmd: [5657]: info: Started.
-Dec 14 20:06:35 xen-e lrmd: [24225]: info: max-children set to 4 (2 processors online)
-Dec 14 20:06:35 xen-e lrmd: [24225]: info: enabling coredumps
-Dec 14 20:06:35 xen-e lrmd: [24225]: info: Started.
-Dec 14 20:06:36 xen-e lrmd: [24225]: info: max-children already set to 4
-Dec 14 20:06:37 xen-d lrmd: [5657]: info: max-children already set to 4
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:d1 probe[2] (pid 5812)
-Dec 14 20:07:19 xen-d lrmd: [5657]: notice: lrmd_rsc_new(): No lrm_rprovider field in message
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:s-libvirt probe[3] (pid 5813)
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: operation monitor[3] on s-libvirt for client 5660: pid 5813 exited with return code 7
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: operation monitor[2] on d1 for client 5660: pid 5812 exited with return code 7
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:d1 start[4] (pid 5833)
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: operation start[4] on d1 for client 5660: pid 5833 exited with return code 0
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:d1 monitor[5] (pid 5840)
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: operation monitor[5] on d1 for client 5660: pid 5840 exited with return code 0
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: rsc:d1 probe[2] (pid 24243)
-Dec 14 20:07:19 xen-e lrmd: [24225]: notice: lrmd_rsc_new(): No lrm_rprovider field in message
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: rsc:s-libvirt probe[3] (pid 24244)
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: operation monitor[3] on s-libvirt for client 24228: pid 24244 exited with return code 7
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: operation monitor[2] on d1 for client 24228: pid 24243 exited with return code 7
-Dec 14 20:07:19 xen-e lrmd: [24225]: info: rsc:s-libvirt start[4] (pid 24264)
-Dec 14 20:07:20 xen-e external/libvirt(s-libvirt)[24271]: [24288]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:21 xen-e lrmd: [24225]: info: operation start[4] on s-libvirt for client 24228: pid 24264 exited with return code 0
-Dec 14 20:07:21 xen-e lrmd: [24225]: info: rsc:s-libvirt monitor[5] (pid 24289)
-Dec 14 20:07:22 xen-e external/libvirt(s-libvirt)[24296]: [24313]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:23 xen-e lrmd: [24225]: info: operation monitor[5] on s-libvirt for client 24228: pid 24289 exited with return code 0
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: cancel_op: operation monitor[5] on d1 for client 5660, its parameters: CRM_meta_name=[monitor] crm_feature_set=[3.0.6] CRM_meta_timeout=[30000] CRM_meta_interval=[5000] cancelled
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 stop[6] (pid 5926)
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: operation stop[6] on d1 for client 5660: pid 5926 exited with return code 0
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 start[7] (pid 5929)
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: operation start[7] on d1 for client 5660: pid 5929 exited with return code 0
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 monitor[8] (pid 5938)
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: operation monitor[8] on d1 for client 5660: pid 5938 exited with return code 0
-Dec 14 20:07:29 xen-e external/libvirt(s-libvirt)[24321]: [24338]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24387]: ERROR: Failed to get status for xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: ERROR: setlocale: No such file or directory
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: error: Cannot recv data: Warning: Identity file /root/.ssh/xen not accessible: No such file or directory.
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: Permission denied (publickey,keyboard-interactive). : Connection reset by peer
-Dec 14 20:07:36 xen-e external/libvirt(s-libvirt)[24371]: [24393]: error: failed to connect to the hypervisor
-Dec 14 20:07:37 xen-e stonith: [24366]: WARN: external_status: 'libvirt status' failed with rc 1
-Dec 14 20:07:37 xen-e stonith: [24366]: ERROR: external/libvirt device not accessible.
-Dec 14 20:07:37 xen-e lrm-stonith: [24364]: WARN: map_ra_retvalue: Mapped the invalid return code -2.
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: cancel_op: operation monitor[5] on s-libvirt for client 24228, its parameters: CRM_meta_name=[monitor] crm_feature_set=[3.0.6] CRM_meta_timeout=[60000] CRM_meta_interval=[5000] hostlist=[xen-d xen-e] hypervisor_uri=[xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen] reset_method=[reboot] cancelled
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: rsc:s-libvirt stop[6] (pid 24417)
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: operation stop[6] on s-libvirt for client 24228: pid 24417 exited with return code 0
-Dec 14 20:07:37 xen-e lrmd: [24225]: info: rsc:s-libvirt start[7] (pid 24418)
-Dec 14 20:07:39 xen-e external/libvirt(s-libvirt)[24425]: [24442]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:40 xen-e lrmd: [24225]: info: operation start[7] on s-libvirt for client 24228: pid 24418 exited with return code 0
-Dec 14 20:07:40 xen-e lrmd: [24225]: info: rsc:s-libvirt monitor[8] (pid 24456)
-Dec 14 20:07:41 xen-e external/libvirt(s-libvirt)[24463]: [24480]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:42 xen-e lrmd: [24225]: info: operation monitor[8] on s-libvirt for client 24228: pid 24456 exited with return code 0
-Dec 14 20:07:44 xen-d lrmd: [5657]: info: cancel_op: operation monitor[8] on d1 for client 5660, its parameters: CRM_meta_name=[monitor] crm_feature_set=[3.0.6] CRM_meta_timeout=[30000] CRM_meta_interval=[5000] cancelled
-Dec 14 20:07:48 xen-e external/libvirt(s-libvirt)[24488]: [24505]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:55 xen-d shutdown[6093]: shutting down for system reboot
-Dec 14 20:07:55 xen-d init: Switching to runlevel: 6
-Dec 14 20:07:55 xen-e external/libvirt(s-libvirt)[24525]: [24540]: notice: Domain xen-d was rebooted
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: operation start[9] on d1 for client 24228: pid 24568 exited with return code 0
-Dec 14 20:07:57 xen-d logd: [6194]: debug: Stopping ha_logd with pid 1787
-Dec 14 20:07:57 xen-d logd: [6194]: info: Waiting for pid=1787 to exit
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: received SIGTERM
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: waiting for 0 messages to be read for process lrmd
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: waiting for 0 messages to be read by write process
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: sending SIGTERM to write process
-Dec 14 20:07:57 xen-d logd: [1790]: info: logd_term_write_action: received SIGTERM
-Dec 14 20:07:57 xen-d logd: [1790]: debug: Writing out 0 messages then quitting
-Dec 14 20:07:57 xen-d logd: [1790]: info: Exiting write process
-Dec 14 20:07:57 xen-d haveged: haveged stopping due to signal 15
-Dec 14 20:07:57 xen-e lrmd: [24225]: info: rsc:d1 monitor[10] (pid 24577)
-Dec 14 20:07:57 xen-e lrmd: [24225]: info: operation monitor[10] on d1 for client 24228: pid 24577 exited with return code 0
-Dec 14 20:07:57 xen-e external/libvirt(s-libvirt)[24555]: [24588]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:07:58 xen-d logd: [6194]: info: Pid 1787 exited
-Dec 14 20:07:58 xen-d rpcbind: rpcbind terminating on signal. Restart with "rpcbind -w"
-Dec 14 20:07:58 xen-d kernel: Kernel logging (proc) stopped.
-Dec 14 20:07:58 xen-d kernel: Kernel log daemon terminating.
-Dec 14 20:07:58 xen-d syslog-ng[1679]: Termination requested via signal, terminating;
-Dec 14 20:07:58 xen-d syslog-ng[1679]: syslog-ng shutting down; version='2.0.9'
-Dec 14 20:08:07 xen-e external/libvirt(s-libvirt)[24599]: [24616]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:15 xen-e external/libvirt(s-libvirt)[24630]: [24647]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:21 xen-d syslog-ng[1681]: syslog-ng starting up; version='2.0.9'
-Dec 14 20:08:21 xen-d iscsid: iSCSI logger with pid=1682 started!
-Dec 14 20:08:22 xen-d sm-notify[1716]: Version 1.2.3 starting
-Dec 14 20:08:22 xen-d haveged: haveged starting up
-Dec 14 20:08:22 xen-d haveged: arch: x86 vendor: amd generic: 0 i_cache: 64 d_cache: 64 loop_idx: 20 loop_idxmax: 40 loop_sz: 63724 loop_szmax: 124334 etime: 18207 havege_ndpt 0
-Dec 14 20:08:22 xen-d logd: [1789]: info: setting log facility to daemon
-Dec 14 20:08:22 xen-d logd: [1789]: info: logd started with /etc/logd.cf.
-Dec 14 20:08:22 xen-d iscsid: transport class version 2.0-870. iscsid version 2.0-872.suse
-Dec 14 20:08:22 xen-d iscsid: iSCSI daemon with pid=1683 started!
-Dec 14 20:08:22 xen-e external/libvirt(s-libvirt)[24658]: [24678]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:23 xen-d lrmd: [1945]: info: max-children set to 4 (2 processors online)
-Dec 14 20:08:23 xen-d lrmd: [1945]: info: enabling coredumps
-Dec 14 20:08:23 xen-d lrmd: [1945]: info: Started.
-Dec 14 20:08:25 xen-d lrmd: [1945]: info: max-children already set to 4
-Dec 14 20:08:25 xen-d ntpd[2127]: ntpd 4.2.4p8@1.1612-o Thu Nov 10 17:10:45 UTC 2011 (1)
-Dec 14 20:08:25 xen-d ntpd[2128]: precision = 2.000 usec
-Dec 14 20:08:25 xen-d ntpd[2128]: ntp_io: estimated max descriptors: 1024, initial socket boundary: 16
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #1 wildcard, ::#123 Disabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #2 eth0, fe80::216:3eff:fe65:738a#123 Enabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #3 lo, ::1#123 Enabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #4 lo, 127.0.0.1#123 Enabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #5 lo, 127.0.0.2#123 Enabled
-Dec 14 20:08:25 xen-d ntpd[2128]: Listening on interface #6 eth0, 10.2.13.54#123 Enabled
-Dec 14 20:08:25 xen-d ntpd[2128]: kernel time sync status 2040
-Dec 14 20:08:25 xen-d ntpd[2128]: frequency initialized 29.933 PPM from /var/lib/ntp/drift/ntp.drift
-Dec 14 20:08:25 xen-d /usr/sbin/cron[2244]: (CRON) STARTUP (V5.0)
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 probe[2] (pid 2384)
-Dec 14 20:08:26 xen-d lrmd: [1945]: notice: lrmd_rsc_new(): No lrm_rprovider field in message
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:s-libvirt probe[3] (pid 2385)
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: operation monitor[3] on s-libvirt for client 1948: pid 2385 exited with return code 7
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: operation monitor[2] on d1 for client 1948: pid 2384 exited with return code 7
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 start[4] (pid 2405)
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: operation start[4] on d1 for client 1948: pid 2405 exited with return code 0
-Dec 14 20:08:26 xen-d kernel: klogd 1.4.1, log source = /proc/kmsg started.
-Dec 14 20:08:26 xen-d kernel: [ 22.808182] Loading iSCSI transport class v2.0-870.
-Dec 14 20:08:26 xen-d kernel: [ 22.815399] iscsi: registered transport (tcp)
-Dec 14 20:08:26 xen-d kernel: [ 23.572989] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
-Dec 14 20:08:26 xen-d kernel: [ 23.573005] EDD information not available.
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 monitor[5] (pid 2409)
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: operation monitor[5] on d1 for client 1948: pid 2409 exited with return code 0
-Dec 14 20:08:29 xen-d kernel: [ 30.841076] eth0: no IPv6 routers present
-Dec 14 20:08:29 xen-d logger: Mark:HB_REPORT:1355512108
-Dec 14 20:08:29 xen-e external/libvirt(s-libvirt)[24689]: [24706]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:36 xen-e external/libvirt(s-libvirt)[24717]: [24734]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: cancel_op: operation monitor[10] on d1 for client 24228, its parameters: CRM_meta_name=[monitor] crm_feature_set=[3.0.6] CRM_meta_timeout=[30000] CRM_meta_interval=[5000] cancelled
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: operation stop[11] on d1 for client 24228: pid 24774 exited with return code 0
-Dec 14 20:08:43 xen-e external/libvirt(s-libvirt)[24748]: [24786]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-.INP: exclude clear
-.INP: peinputs
-history-test/xen-e/pengine/pe-input-43.bz2
-history-test/xen-e/pengine/pe-input-44.bz2
-history-test/xen-e/pengine/pe-input-45.bz2
-history-test/xen-e/pengine/pe-input-46.bz2
-history-test/xen-e/pengine/pe-input-47.bz2
-history-test/xen-e/pengine/pe-input-48.bz2
-history-test/xen-e/pengine/pe-warn-272.bz2
-history-test/xen-e/pengine/pe-input-49.bz2
-history-test/xen-e/pengine/pe-input-50.bz2
-.INP: peinputs v
-Date Start End Filename Client User Origin Tags
-==== ===== === ======== ====== ==== ====== ====
-2012-12-14 20:06:57 20:06:57 pe-input-43 crmd hacluster xen-e
-2012-12-14 20:07:19 20:07:23 pe-input-44 cibadmin root xen-d s-libvirt
-2012-12-14 20:07:29 20:07:29 pe-input-45 cibadmin root xen-d
-2012-12-14 20:07:29 20:07:29 pe-input-46 cibadmin root xen-d
-2012-12-14 20:07:37 --:--:-- pe-input-47 cibadmin root xen-d
-2012-12-14 20:07:37 20:07:42 pe-input-48 cibadmin root xen-d s-libvirt
-2012-12-14 20:07:54 20:07:56 pe-warn-272 cibadmin root xen-d d1 s-libvirt xen-d
-2012-12-14 20:07:56 20:07:57 pe-input-49 cibadmin root xen-d d1
-2012-12-14 20:08:43 20:08:43 pe-input-50 cibadmin root xen-d d1
-.INP: transitions
-Time Name Node Tags
-2012-12-14 20:06:57 - 20:06:57: pe-input-43 xen-e
-2012-12-14 20:07:19 - 20:07:23: pe-input-44 xen-e s-libvirt
-2012-12-14 20:07:29 - 20:07:29: pe-input-45 xen-e
-2012-12-14 20:07:29 - 20:07:29: pe-input-46 xen-e
-2012-12-14 20:07:37 - --:--:--: pe-input-47 xen-e
-2012-12-14 20:07:37 - 20:07:42: pe-input-48 xen-e s-libvirt
-2012-12-14 20:07:54 - 20:07:56: pe-warn-272 xen-e d1 s-libvirt xen-d
-2012-12-14 20:07:56 - 20:07:57: pe-input-49 xen-e d1
-2012-12-14 20:08:43 - 20:08:43: pe-input-50 xen-e d1
-.INP: refresh
-Refreshing log data...
-9 transitions, 87 events.
-.INP: resource d1
-Dec 14 20:07:19 xen-d lrmd: [5657]: info: rsc:d1 start[4] (pid 5833)
-Dec 14 20:07:19 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_start_0 (call=4, rc=0, cib-update=14, confirmed=true) ok
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 stop[6] (pid 5926)
-Dec 14 20:07:29 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_stop_0 (call=6, rc=0, cib-update=17, confirmed=true) ok
-Dec 14 20:07:29 xen-d lrmd: [5657]: info: rsc:d1 start[7] (pid 5929)
-Dec 14 20:07:29 xen-d crmd: [5660]: info: process_lrm_event: LRM operation d1_start_0 (call=7, rc=0, cib-update=18, confirmed=true) ok
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:56 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_start_0 (call=9, rc=0, cib-update=96, confirmed=true) ok
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 start[4] (pid 2405)
-Dec 14 20:08:26 xen-d crmd: [1948]: info: process_lrm_event: LRM operation d1_start_0 (call=4, rc=0, cib-update=9, confirmed=true) ok
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_stop_0 (call=11, rc=0, cib-update=125, confirmed=true) ok
-.INP: # reduce report span
-.INP: timeframe "2012-12-14 20:07:30"
-.INP: peinputs
-history-test/xen-e/pengine/pe-input-47.bz2
-history-test/xen-e/pengine/pe-input-48.bz2
-history-test/xen-e/pengine/pe-warn-272.bz2
-history-test/xen-e/pengine/pe-input-49.bz2
-history-test/xen-e/pengine/pe-input-50.bz2
-.INP: resource d1
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:56 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_start_0 (call=9, rc=0, cib-update=96, confirmed=true) ok
-Dec 14 20:08:26 xen-d lrmd: [1945]: info: rsc:d1 start[4] (pid 2405)
-Dec 14 20:08:26 xen-d crmd: [1948]: info: process_lrm_event: LRM operation d1_start_0 (call=4, rc=0, cib-update=9, confirmed=true) ok
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e crmd: [24228]: info: process_lrm_event: LRM operation d1_stop_0 (call=11, rc=0, cib-update=125, confirmed=true) ok
-.INP: exclude corosync|crmd|pengine|stonith-ng|cib|attrd|mgmtd|sshd
-.INP: transition log
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: cancel_op: operation monitor[10] on d1 for client 24228, its parameters: CRM_meta_name=[monitor] crm_feature_set=[3.0.6] CRM_meta_timeout=[30000] CRM_meta_interval=[5000] cancelled
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: operation stop[11] on d1 for client 24228: pid 24774 exited with return code 0
-Dec 14 20:08:43 xen-e external/libvirt(s-libvirt)[24748]: [24786]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-.INP: transition nograph
-INFO: 26: running ptest with history-test/xen-e/pengine/pe-input-50.bz2
-.EXT >/dev/null 2>&1 crm_simulate -x - -S -VV
-Transition xen-e:pe-input-50 (20:08:43 - 20:08:43):
- total 8 actions: 8 Complete
-Dec 14 20:08:43 xen-e lrmd: [24225]: info: rsc:d1 stop[11] (pid 24774)
-Dec 14 20:08:43 xen-e external/libvirt(s-libvirt)[24748]: [24786]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-.INP: transition -1 nograph
-INFO: 27: running ptest with history-test/xen-e/pengine/pe-input-49.bz2
-.EXT >/dev/null 2>&1 crm_simulate -x - -S -VV
-Transition xen-e:pe-input-49 (20:07:56 - 20:07:57):
- total 2 actions: 2 Complete
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:57 xen-e external/libvirt(s-libvirt)[24555]: [24588]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-.INP: transition save 0 _crmsh_regtest
-INFO: 28: transition history-test/xen-e/pengine/pe-input-50.bz2 saved to shadow _crmsh_regtest
-.INP: transition log 49
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: rsc:d1 start[9] (pid 24568)
-Dec 14 20:07:56 xen-e lrmd: [24225]: info: operation start[9] on d1 for client 24228: pid 24568 exited with return code 0
-Dec 14 20:07:57 xen-d logd: [6194]: debug: Stopping ha_logd with pid 1787
-Dec 14 20:07:57 xen-d logd: [6194]: info: Waiting for pid=1787 to exit
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: received SIGTERM
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: waiting for 0 messages to be read for process lrmd
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: waiting for 0 messages to be read by write process
-Dec 14 20:07:57 xen-d logd: [1787]: debug: logd_term_action: sending SIGTERM to write process
-Dec 14 20:07:57 xen-d logd: [1790]: info: logd_term_write_action: received SIGTERM
-Dec 14 20:07:57 xen-d logd: [1790]: debug: Writing out 0 messages then quitting
-Dec 14 20:07:57 xen-d logd: [1790]: info: Exiting write process
-Dec 14 20:07:57 xen-d haveged: haveged stopping due to signal 15
-Dec 14 20:07:57 xen-e lrmd: [24225]: info: rsc:d1 monitor[10] (pid 24577)
-Dec 14 20:07:57 xen-e lrmd: [24225]: info: operation monitor[10] on d1 for client 24228: pid 24577 exited with return code 0
-Dec 14 20:07:57 xen-e external/libvirt(s-libvirt)[24555]: [24588]: notice: xen+ssh://hex-12.suse.de/?keyfile=/root/.ssh/xen: Running hypervisor: Xen 4.1.0
-.INP: transition tags 49
-d1
-.INP: # reset timeframe
-.INP: timeframe
-.INP: session save _crmsh_regtest
-.EXT mkdir -p /var/cache/crm/history-root/session/_crmsh_regtest
-.INP: session load _crmsh_regtest
-.INP: session
-current session: _crmsh_regtest
-.INP: session pack
+Traceback (most recent call last):
+ File "/usr/sbin/crm", line 42, in <module>
+ rc = main.run()
+ File "/usr/lib/python3.6/site-packages/crmsh/main.py", line 362, in run
+ return main_input_loop(context, user_args)
+ File "/usr/lib/python3.6/site-packages/crmsh/main.py", line 259, in main_input_loop
+ if not context.run(inp):
+ File "/usr/lib/python3.6/site-packages/crmsh/ui_context.py", line 75, in run
+ rv = self.execute_command() is not False
+ File "/usr/lib/python3.6/site-packages/crmsh/ui_context.py", line 259, in execute_command
+ rv = self.command_info.function(*arglist)
+ File "/usr/lib/python3.6/site-packages/crmsh/ui_history.py", line 151, in do_info
+ return crm_report().info()
+ File "/usr/lib/python3.6/site-packages/crmsh/history.py", line 755, in info
+ if not self.prepare_source():
+ File "/usr/lib/python3.6/site-packages/crmsh/history.py", line 630, in prepare_source
+ self.report_setup()
+ File "/usr/lib/python3.6/site-packages/crmsh/history.py", line 604, in report_setup
+ self.logparser.scan()
+ File "/usr/lib/python3.6/site-packages/crmsh/logparser.py", line 305, in scan
+ return self._scan(mode=mode)
+ File "/usr/lib/python3.6/site-packages/crmsh/logparser.py", line 431, in _scan
+ self._save_cache()
+ File "/usr/lib/python3.6/site-packages/crmsh/logparser.py", line 613, in _save_cache
+ json.dump(self.to_dict(), f, indent=2)
+ File "/usr/lib64/python3.6/json/__init__.py", line 180, in dump
+ fp.write(chunk)
+TypeError: a bytes-like object is required, not 'str'
.TRY History 2
@@ -384,3 +37,9 @@
.INP: session load _crmsh_regtest
+ERROR: 2: history session _crmsh_regtest does not exist
.INP: exclude
-corosync|crmd|pengine|stonith-ng|cib|attrd|mgmtd|sshd
+.EXT mkdir -p /var/cache/crm/history-root
+INFO: 3: Retrieving information from cluster nodes, please wait...
+.EXT hb_report -Z -Q -f 'Wed Oct 25 07:22:07 2017' /var/cache/crm/history-root/live
+b''
+b'/bin/sh: /usr/share/crmsh/hb_report/hb_report: /usr/bin/python33: bad interpreter: No such file or directory\n'
+ERROR: 3: live: report failed
----------
Wed Oct 25 08:22:07 UTC 2017: END testcase history
Wed Oct 25 08:22:07 UTC 2017: BEGIN testcase newfeatures
Wed Oct 25 08:22:09 UTC 2017: END testcase newfeatures
Wed Oct 25 08:22:09 UTC 2017: BEGIN testcase commit
----------
testcase commit failed
output is in crmtestout/commit.out
diff (from crmtestout/commit.diff):
--- /usr/share/crmsh/tests/testcases/commit.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:22:10.890823400 +0000
@@ -29,13 +29,11 @@
.INP: rename p3 pp3
-INFO: 21: modified colocation:cl1 from p3 to pp3
INFO: 21: modified location:l1 from p3 to pp3
INFO: 21: modified order:o1 from p3 to pp3
+INFO: 21: modified colocation:cl1 from p3 to pp3
.INP: commit
.INP: rename pp3 p3
-INFO: 23: modified colocation:cl1 from pp3 to p3
INFO: 23: modified location:l1 from pp3 to p3
INFO: 23: modified order:o1 from pp3 to p3
+INFO: 23: modified colocation:cl1 from pp3 to p3
.INP: delete c1
-INFO: 24: modified colocation:cl1 from c1 to g1
-INFO: 24: modified order:o1 from c1 to g1
.INP: commit
@@ -45,6 +43,13 @@
.INP: commit
+INFO: 29: apparently there is nothing to commit
+INFO: 29: try changing something first
.INP: filter "sed '/g1/s/p1/d1/'"
+ERROR: 30: memoryview: a bytes-like object is required, not 'str'
+INFO: 30: from: sed '/g1/s/p1/d1/'
.INP: group g2 d3 d2
+ERROR: 31: Cannot create group with ID 'g2': Found existing group with same ID.
.INP: delete d2
.INP: commit
+INFO: 33: apparently there is nothing to commit
+INFO: 33: try changing something first
.INP: _test
@@ -56,2 +61,3 @@
primitive d1 Dummy
+primitive d2 Dummy
primitive d3 Dummy
@@ -68,7 +74,8 @@
op monitor interval=60m
-group g1 d1 p2
-group g2 d3
-colocation cl1 inf: g1 p3
+group g1 p1 p2
+group g2 d1 d2
+clone c1 g1
+colocation cl1 inf: c1 p3
location l1 p3 100: node1
-order o1 inf: p3 g1
+order o1 inf: p3 c1
property cib-bootstrap-options: \
----------
Wed Oct 25 08:22:10 UTC 2017: END testcase commit
Wed Oct 25 08:22:10 UTC 2017: BEGIN testcase bugs
----------
testcase bugs failed
output is in crmtestout/bugs.out
diff (from crmtestout/bugs.diff):
--- /usr/share/crmsh/tests/testcases/bugs.exp 2017-10-25 08:21:25.000000000 +0000
+++ - 2017-10-25 08:22:13.105434905 +0000
@@ -13,4 +13,6 @@
.INP: filter "sed 's/p1 p2/& p3/'" c1
+ERROR: 12: memoryview: a bytes-like object is required, not 'str'
+INFO: 12: from: sed 's/p1 p2/& p3/'
.INP: show c1
-colocation c1 inf: p1 p2 p3
+colocation c1 inf: p1 p2
.INP: delete c1
@@ -18,4 +20,6 @@
.INP: filter "sed 's/\[/\(/;s/\]/\)/'" c2
+ERROR: 16: memoryview: a bytes-like object is required, not 'str'
+INFO: 16: from: sed 's/\[/\(/;s/\]/\)/'
.INP: show c2
-colocation c2 inf: ( p1 p2 ) p3 p4
+colocation c2 inf: [ p1 p2 ] p3 p4
.INP: primitive p5 Dummy
@@ -37,3 +41,4 @@
clone cl-p5 p5
-colocation c2 inf: ( p1 p2 ) p3 p4
+colocation c1 inf: p1 p2
+colocation c2 inf: [ p1 p2 ] p3 p4
.INP: commit
@@ -59,3 +64,4 @@
clone cl-p5 p5
-colocation c2 inf: ( p1 p2 ) p3 p4
+colocation c1 inf: p1 p2
+colocation c2 inf: [ p1 p2 ] p3 p4
.TRY Unordered load file
@@ -84,3 +90,4 @@
clone cl-p5 p5
-colocation c2 inf: ( p1 p2 ) p3 p4
+colocation c1 inf: p1 p2
+colocation c2 inf: [ p1 p2 ] p3 p4
location loc1 g1 \
@@ -101,5 +108,5 @@
.INP: erase
-INFO: 2: modified location:loc1 from g1 to gr2
INFO: 2: constraint colocation:c2 updated
INFO: 2: constraint colocation:c2 updated
+INFO: 2: modified location:loc1 from g1 to gr2
.INP: primitive st stonith:null params hostlist='node1' meta description="some description here" op start requires=nothing op monitor interval=60m
----------
Wed Oct 25 08:22:13 UTC 2017: END testcase bugs
Wed Oct 25 08:22:13 UTC 2017: BEGIN testcase scripts
Wed Oct 25 08:22:15 UTC 2017: END testcase scripts
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment