Test output for hopefully [ok]

Testing time: 58s

'/home/chicken/salmonella/build/salmonella-run-publish/chicken/bin/csi' -script run.scm < /dev/null 2>&1
D CALL: #<procedure>
D Initial: set
D Value in other thread is unchanged...: 13
D #<thread: thread557>: also in other thread former ref is still unchanged...
D even after commit.  (Note: tests caching of references to fields.): 13
D Value in other thread is unchanged...: 13
D Second round expecting changed value: 252
D #<thread: thread557>: also in other thread former ref is still unchanged...
D even after commit.  (Note: tests caching of references to fields.): 13
NOTE: Duplicate reference checking was disabled for hopefully.
T2 x(b2) cc 2 6
T1 x(b1) cc 2 7
T2 y(b1) cc 2 7
D T2Set: 65
T1 y(b2) cc 2 6
D T1Set: 42
T2 trying now to commit cc 2 65
T2 done at count cc -2 -2
T1 trying now to commit cc -2 42
T1 x(b1) cc -3 7
T1 y(b2) cc -3 65
D T1Set: 455
T1 trying now to commit cc -3 455
D M1: not-owned
D M2: not-abandoned
T 25 K a: (#<procedure (print-change t)>)
T 25 K b: (#<procedure (print-change t)>)
Prepare from 23 42
Prepare to   11 12
Commit from 23 42
Commit to   11 12
Phase I trigger #<procedure (?)> returns #<procedure (?)>
Post transaction triggers: (#<procedure (?)> #<procedure (?)>)
Consequence 11 12
T 27 K a: (#<procedure (print-change t)>)
T 27 K b: (#<procedure (print-change t)>)
Prepare from 11 12
Prepare to   3 5
Commit from 11 12
Commit to   3 5
Phase I trigger #<procedure (?)> returns #<procedure (?)>
Post transaction triggers: (#<procedure (?)> #<procedure (?)>)
Consequence 3 5
Testing without current transaction
Change to 11 and 12
T 29 K a: (#<procedure (print-change t)>)
T 29 K b: (#<procedure (print-change t)>)
Prepare from 3 5
Prepare to   11 12
Commit from 3 5
Commit to   11 12
Phase I trigger #<procedure (?)> returns #<procedure (?)>
Post transaction triggers: (#<procedure (?)> #<procedure (?)>)
Consequence 11 12
T 31 K a: (#<procedure (print-change t)>)
T 31 K b: (#<procedure (print-change t)>)
Prepare from 11 12
Prepare to   11 12
Commit from 11 12
Commit to   11 12
Phase I trigger #<procedure (?)> returns #<procedure (?)>
Post transaction triggers: (#<procedure (?)> #<procedure (?)>)
Consequence 3 5
Simple record access 20000 op in 250.0 ms (80.0 op/ms)
AC record access outside 20000 op in 344.0 ms (58.1395348837209 op/ms)
AC record access in trans 20000 op in 346.0 ms (57.8034682080925 op/ms)
Heavy record access in trans 20000 op in 234.0 ms (85.4700854700855 op/ms)
Simple record access 20000 op in 268.0 ms (74.6268656716418 op/ms)
AC record access outside 20000 op in 336.0 ms (59.5238095238095 op/ms)
AC record access in trans 20000 op in 342.0 ms (58.4795321637427 op/ms)
Heavy record access in trans 20000 op in 233.0 ms (85.8369098712446 op/ms)
Simple record access 20000 op in 281.0 ms (71.1743772241993 op/ms)
AC record access outside 20000 op in 349.0 ms (57.3065902578797 op/ms)
AC record access in trans 20000 op in 339.0 ms (58.9970501474926 op/ms)
Heavy record access in trans 20000 op in 235.0 ms (85.1063829787234 op/ms)
Simple record access 20000 op in 279.0 ms (71.6845878136201 op/ms)
AC record access outside 20000 op in 353.0 ms (56.657223796034 op/ms)
AC record access in trans 20000 op in 352.0 ms (56.8181818181818 op/ms)
Heavy record access in trans 20000 op in 250.0 ms (80.0 op/ms)
Simple record access 20000 op in 288.0 ms (69.4444444444444 op/ms)
AC record access outside 20000 op in 358.0 ms (55.8659217877095 op/ms)
AC record access in trans 20000 op in 359.0 ms (55.7103064066852 op/ms)
Heavy record access in trans 20000 op in 243.0 ms (82.3045267489712 op/ms)
Simple record access 20000 op in 292.0 ms (68.4931506849315 op/ms)
AC record access outside 20000 op in 363.0 ms (55.0964187327824 op/ms)
AC record access in trans 20000 op in 362.0 ms (55.2486187845304 op/ms)
Heavy record access in trans 20000 op in 245.0 ms (81.6326530612245 op/ms)
Simple record access 20000 op in 290.0 ms (68.9655172413793 op/ms)
AC record access outside 20000 op in 360.0 ms (55.5555555555556 op/ms)
AC record access in trans 20000 op in 373.0 ms (53.6193029490617 op/ms)
Heavy record access in trans 20000 op in 241.0 ms (82.9875518672199 op/ms)
Simple record access 20000 op in 293.0 ms (68.259385665529 op/ms)
AC record access outside 20000 op in 360.0 ms (55.5555555555556 op/ms)
AC record access in trans 20000 op in 350.0 ms (57.1428571428571 op/ms)
Heavy record access in trans 20000 op in 251.0 ms (79.6812749003984 op/ms)
Simple record access 20000 op in 279.0 ms (71.6845878136201 op/ms)
AC record access outside 20000 op in 363.0 ms (55.0964187327824 op/ms)
AC record access in trans 20000 op in 365.0 ms (54.7945205479452 op/ms)
Heavy record access in trans 20000 op in 247.0 ms (80.9716599190283 op/ms)
Simple record access 20000 op in 305.0 ms (65.5737704918033 op/ms)
AC record access outside 20000 op in 366.0 ms (54.6448087431694 op/ms)
AC record access in trans 20000 op in 362.0 ms (55.2486187845304 op/ms)
Heavy record access in trans 20000 op in 246.0 ms (81.3008130081301 op/ms)
Locking 20000 op in 773.0 ms (25.8732212160414 op/ms)
Optimistic 20000 op in 598.0 ms (33.4448160535117 op/ms)
Locking with parameter usage
Locking 20000 op in 1489.0 ms (13.4318334452653 op/ms)
Optimistic/current 20000 op in 774.0 ms (25.8397932816537 op/ms)
Optimistic/heavy 20000 op in 614.0 ms (32.5732899022801 op/ms)
Locking 20000 op in 784.0 ms (25.5102040816327 op/ms)
Optimistic 20000 op in 609.0 ms (32.8407224958949 op/ms)
Locking with parameter usage
Locking 20000 op in 1504.0 ms (13.2978723404255 op/ms)
Optimistic/current 20000 op in 868.0 ms (23.0414746543779 op/ms)
Optimistic/heavy 20000 op in 678.0 ms (29.4985250737463 op/ms)
Locking 20000 op in 838.0 ms (23.8663484486874 op/ms)
Optimistic 20000 op in 603.0 ms (33.167495854063 op/ms)
Locking with parameter usage
Locking 20000 op in 1531.0 ms (13.0633572828217 op/ms)
Optimistic/current 20000 op in 826.0 ms (24.2130750605327 op/ms)
Optimistic/heavy 20000 op in 679.0 ms (29.4550810014728 op/ms)
Locking 20000 op in 844.0 ms (23.696682464455 op/ms)
Optimistic 20000 op in 599.0 ms (33.3889816360601 op/ms)
Locking with parameter usage
Locking 20000 op in 1527.0 ms (13.0975769482646 op/ms)
Optimistic/current 20000 op in 822.0 ms (24.330900243309 op/ms)
Optimistic/heavy 20000 op in 642.0 ms (31.1526D Done: success
479750779 op/ms)
Locking 20000 op in 833.0 ms (24.0096038415366 op/ms)
Optimistic 20000 op in 655.0 ms (30.5343511450382 op/ms)
Locking with parameter usage
Locking 20000 op in 1541.0 ms (12.9785853341986 op/ms)
Optimistic/current 20000 op in 767.0 ms (26.0756192959583 op/ms)
Optimistic/heavy 20000 op in 654.0 ms (30.5810397553517 op/ms)
Locking 20000 op in 803.0 ms (24.906600249066 op/ms)
Optimistic 20000 op in 629.0 ms (31.7965023847377 op/ms)
Locking with parameter usage
Locking 20000 op in 1522.0 ms (13.1406044678055 op/ms)
Optimistic/current 20000 op in 781.0 ms (25.6081946222791 op/ms)
Optimistic/heavy 20000 op in 640.0 ms (31.25 op/ms)
Locking 20000 op in 835.0 ms (23.9520958083832 op/ms)
Optimistic 20000 op in 643.0 ms (31.104199066874 op/ms)
Locking with parameter usage
Locking 20000 op in 1498.0 ms (13.3511348464619 op/ms)
Optimistic/current 20000 op in 805.0 ms (24.8447204968944 op/ms)
Optimistic/heavy 20000 op in 652.0 ms (30.6748466257669 op/ms)
Locking 20000 op in 808.0 ms (24.7524752475248 op/ms)
Optimistic 20000 op in 642.0 ms (31.1526479750779 op/ms)
Locking with parameter usage
Locking 20000 op in 1591.0 ms (12.5707102451289 op/ms)
Optimistic/current 20000 op in 812.0 ms (24.6305418719212 op/ms)
Optimistic/heavy 20000 op in 664.0 ms (30.1204819277108 op/ms)
Locking 20000 op in 857.0 ms (23.3372228704784 op/ms)
Optimistic 20000 op in 651.0 ms (30.7219662058372 op/ms)
Locking with parameter usage
Locking 20000 op in 1572.0 ms (12.7226463104326 op/ms)
Optimistic/current 20000 op in 839.0 ms (23.8379022646007 op/ms)
Optimistic/heavy 20000 op in 720.0 ms (27.7777777777778 op/ms)
Locking 20000 op in 754.0 ms (26.525198938992 op/ms)
Optimistic 20000 op in 620.0 ms (32.258064516129 op/ms)
Locking with parameter usage
Locking 20000 op in 1558.0 ms (12.8369704749679 op/ms)
Optimistic/current 20000 op in 820.0 ms (24.390243902439 op/ms)
Optimistic/heavy 20000 op in 648.0 ms (30.8641975308642 op/ms)