3 ! expect signal SIGABRT
5 $ ${bindir:=.}/bugged1_liveness ${bindir:=.}/../msg_platform.xml ${bindir:=.}/deploy_bugged1_liveness_visited.xml --cfg=model-check:1 "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n" --cfg=contexts/factory:ucontext --cfg=model-check/visited:100
6 > [ 0.000000] (0:@) Configuration change: Set 'model-check' to '1'
7 > [ 0.000000] (0:@) Configuration change: Set 'model-check/visited' to '100'
8 > [ 0.000000] (0:@) Check the liveness property promela_bugged1_liveness
9 > [ 0.000000] (0:@) Get debug information ...
10 > [ 0.000000] (0:@) Get debug information done !
11 > [ 0.000000] (2:client@Boivin) Ask the request
12 > [ 0.000000] (3:client@Fafard) Ask the request
13 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
14 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
15 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
16 > [ 0.000000] (2:client@Boivin) Ask the request
17 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
18 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
19 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
20 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
21 > [ 0.000000] (2:client@Boivin) Ask the request
22 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
23 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
24 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
25 > [ 0.000000] (2:client@Boivin) Ask the request
26 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
27 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
28 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
29 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
30 > [ 0.000000] (2:client@Boivin) Ask the request
31 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
32 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
33 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
34 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
35 > [ 0.000000] (2:client@Boivin) Ask the request
36 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
37 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
38 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
39 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
40 > [ 0.000000] (2:client@Boivin) Ask the request
41 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
42 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
43 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
44 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
45 > [ 0.000000] (2:client@Boivin) Ask the request
46 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
47 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
48 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
49 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
50 > [ 0.000000] (2:client@Boivin) Ask the request
51 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
52 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
53 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
54 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
55 > [ 0.000000] (2:client@Boivin) Ask the request
56 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
57 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
58 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
59 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
60 > [ 0.000000] (2:client@Boivin) Ask the request
61 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
62 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
63 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
64 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
65 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
66 > [ 0.000000] (2:client@Boivin) Ask the request
67 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
68 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
69 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
70 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
71 > [ 0.000000] (2:client@Boivin) Ask the request
72 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
73 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
74 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
75 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
76 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
77 > [ 0.000000] (2:client@Boivin) Ask the request
78 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
79 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
80 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
81 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
82 > [ 0.000000] (2:client@Boivin) Ask the request
83 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
84 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
85 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
86 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
87 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
88 > [ 0.000000] (2:client@Boivin) Ask the request
89 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
90 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
91 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
92 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
93 > [ 0.000000] (2:client@Boivin) Ask the request
94 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
95 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
96 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
97 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
98 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
99 > [ 0.000000] (2:client@Boivin) Ask the request
100 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
101 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
102 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
103 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
104 > [ 0.000000] (2:client@Boivin) Ask the request
105 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
106 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
107 > [ 0.000000] (3:client@Fafard) Propositions changed : r=1, cs=0
108 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
109 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
110 > [ 0.000000] (1:coordinator@Tremblay) CS release. resource now idle
111 > [ 0.000000] (2:client@Boivin) Ask the request
112 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
113 > [ 0.000000] (1:coordinator@Tremblay) CS already used. Queue the request.
114 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
115 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
116 > [ 0.000000] (2:client@Boivin) Ask the request
117 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
118 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
119 > [ 0.000000] (3:client@Fafard) Propositions changed : r=1, cs=0
120 > [ 0.000000] (1:coordinator@Tremblay) CS release. Grant to queued requests (queue size: 1)
121 > [ 0.000000] (2:client@Boivin) Ask the request
122 > [ 0.000000] (1:coordinator@Tremblay) CS idle. Grant immediatly
123 > [ 0.000000] (2:client@Boivin) 2 got the answer. Sleep a bit and release it
124 > [ 0.000000] (0:@) Pair 57 already reached (equal to pair 45) !
125 > [ 0.000000] (0:@) *-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*
126 > [ 0.000000] (0:@) | ACCEPTANCE CYCLE |
127 > [ 0.000000] (0:@) *-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*-*
128 > [ 0.000000] (0:@) Counter-example that violates formula :
129 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
130 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
131 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
132 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iSend(src=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (54)
133 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
134 > [ 0.000000] (0:@) [(2)Boivin (client)] iRecv(dst=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (56)
135 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
136 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
137 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
138 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
139 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
140 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
141 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
142 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
143 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
144 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
145 > [ 0.000000] (0:@) [(2)Boivin (client)] iRecv(dst=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (56)
146 > [ 0.000000] (0:@) [(3)Fafard (client)] iSend(src=(3)Fafard (client), buff=(verbose only), size=(verbose only)) (54)
147 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iSend(src=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (54)
148 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
149 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
150 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(3)Fafard (client)-> (1)Tremblay (coordinator)]) (62)
151 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
152 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
153 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
154 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
155 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
156 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
157 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
158 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
159 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iSend(src=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (54)
160 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
161 > [ 0.000000] (0:@) [(2)Boivin (client)] iRecv(dst=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (56)
162 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
163 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
164 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
165 > [ 0.000000] (0:@) [(3)Fafard (client)] Wait(comm=(verbose only) [(3)Fafard (client)-> (1)Tremblay (coordinator)]) (62)
166 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
167 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
168 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
169 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
170 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
171 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
172 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iSend(src=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (54)
173 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(2)Boivin (client)-> (1)Tremblay (coordinator)]) (62)
174 > [ 0.000000] (0:@) [(2)Boivin (client)] iRecv(dst=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (56)
175 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
176 > [ 0.000000] (0:@) [(1)Tremblay (coordinator)] iRecv(dst=(1)Tremblay (coordinator), buff=(verbose only), size=(verbose only)) (56)
177 > [ 0.000000] (0:@) [(2)Boivin (client)] Wait(comm=(verbose only) [(1)Tremblay (coordinator)-> (2)Boivin (client)]) (62)
178 > [ 0.000000] (0:@) [(2)Boivin (client)] iSend(src=(2)Boivin (client), buff=(verbose only), size=(verbose only)) (54)
179 > [ 0.000000] (0:@) Expanded pairs = 57
180 > [ 0.000000] (0:@) Visited pairs = 365
181 > [ 0.000000] (0:@) Executed transitions = 364