Commit | Line | Data |
---|---|---|
b6b17880 MD |
1 | make[1]: Entering directory `/home/compudj/doc/userspace-rcu/formal-model/urcu-controldataflow-min-progress' |
2 | rm -f pan* trail.out .input.spin* *.spin.trail .input.define | |
3 | touch .input.define | |
4 | cat .input.define > pan.ltl | |
5 | cat DEFINES >> pan.ltl | |
6 | spin -f "!(`cat urcu_progress.ltl | grep -v ^//`)" >> pan.ltl | |
7 | cp urcu_progress_writer_error.define .input.define | |
8 | cat .input.define > .input.spin | |
9 | cat DEFINES >> .input.spin | |
10 | cat urcu.spin >> .input.spin | |
11 | rm -f .input.spin.trail | |
12 | spin -a -X -N pan.ltl .input.spin | |
13 | Exit-Status 0 | |
14 | gcc -O2 -w -DHASH64 -DCOLLAPSE -o pan pan.c | |
15 | ./pan -a -f -v -c1 -X -m10000000 -w20 | |
16 | warning: for p.o. reduction to be valid the never claim must be stutter-invariant | |
17 | (never claims generated from LTL formulae are stutter-invariant) | |
18 | depth 0: Claim reached state 5 (line 1180) | |
19 | depth 7: Claim reached state 9 (line 1185) | |
20 | depth 46: Claim reached state 9 (line 1184) | |
21 | pan: acceptance cycle (at depth 3798) | |
22 | pan: wrote .input.spin.trail | |
23 | ||
24 | (Spin Version 5.1.7 -- 23 December 2008) | |
25 | Warning: Search not completed | |
26 | + Partial Order Reduction | |
27 | + Compression | |
28 | ||
29 | Full statespace search for: | |
30 | never claim + | |
31 | assertion violations + (if within scope of claim) | |
32 | acceptance cycles + (fairness enabled) | |
33 | invalid end states - (disabled by never claim) | |
34 | ||
35 | State-vector 80 byte, depth reached 3956, errors: 1 | |
36 | 139740 states, stored (233412 visited) | |
37 | 43234612 states, matched | |
38 | 43468024 transitions (= visited+matched) | |
39 | 2.3201732e+08 atomic steps | |
40 | hash conflicts: 937081 (resolved) | |
41 | ||
42 | Stats on memory usage (in Megabytes): | |
43 | 15.459 equivalent memory usage for states (stored*(State-vector + overhead)) | |
44 | 7.007 actual memory usage for states (compression: 45.33%) | |
45 | state-vector as stored = 17 byte + 36 byte overhead | |
46 | 8.000 memory used for hash table (-w20) | |
47 | 457.764 memory used for DFS stack (-m10000000) | |
48 | 472.697 total actual memory usage | |
49 | ||
50 | nr of templates: [ globals chans procs ] | |
51 | collapse counts: [ 1001 532 228 2 2 ] | |
52 | unreached in proctype urcu_reader | |
53 | line 269, "pan.___", state 55, "cache_dirty_urcu_gp_ctr = 0" | |
54 | line 277, "pan.___", state 77, "cache_dirty_rcu_ptr = 0" | |
55 | line 281, "pan.___", state 86, "cache_dirty_rcu_data[i] = 0" | |
56 | line 246, "pan.___", state 102, "(1)" | |
57 | line 250, "pan.___", state 110, "(1)" | |
58 | line 254, "pan.___", state 122, "(1)" | |
59 | line 258, "pan.___", state 130, "(1)" | |
60 | line 405, "pan.___", state 156, "cache_dirty_urcu_gp_ctr = 0" | |
61 | line 414, "pan.___", state 188, "cache_dirty_rcu_ptr = 0" | |
62 | line 418, "pan.___", state 202, "cache_dirty_rcu_data[i] = 0" | |
63 | line 423, "pan.___", state 221, "(1)" | |
64 | line 432, "pan.___", state 251, "(1)" | |
65 | line 436, "pan.___", state 264, "(1)" | |
66 | line 615, "pan.___", state 285, "_proc_urcu_reader = (_proc_urcu_reader|((1<<2)<<1))" | |
67 | line 405, "pan.___", state 292, "cache_dirty_urcu_gp_ctr = 0" | |
68 | line 414, "pan.___", state 324, "cache_dirty_rcu_ptr = 0" | |
69 | line 418, "pan.___", state 338, "cache_dirty_rcu_data[i] = 0" | |
70 | line 423, "pan.___", state 357, "(1)" | |
71 | line 432, "pan.___", state 387, "(1)" | |
72 | line 436, "pan.___", state 400, "(1)" | |
73 | line 405, "pan.___", state 421, "cache_dirty_urcu_gp_ctr = 0" | |
74 | line 414, "pan.___", state 453, "cache_dirty_rcu_ptr = 0" | |
75 | line 418, "pan.___", state 467, "cache_dirty_rcu_data[i] = 0" | |
76 | line 423, "pan.___", state 486, "(1)" | |
77 | line 432, "pan.___", state 516, "(1)" | |
78 | line 436, "pan.___", state 529, "(1)" | |
79 | line 405, "pan.___", state 552, "cache_dirty_urcu_gp_ctr = 0" | |
80 | line 405, "pan.___", state 554, "(1)" | |
81 | line 405, "pan.___", state 555, "(cache_dirty_urcu_gp_ctr)" | |
82 | line 405, "pan.___", state 555, "else" | |
83 | line 405, "pan.___", state 558, "(1)" | |
84 | line 409, "pan.___", state 566, "cache_dirty_urcu_active_readers = 0" | |
85 | line 409, "pan.___", state 568, "(1)" | |
86 | line 409, "pan.___", state 569, "(cache_dirty_urcu_active_readers)" | |
87 | line 409, "pan.___", state 569, "else" | |
88 | line 409, "pan.___", state 572, "(1)" | |
89 | line 409, "pan.___", state 573, "(1)" | |
90 | line 409, "pan.___", state 573, "(1)" | |
91 | line 407, "pan.___", state 578, "((i<1))" | |
92 | line 407, "pan.___", state 578, "((i>=1))" | |
93 | line 414, "pan.___", state 584, "cache_dirty_rcu_ptr = 0" | |
94 | line 414, "pan.___", state 586, "(1)" | |
95 | line 414, "pan.___", state 587, "(cache_dirty_rcu_ptr)" | |
96 | line 414, "pan.___", state 587, "else" | |
97 | line 414, "pan.___", state 590, "(1)" | |
98 | line 414, "pan.___", state 591, "(1)" | |
99 | line 414, "pan.___", state 591, "(1)" | |
100 | line 418, "pan.___", state 598, "cache_dirty_rcu_data[i] = 0" | |
101 | line 418, "pan.___", state 600, "(1)" | |
102 | line 418, "pan.___", state 601, "(cache_dirty_rcu_data[i])" | |
103 | line 418, "pan.___", state 601, "else" | |
104 | line 418, "pan.___", state 604, "(1)" | |
105 | line 418, "pan.___", state 605, "(1)" | |
106 | line 418, "pan.___", state 605, "(1)" | |
107 | line 416, "pan.___", state 610, "((i<2))" | |
108 | line 416, "pan.___", state 610, "((i>=2))" | |
109 | line 423, "pan.___", state 617, "(1)" | |
110 | line 423, "pan.___", state 618, "(!(cache_dirty_urcu_gp_ctr))" | |
111 | line 423, "pan.___", state 618, "else" | |
112 | line 423, "pan.___", state 621, "(1)" | |
113 | line 423, "pan.___", state 622, "(1)" | |
114 | line 423, "pan.___", state 622, "(1)" | |
115 | line 427, "pan.___", state 630, "(1)" | |
116 | line 427, "pan.___", state 631, "(!(cache_dirty_urcu_active_readers))" | |
117 | line 427, "pan.___", state 631, "else" | |
118 | line 427, "pan.___", state 634, "(1)" | |
119 | line 427, "pan.___", state 635, "(1)" | |
120 | line 427, "pan.___", state 635, "(1)" | |
121 | line 425, "pan.___", state 640, "((i<1))" | |
122 | line 425, "pan.___", state 640, "((i>=1))" | |
123 | line 432, "pan.___", state 647, "(1)" | |
124 | line 432, "pan.___", state 648, "(!(cache_dirty_rcu_ptr))" | |
125 | line 432, "pan.___", state 648, "else" | |
126 | line 432, "pan.___", state 651, "(1)" | |
127 | line 432, "pan.___", state 652, "(1)" | |
128 | line 432, "pan.___", state 652, "(1)" | |
129 | line 436, "pan.___", state 660, "(1)" | |
130 | line 436, "pan.___", state 661, "(!(cache_dirty_rcu_data[i]))" | |
131 | line 436, "pan.___", state 661, "else" | |
132 | line 436, "pan.___", state 664, "(1)" | |
133 | line 436, "pan.___", state 665, "(1)" | |
134 | line 436, "pan.___", state 665, "(1)" | |
135 | line 434, "pan.___", state 670, "((i<2))" | |
136 | line 434, "pan.___", state 670, "((i>=2))" | |
137 | line 444, "pan.___", state 674, "(1)" | |
138 | line 444, "pan.___", state 674, "(1)" | |
139 | line 615, "pan.___", state 677, "cached_urcu_active_readers = (tmp+1)" | |
140 | line 615, "pan.___", state 678, "_proc_urcu_reader = (_proc_urcu_reader|(1<<5))" | |
141 | line 615, "pan.___", state 679, "(1)" | |
142 | line 405, "pan.___", state 686, "cache_dirty_urcu_gp_ctr = 0" | |
143 | line 414, "pan.___", state 718, "cache_dirty_rcu_ptr = 0" | |
144 | line 418, "pan.___", state 732, "cache_dirty_rcu_data[i] = 0" | |
145 | line 423, "pan.___", state 751, "(1)" | |
146 | line 432, "pan.___", state 781, "(1)" | |
147 | line 436, "pan.___", state 794, "(1)" | |
148 | line 405, "pan.___", state 821, "cache_dirty_urcu_gp_ctr = 0" | |
149 | line 414, "pan.___", state 853, "cache_dirty_rcu_ptr = 0" | |
150 | line 418, "pan.___", state 867, "cache_dirty_rcu_data[i] = 0" | |
151 | line 423, "pan.___", state 886, "(1)" | |
152 | line 432, "pan.___", state 916, "(1)" | |
153 | line 436, "pan.___", state 929, "(1)" | |
154 | line 405, "pan.___", state 950, "cache_dirty_urcu_gp_ctr = 0" | |
155 | line 414, "pan.___", state 982, "cache_dirty_rcu_ptr = 0" | |
156 | line 418, "pan.___", state 996, "cache_dirty_rcu_data[i] = 0" | |
157 | line 423, "pan.___", state 1015, "(1)" | |
158 | line 432, "pan.___", state 1045, "(1)" | |
159 | line 436, "pan.___", state 1058, "(1)" | |
160 | line 246, "pan.___", state 1091, "(1)" | |
161 | line 254, "pan.___", state 1111, "(1)" | |
162 | line 258, "pan.___", state 1119, "(1)" | |
163 | line 749, "pan.___", state 1136, "-end-" | |
164 | (91 of 1136 states) | |
165 | unreached in proctype urcu_writer | |
166 | line 405, "pan.___", state 45, "cache_dirty_urcu_gp_ctr = 0" | |
167 | line 409, "pan.___", state 59, "cache_dirty_urcu_active_readers = 0" | |
168 | line 414, "pan.___", state 77, "cache_dirty_rcu_ptr = 0" | |
169 | line 423, "pan.___", state 110, "(1)" | |
170 | line 427, "pan.___", state 123, "(1)" | |
171 | line 432, "pan.___", state 140, "(1)" | |
172 | line 269, "pan.___", state 176, "cache_dirty_urcu_gp_ctr = 0" | |
173 | line 273, "pan.___", state 185, "cache_dirty_urcu_active_readers = 0" | |
174 | line 277, "pan.___", state 198, "cache_dirty_rcu_ptr = 0" | |
175 | line 405, "pan.___", state 238, "cache_dirty_urcu_gp_ctr = 0" | |
176 | line 409, "pan.___", state 252, "cache_dirty_urcu_active_readers = 0" | |
177 | line 414, "pan.___", state 270, "cache_dirty_rcu_ptr = 0" | |
178 | line 418, "pan.___", state 284, "cache_dirty_rcu_data[i] = 0" | |
179 | line 423, "pan.___", state 303, "(1)" | |
180 | line 427, "pan.___", state 316, "(1)" | |
181 | line 432, "pan.___", state 333, "(1)" | |
182 | line 436, "pan.___", state 346, "(1)" | |
183 | line 409, "pan.___", state 383, "cache_dirty_urcu_active_readers = 0" | |
184 | line 414, "pan.___", state 401, "cache_dirty_rcu_ptr = 0" | |
185 | line 418, "pan.___", state 415, "cache_dirty_rcu_data[i] = 0" | |
186 | line 427, "pan.___", state 447, "(1)" | |
187 | line 432, "pan.___", state 464, "(1)" | |
188 | line 436, "pan.___", state 477, "(1)" | |
189 | line 405, "pan.___", state 504, "cache_dirty_urcu_gp_ctr = 0" | |
190 | line 405, "pan.___", state 506, "(1)" | |
191 | line 405, "pan.___", state 507, "(cache_dirty_urcu_gp_ctr)" | |
192 | line 405, "pan.___", state 507, "else" | |
193 | line 405, "pan.___", state 510, "(1)" | |
194 | line 409, "pan.___", state 518, "cache_dirty_urcu_active_readers = 0" | |
195 | line 409, "pan.___", state 520, "(1)" | |
196 | line 409, "pan.___", state 521, "(cache_dirty_urcu_active_readers)" | |
197 | line 409, "pan.___", state 521, "else" | |
198 | line 409, "pan.___", state 524, "(1)" | |
199 | line 409, "pan.___", state 525, "(1)" | |
200 | line 409, "pan.___", state 525, "(1)" | |
201 | line 407, "pan.___", state 530, "((i<1))" | |
202 | line 407, "pan.___", state 530, "((i>=1))" | |
203 | line 414, "pan.___", state 536, "cache_dirty_rcu_ptr = 0" | |
204 | line 414, "pan.___", state 538, "(1)" | |
205 | line 414, "pan.___", state 539, "(cache_dirty_rcu_ptr)" | |
206 | line 414, "pan.___", state 539, "else" | |
207 | line 414, "pan.___", state 542, "(1)" | |
208 | line 414, "pan.___", state 543, "(1)" | |
209 | line 414, "pan.___", state 543, "(1)" | |
210 | line 418, "pan.___", state 550, "cache_dirty_rcu_data[i] = 0" | |
211 | line 418, "pan.___", state 552, "(1)" | |
212 | line 418, "pan.___", state 553, "(cache_dirty_rcu_data[i])" | |
213 | line 418, "pan.___", state 553, "else" | |
214 | line 418, "pan.___", state 556, "(1)" | |
215 | line 418, "pan.___", state 557, "(1)" | |
216 | line 418, "pan.___", state 557, "(1)" | |
217 | line 416, "pan.___", state 562, "((i<2))" | |
218 | line 416, "pan.___", state 562, "((i>=2))" | |
219 | line 423, "pan.___", state 569, "(1)" | |
220 | line 423, "pan.___", state 570, "(!(cache_dirty_urcu_gp_ctr))" | |
221 | line 423, "pan.___", state 570, "else" | |
222 | line 423, "pan.___", state 573, "(1)" | |
223 | line 423, "pan.___", state 574, "(1)" | |
224 | line 423, "pan.___", state 574, "(1)" | |
225 | line 427, "pan.___", state 582, "(1)" | |
226 | line 427, "pan.___", state 583, "(!(cache_dirty_urcu_active_readers))" | |
227 | line 427, "pan.___", state 583, "else" | |
228 | line 427, "pan.___", state 586, "(1)" | |
229 | line 427, "pan.___", state 587, "(1)" | |
230 | line 427, "pan.___", state 587, "(1)" | |
231 | line 425, "pan.___", state 592, "((i<1))" | |
232 | line 425, "pan.___", state 592, "((i>=1))" | |
233 | line 432, "pan.___", state 599, "(1)" | |
234 | line 432, "pan.___", state 600, "(!(cache_dirty_rcu_ptr))" | |
235 | line 432, "pan.___", state 600, "else" | |
236 | line 432, "pan.___", state 603, "(1)" | |
237 | line 432, "pan.___", state 604, "(1)" | |
238 | line 432, "pan.___", state 604, "(1)" | |
239 | line 436, "pan.___", state 612, "(1)" | |
240 | line 436, "pan.___", state 613, "(!(cache_dirty_rcu_data[i]))" | |
241 | line 436, "pan.___", state 613, "else" | |
242 | line 436, "pan.___", state 616, "(1)" | |
243 | line 436, "pan.___", state 617, "(1)" | |
244 | line 436, "pan.___", state 617, "(1)" | |
245 | line 444, "pan.___", state 626, "(1)" | |
246 | line 444, "pan.___", state 626, "(1)" | |
247 | line 409, "pan.___", state 646, "cache_dirty_urcu_active_readers = 0" | |
248 | line 414, "pan.___", state 664, "cache_dirty_rcu_ptr = 0" | |
249 | line 418, "pan.___", state 678, "cache_dirty_rcu_data[i] = 0" | |
250 | line 427, "pan.___", state 710, "(1)" | |
251 | line 432, "pan.___", state 727, "(1)" | |
252 | line 436, "pan.___", state 740, "(1)" | |
253 | line 409, "pan.___", state 775, "cache_dirty_urcu_active_readers = 0" | |
254 | line 414, "pan.___", state 793, "cache_dirty_rcu_ptr = 0" | |
255 | line 418, "pan.___", state 807, "cache_dirty_rcu_data[i] = 0" | |
256 | line 427, "pan.___", state 839, "(1)" | |
257 | line 432, "pan.___", state 856, "(1)" | |
258 | line 436, "pan.___", state 869, "(1)" | |
259 | line 409, "pan.___", state 906, "cache_dirty_urcu_active_readers = 0" | |
260 | line 414, "pan.___", state 924, "cache_dirty_rcu_ptr = 0" | |
261 | line 418, "pan.___", state 938, "cache_dirty_rcu_data[i] = 0" | |
262 | line 427, "pan.___", state 970, "(1)" | |
263 | line 432, "pan.___", state 987, "(1)" | |
264 | line 436, "pan.___", state 1000, "(1)" | |
265 | line 409, "pan.___", state 1040, "cache_dirty_urcu_active_readers = 0" | |
266 | line 414, "pan.___", state 1058, "cache_dirty_rcu_ptr = 0" | |
267 | line 418, "pan.___", state 1072, "cache_dirty_rcu_data[i] = 0" | |
268 | line 427, "pan.___", state 1104, "(1)" | |
269 | line 432, "pan.___", state 1121, "(1)" | |
270 | line 436, "pan.___", state 1134, "(1)" | |
271 | line 269, "pan.___", state 1180, "cache_dirty_urcu_gp_ctr = 0" | |
272 | line 273, "pan.___", state 1189, "cache_dirty_urcu_active_readers = 0" | |
273 | line 277, "pan.___", state 1204, "(1)" | |
274 | line 281, "pan.___", state 1211, "cache_dirty_rcu_data[i] = 0" | |
275 | line 246, "pan.___", state 1227, "(1)" | |
276 | line 250, "pan.___", state 1235, "(1)" | |
277 | line 254, "pan.___", state 1247, "(1)" | |
278 | line 258, "pan.___", state 1255, "(1)" | |
279 | line 269, "pan.___", state 1286, "cache_dirty_urcu_gp_ctr = 0" | |
280 | line 273, "pan.___", state 1295, "cache_dirty_urcu_active_readers = 0" | |
281 | line 277, "pan.___", state 1308, "cache_dirty_rcu_ptr = 0" | |
282 | line 281, "pan.___", state 1317, "cache_dirty_rcu_data[i] = 0" | |
283 | line 246, "pan.___", state 1333, "(1)" | |
284 | line 250, "pan.___", state 1341, "(1)" | |
285 | line 254, "pan.___", state 1353, "(1)" | |
286 | line 258, "pan.___", state 1361, "(1)" | |
287 | line 273, "pan.___", state 1387, "cache_dirty_urcu_active_readers = 0" | |
288 | line 277, "pan.___", state 1400, "cache_dirty_rcu_ptr = 0" | |
289 | line 281, "pan.___", state 1409, "cache_dirty_rcu_data[i] = 0" | |
290 | line 246, "pan.___", state 1425, "(1)" | |
291 | line 250, "pan.___", state 1433, "(1)" | |
292 | line 254, "pan.___", state 1445, "(1)" | |
293 | line 258, "pan.___", state 1453, "(1)" | |
294 | line 269, "pan.___", state 1484, "cache_dirty_urcu_gp_ctr = 0" | |
295 | line 273, "pan.___", state 1493, "cache_dirty_urcu_active_readers = 0" | |
296 | line 277, "pan.___", state 1506, "cache_dirty_rcu_ptr = 0" | |
297 | line 281, "pan.___", state 1515, "cache_dirty_rcu_data[i] = 0" | |
298 | line 246, "pan.___", state 1531, "(1)" | |
299 | line 250, "pan.___", state 1539, "(1)" | |
300 | line 254, "pan.___", state 1551, "(1)" | |
301 | line 258, "pan.___", state 1559, "(1)" | |
302 | line 1124, "pan.___", state 1575, "-end-" | |
303 | (118 of 1575 states) | |
304 | unreached in proctype :init: | |
305 | (0 of 26 states) | |
306 | unreached in proctype :never: | |
307 | line 1187, "pan.___", state 11, "-end-" | |
308 | (1 of 11 states) | |
309 | ||
310 | pan: elapsed time 67.7 seconds | |
311 | pan: rate 3447.2308 states/second | |
312 | pan: avg transition delay 1.5577e-06 usec | |
313 | cp .input.spin urcu_progress_writer_error.spin.input | |
314 | cp .input.spin.trail urcu_progress_writer_error.spin.input.trail | |
315 | make[1]: Leaving directory `/home/compudj/doc/userspace-rcu/formal-model/urcu-controldataflow-min-progress' |