Crafty 23.1 JA quirks

Discussion of chess software programming and technical issues.

Moderators: hgm, Rebel, chrisw

F. Bluemers
Posts: 868
Joined: Thu Mar 09, 2006 11:21 pm
Location: Nederland

Crafty 23.1 JA quirks

Post by F. Bluemers »

I recently added crafty to my dirty tours and noticed a couple of issues.
I am using Jim's compilation.
First: for every game there are 2 log.xxn and game.xxn created (maybe because it uses 2 threads?).
But more problematic: Often crafty looses on time with black (and black only) right out of the book.
Here is a crafty log from such a game:

Code: Select all

noise level set to 1000000.
max threads set to 2.
hash table memory =  256M bytes.
pawn hash table memory =   16M bytes.


Crafty v23.1 JA (2 cpus)

White(1): xboard
White(1): protover 2
feature ping=1 setboard=1 san=1 time=1 draw=1
feature sigint=0 sigterm=0 reuse=1 analyze=1
feature myname="Crafty-23.1 JA" name=1
feature playother=1 colors=0
feature variants="normal,nocastle"
feature done=1
White(1): accepted ping
White(1): accepted setboard
White(1): accepted san
White(1): accepted time
White(1): accepted draw
White(1): accepted sigint
White(1): accepted sigterm
White(1): accepted reuse
White(1): accepted analyze
White(1): accepted myname
White(1): accepted name
White(1): accepted playother
White(1): accepted colors
White(1): accepted variants
White(1): accepted done
White(1): new
parallel threads terminated.
White(1): random
White(1): level 0 60 0
 game/3600 seconds primary time control
White(1): post
White(1): hard
pondering enabled.
White(1): ping 1
pong 1
White(1): force
White(1): computer
playing a computer!
White(1): name Dirty Jul 23 2009
Crafty 23.1 JA vs Dirty
White(1): time 360000
time remaining:  60:00 (Crafty).
White(1): otim 359998
time remaining:  59:59 (opponent).
White(1): d4
Black(1): go
               book moves {d5, Nf6}
               book   0.0s     28%    d5
Black(1): d5
              time used:   0.01
time remaining (white):   0:59:59time remaining (black):   0:59:59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves {c4, Nf3}
               moves considered {only non-book moves}
              time limit 20.11 (+1:35) (1:00)
              depth   time  score   variation (1)
starting thread 1
               11->   0.36   0.32   2. Nf3 Nf6 3. e3 e6 4. Nc3 Nc6 5. Bd3
                                    Bd6 6. O-O O-O 7. Ng5 (s=3)
White(2): e3 [pondering]
              time limit 3:21 (+1:35) (10:35)
              depth   time  score   variation (1)
White(2): time 359989
time remaining:  59:59 (Crafty).
White(2): otim 359984
time remaining:  59:59 (opponent).
White(2): Nf3
              time used:   0.38
               book moves {Nf6}
               book   0.0s     68%    Nf6!
Black(2): Nf6
              time used:   0.01

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>|<P>|   |<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   |<N>|   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   | . |<P>| . |   | . |   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|   | . |   | . |
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |-N-| . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-|-B-|-Q-|-K-|-B-| . |-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
White&#40;3&#41;&#58; e3 &#91;pondering&#93;
               book moves &#123;c6&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; time 359964
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;3&#41;&#58; otim 359976
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;3&#41;&#58; c4
              time limit 3&#58;21 (+1&#58;35&#41; &#40;10&#58;35&#41;
              depth   time  score   variation &#40;1&#41;
               11->   0.28   0.22   3. ... e6 4. Nc3 Nc6 5. Bb5 Bb4 6.
                                    Bxc6+ bxc6 7. Ne5 Bd7 8. O-O O-O 9.
                                    Bd2 <HT>
........pv lines snipped................................................
               22->  45&#58;21   0.15   3. ... e6 4. c4 c5 5. Nc3 Nc6 6. Be2
                                    Bd6 7. O-O O-O 8. dxc5 Bxc5 9. Qb3
                                    Qb6 10. Qxb6 Bxb6 11. Rd1 Rd8 12. cxd5
                                    Nxd5 13. Nxd5 Rxd5 14. Rxd5 exd5
White&#40;3&#41;&#58; result 1-0 &#123;White wins on time&#125;
Updating book database
White&#40;3&#41;&#58; quit
The winboard log:

Code: Select all

recognized 'normal' (-1&#41; as variant normal
WinBoard 4.4.1 + polyglot1.4w.exe
Reset&#40;1, 0&#41; from gameMode 0
recognized 'normal' (-1&#41; as variant normal
GameEnds&#40;0, &#40;null&#41;, 2&#41;
shuffleOpenings = 0
TC string = '+60'
mps=0 tc=3600000 inc=0
TC string = '+60'
mps=0 tc=3600000 inc=0
StartChildProcess &#40;dir="C&#58;\Users\Fonzy\chesstours\Engines\Polyglot") "./polyglot1.4w.exe" Doch.ini
nice engine proc to 10
562 >first &#58; xboard
protover 2
562 <first &#58; PolyGlot 1.4W26 by Fabien Letouzey
655 <first &#58; feature done=0
655 >first &#58; accepted done
655 <first &#58; feature analyze=1
655 >first &#58; accepted analyze
655 <first &#58; feature colors=0
655 >first &#58; accepted colors
655 <first &#58; feature draw=1
655 >first &#58; accepted draw
655 <first &#58; feature ics=1
655 >first &#58; accepted ics
655 <first &#58; feature myname="Doch64 09.980 JA"
655 >first &#58; accepted myname
655 <first &#58; feature name=1
655 >first &#58; accepted name
655 <first &#58; feature pause=0
655 >first &#58; accepted pause
655 <first &#58; feature ping=1
655 >first &#58; accepted ping
655 <first &#58; feature playother=1
655 >first &#58; accepted playother
655 <first &#58; feature reuse=1
655 >first &#58; accepted reuse
655 <first &#58; feature san=0
655 >first &#58; accepted san
655 <first &#58; feature setboard=1
655 >first &#58; accepted setboard
655 <first &#58; feature sigint=0
655 >first &#58; accepted sigint
655 <first &#58; feature sigterm=0
655 >first &#58; accepted sigterm
655 <first &#58; feature time=1
655 >first &#58; accepted time
655 <first &#58; feature usermove=1
655 >first &#58; accepted usermove
655 <first &#58; feature variants="normal"
655 >first &#58; accepted variants
655 <first &#58; feature done=1
655 >first &#58; accepted done
671 >first &#58; new
random
671 >first &#58; ics -
671 >first &#58; level 0 60 0
671 >first &#58; post
671 >first &#58; hard
671 >first &#58; ping 1
671 >first &#58; force
StartChildProcess &#40;dir="C&#58;\Users\Fonzy\chesstours\Engines\Crafty-ja") "./crafty_231_x64_ja.exe" 
nice engine proc to 10
1186 >second&#58; xboard
protover 2
1186 <second&#58; unable to open book file &#91;./books.bin&#93;.
1186 <second&#58; 
1186 <second&#58; Initializing multiple threads.
1186 <second&#58; System is SMP, not NUMA.
1186 <second&#58; EGTB cache memory =   32M bytes.
1186 <second&#58; use 'settc' command if a game is restarted after Crafty
1186 <second&#58; has been terminated for any reason.
1186 <second&#58; tournament mode.
1186 <second&#58; book learning enabled
1186 <second&#58; choose from book moves randomly &#40;using weights.)
1186 <second&#58; choose from 4 best moves.
1186 <second&#58; noise level set to 1000000.
1186 <second&#58; max threads set to 2.
1186 <second&#58; hash table memory =  256M bytes.
1186 <second&#58; pawn hash table memory =   16M bytes.
1186 <second&#58; 
1186 <second&#58; 
1186 <second&#58; Crafty v23.1 JA &#40;2 cpus&#41;
1186 <second&#58; 
1186 <first &#58; pong 1
1186 <second&#58; White&#40;1&#41;&#58; 
1186 <second&#58; tellicsnoalias kibitz Hello from Crafty v23.1 JA! &#40;2 cpus&#41;
1186 <second&#58; feature ping=1 setboard=1 san=1 time=1 draw=1
1186 >second&#58; accepted ping
1186 >second&#58; accepted setboard
1186 >second&#58; accepted san
1186 >second&#58; accepted time
1186 >second&#58; accepted draw
1186 <second&#58; feature sigint=0 sigterm=0 reuse=1 analyze=1
1186 >second&#58; accepted sigint
1186 >second&#58; accepted sigterm
1186 >second&#58; accepted reuse
1186 >second&#58; accepted analyze
1186 <second&#58; feature myname="Crafty-23.1 JA" name=1
1186 >second&#58; accepted myname
1186 >second&#58; accepted name
1186 <second&#58; feature playother=1 colors=0
1186 >second&#58; accepted playother
1186 >second&#58; accepted colors
1186 <second&#58; feature variants="normal,nocastle"
1186 >second&#58; accepted variants
1186 <second&#58; feature done=1
1186 >second&#58; accepted done
1201 >second&#58; new
random
1201 >second&#58; level 0 60 0
1201 >second&#58; post
1201 >second&#58; hard
1201 >second&#58; ping 1
1201 >second&#58; force
1201 >first &#58; computer
1201 >first &#58; name Crafty-23.1 JA
1201 >second&#58; computer
1201 >second&#58; name Doch64 09.980 JA
TC string = '+60'
mps=0 tc=3600000 inc=0
TC string = '+60'
mps=0 tc=3600000 inc=0
time odds&#58; 1 1 
1201 >first &#58; time 360000
1201 >first &#58; otim 360000
book hit = &#40;NULL&#41;
1201 >first &#58; go
nps&#58; w=-1, b=-1
1217 <first &#58; move d2d4
machine move 0, castling = 7 0 4 7 0 4
move to parse&#58; d2d4
7 0 4 7 0 4 Legality test? d2d4
7 0 4 7 0 4 Legality test? d2d4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=0 &#40;3,1&#41;-&#40;3,3&#41; -
7 0 4 7 0 4 Legality test? d2d4
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; d2d4
, parse&#58; d4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=1 bmm=0 ep=-4, reps=6
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1217 >second&#58; time 360000
1217 >second&#58; otim 359998
book hit = &#40;NULL&#41;
1233 >second&#58; d4
1233 >second&#58; go
silence
1326 <second&#58; tellicsnoalias set 1 Crafty v23.1 JA &#40;2 cpus&#41;
1326 <second&#58; pong 1
1326 <second&#58; tellicsnoalias kibitz Hello from Crafty v23.1 JA! &#40;2 cpus&#41;
1326 <second&#58; move Nf6
machine move 1, castling = 7 0 4 7 0 4
move to parse&#58; Nf6
Parser Qa1&#58; yyleng=3,  23&#40;-1,-1&#41;-&#40;5,5&#41; = 0 ( )
Disambiguate in&#58;  23&#40;-1,-1&#41;-&#40;5,5&#41; = 0 (-)
Disambiguate out&#58; 23&#40;6,7&#41;-&#40;5,5&#41; = 0 (-)
7 0 4 7 0 4 Legality test? g8f6
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=23 &#40;6,7&#41;-&#40;5,5&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; g8f6
, parse&#58; Nf6 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=2 bmm=0 ep=-4, reps=6
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1326 >first &#58; time 359998
1326 >first &#58; otim 359989
book hit = &#40;NULL&#41;
1326 >first &#58; usermove 1326 >first &#58; g8f6
silence
1326 <second&#58; 
1326 <second&#58; 
1357 <first &#58; move c1g5
machine move 2, castling = 7 0 4 7 0 4
move to parse&#58; c1g5
7 0 4 7 0 4 Legality test? c1g5
7 0 4 7 0 4 Legality test? c1g5
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=2 &#40;2,0&#41;-&#40;6,4&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; c1g5
, parse&#58; Bg5 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=3 bmm=0 ep=-4, reps=6
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1357 >second&#58; time 359989
1357 >second&#58; otim 359995
book hit = &#40;NULL&#41;
1357 >second&#58; Bg5
silence
1373 <second&#58; Hint&#58; Nc3
1389 <second&#58; move Ne4
machine move 3, castling = 7 0 4 7 0 4
move to parse&#58; Ne4
Parser Qa1&#58; yyleng=3,  23&#40;-1,-1&#41;-&#40;4,3&#41; = 0 ( )
Disambiguate in&#58;  23&#40;-1,-1&#41;-&#40;4,3&#41; = 0 (-)
Disambiguate out&#58; 23&#40;5,5&#41;-&#40;4,3&#41; = 0 (-)
7 0 4 7 0 4 Legality test? f6e4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=23 &#40;5,5&#41;-&#40;4,3&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; f6e4
, parse&#58; Ne4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=4 bmm=0 ep=-4, reps=6
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1389 >first &#58; time 359995
1389 >first &#58; otim 359985
book hit = &#40;NULL&#41;
1389 >first &#58; usermove 1389 >first &#58; f6e4
silence
1389 <second&#58; 
1389 <second&#58; 
1389 <first &#58; move g5h4
machine move 4, castling = 7 0 4 7 0 4
move to parse&#58; g5h4
7 0 4 7 0 4 Legality test? g5h4
7 0 4 7 0 4 Legality test? g5h4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=2 &#40;6,4&#41;-&#40;7,3&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; g5h4
, parse&#58; Bh4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=5 bmm=0 ep=-4, reps=6
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1389 >second&#58; time 359985
1389 >second&#58; otim 359995
book hit = &#40;NULL&#41;
1389 >second&#58; Bh4
silence
1404 <second&#58; Hint&#58; Bd2
2059 <second&#58; 	12     20      66 2790795  3. ... c5 4. dxc5 Nc6 5. Nf3 Nxc5 6. Nc3 Qa5 7. Rb1 Na4 8. Qd5 Nxc3 9. Qxa5 Nxa5 10. bxc3
----------------pv lines snipped-----------------------------------------
20452 <second&#58; 	17     25    1905 89070607  3. ... c5 4. Nd2 Qa5 5. c3 Nxd2 6. Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 Nc6 9. Nf3 d5 10. e3 e6 11. Bd3 Bb4+ 12. Ke2 O-O
21637 <second&#58; move c5
machine move 5, castling = 7 0 4 7 0 4
move to parse&#58; c5
Disambiguate in&#58;  22&#40;2,-1&#41;-&#40;2,4&#41; = 0 (-)
Disambiguate out&#58; 22&#40;2,6&#41;-&#40;2,4&#41; = 0 (-)
7 0 4 7 0 4 Legality test? c7c5
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=22 &#40;2,6&#41;-&#40;2,4&#41; -
7 0 4 7 0 4 Legality test? c7c5
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; c7c5
, parse&#58; c5 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=6 bmm=0 ep=-4, reps=6
6 ep=-3
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
21653 >first &#58; time 359995
21653 >first &#58; otim 357961
book hit = &#40;NULL&#41;
21653 >first &#58; usermove 21653 >first &#58; c7c5
silence
21653 <second&#58; 
21653 <second&#58; 
21653 <second&#58; Hint&#58; Nd2
21653 <first &#58; move f2f3
machine move 6, castling = 7 0 4 7 0 4
move to parse&#58; f2f3
7 0 4 7 0 4 Legality test? f2f3
7 0 4 7 0 4 Legality test? f2f3
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=0 &#40;5,1&#41;-&#40;5,2&#41; -
7 0 4 7 0 4 Legality test? f2f3
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; f2f3
, parse&#58; f3 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=7 bmm=0 ep=-4, reps=6
7 ep=-3
6 ep=-3
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
21653 >second&#58; time 357961
21653 >second&#58; otim 359993
book hit = &#40;NULL&#41;
21653 >second&#58; f3
silence
21887 <second&#58; 	13     35      25 1008668  4. ... Qa5 5. dxc5 Nxc5 6. Nf3 Nc6 7. e3 Rb8 8. Bc4 d6 9. Rb1 Be6 10. O-O Bxc4 11. Nxc4 <HT>
----------pv lines snipped--------------------------
1384485 <second&#58; 	23     28  136286 6265430505  4. ... Qa5 5. c3 Nxd2 6. Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 e6 9. e4 Nc6 10. Nf3 d5 11. Bd3 dxe4 12. Bxe4 Bd7 13. Ne5 Nxd4 <HT>
GameEnds&#40;37, White wins on time, 4&#41;
TC string = '+60'
mps=0 tc=3600000 inc=0
3601276 >first &#58; result 1-0 &#123;White wins on time&#125;
3601276 >second&#58; result 1-0 &#123;White wins on time&#125;
3601276 >first &#58; quit
3601276 >second&#58; quit
Exiting&#58; Match Doch64 09.980 JA vs. Crafty-23.1 JA&#58; final score 1-0-0
ExitEvent&#40;) during GameEnds&#40;), wait
GameEnds&#40;) seems stuck, proceed exiting
the game as winboard and Doch saw it:
[Event "BASEMENT_QUAD_2009-11-7 (1)"]
[Site "BASEMENT_QUAD"]
[Date "2009.12.12"]
[Round "2.2"]
[White "Doch 09.980 JA"]
[Black "Crafty 23.1 JA"]
[Result "1-0"]
[TimeControl "3600"]
[Annotator "3... +0.25"]
[Number "21"]

1. d4 Nf6 2. Bg5 Ne4 3. Bh4 c5 {+0.25/17 20} 4. f3
{White wins on time} 1-0
bob
Posts: 20943
Joined: Mon Feb 27, 2006 7:30 pm
Location: Birmingham, AL

Re: Crafty 23.1 JA quirks

Post by bob »

F. Bluemers wrote:I recently added crafty to my dirty tours and noticed a couple of issues.
I am using Jim's compilation.
First: for every game there are 2 log.xxn and game.xxn created (maybe because it uses 2 threads?).
But more problematic: Often crafty looses on time with black (and black only) right out of the book.
Here is a crafty log from such a game:

Code: Select all

noise level set to 1000000.
max threads set to 2.
hash table memory =  256M bytes.
pawn hash table memory =   16M bytes.


Crafty v23.1 JA &#40;2 cpus&#41;

White&#40;1&#41;&#58; xboard
White&#40;1&#41;&#58; protover 2
feature ping=1 setboard=1 san=1 time=1 draw=1
feature sigint=0 sigterm=0 reuse=1 analyze=1
feature myname="Crafty-23.1 JA" name=1
feature playother=1 colors=0
feature variants="normal,nocastle"
feature done=1
White&#40;1&#41;&#58; accepted ping
White&#40;1&#41;&#58; accepted setboard
White&#40;1&#41;&#58; accepted san
White&#40;1&#41;&#58; accepted time
White&#40;1&#41;&#58; accepted draw
White&#40;1&#41;&#58; accepted sigint
White&#40;1&#41;&#58; accepted sigterm
White&#40;1&#41;&#58; accepted reuse
White&#40;1&#41;&#58; accepted analyze
White&#40;1&#41;&#58; accepted myname
White&#40;1&#41;&#58; accepted name
White&#40;1&#41;&#58; accepted playother
White&#40;1&#41;&#58; accepted colors
White&#40;1&#41;&#58; accepted variants
White&#40;1&#41;&#58; accepted done
White&#40;1&#41;&#58; new
parallel threads terminated.
White&#40;1&#41;&#58; random
White&#40;1&#41;&#58; level 0 60 0
 game/3600 seconds primary time control
White&#40;1&#41;&#58; post
White&#40;1&#41;&#58; hard
pondering enabled.
White&#40;1&#41;&#58; ping 1
pong 1
White&#40;1&#41;&#58; force
White&#40;1&#41;&#58; computer
playing a computer!
White&#40;1&#41;&#58; name Dirty Jul 23 2009
Crafty 23.1 JA vs Dirty
White&#40;1&#41;&#58; time 360000
time remaining&#58;  60&#58;00 &#40;Crafty&#41;.
White&#40;1&#41;&#58; otim 359998
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;1&#41;&#58; d4
Black&#40;1&#41;&#58; go
               book moves &#123;d5, Nf6&#125;
               book   0.0s     28%    d5
Black&#40;1&#41;&#58; d5
              time used&#58;   0.01
time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves &#123;c4, Nf3&#125;
               moves considered &#123;only non-book moves&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
starting thread 1
               11->   0.36   0.32   2. Nf3 Nf6 3. e3 e6 4. Nc3 Nc6 5. Bd3
                                    Bd6 6. O-O O-O 7. Ng5 &#40;s=3&#41;
White&#40;2&#41;&#58; e3 &#91;pondering&#93;
              time limit 3&#58;21 (+1&#58;35&#41; &#40;10&#58;35&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;2&#41;&#58; time 359989
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;2&#41;&#58; otim 359984
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;2&#41;&#58; Nf3
              time used&#58;   0.38
               book moves &#123;Nf6&#125;
               book   0.0s     68%    Nf6!
Black&#40;2&#41;&#58; Nf6
              time used&#58;   0.01

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>|<P>|   |<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   |<N>|   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   | . |<P>| . |   | . |   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|   | . |   | . |
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |-N-| . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-|-B-|-Q-|-K-|-B-| . |-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
White&#40;3&#41;&#58; e3 &#91;pondering&#93;
               book moves &#123;c6&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; time 359964
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;3&#41;&#58; otim 359976
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;3&#41;&#58; c4
              time limit 3&#58;21 (+1&#58;35&#41; &#40;10&#58;35&#41;
              depth   time  score   variation &#40;1&#41;
               11->   0.28   0.22   3. ... e6 4. Nc3 Nc6 5. Bb5 Bb4 6.
                                    Bxc6+ bxc6 7. Ne5 Bd7 8. O-O O-O 9.
                                    Bd2 <HT>
........pv lines snipped................................................
               22->  45&#58;21   0.15   3. ... e6 4. c4 c5 5. Nc3 Nc6 6. Be2
                                    Bd6 7. O-O O-O 8. dxc5 Bxc5 9. Qb3
                                    Qb6 10. Qxb6 Bxb6 11. Rd1 Rd8 12. cxd5
                                    Nxd5 13. Nxd5 Rxd5 14. Rxd5 exd5
White&#40;3&#41;&#58; result 1-0 &#123;White wins on time&#125;
Updating book database
White&#40;3&#41;&#58; quit
The winboard log:

Code: Select all

recognized 'normal' (-1&#41; as variant normal
WinBoard 4.4.1 + polyglot1.4w.exe
Reset&#40;1, 0&#41; from gameMode 0
recognized 'normal' (-1&#41; as variant normal
GameEnds&#40;0, &#40;null&#41;, 2&#41;
shuffleOpenings = 0
TC string = '+60'
mps=0 tc=3600000 inc=0
TC string = '+60'
mps=0 tc=3600000 inc=0
StartChildProcess &#40;dir="C&#58;\Users\Fonzy\chesstours\Engines\Polyglot") "./polyglot1.4w.exe" Doch.ini
nice engine proc to 10
562 >first &#58; xboard
protover 2
562 <first &#58; PolyGlot 1.4W26 by Fabien Letouzey
655 <first &#58; feature done=0
655 >first &#58; accepted done
655 <first &#58; feature analyze=1
655 >first &#58; accepted analyze
655 <first &#58; feature colors=0
655 >first &#58; accepted colors
655 <first &#58; feature draw=1
655 >first &#58; accepted draw
655 <first &#58; feature ics=1
655 >first &#58; accepted ics
655 <first &#58; feature myname="Doch64 09.980 JA"
655 >first &#58; accepted myname
655 <first &#58; feature name=1
655 >first &#58; accepted name
655 <first &#58; feature pause=0
655 >first &#58; accepted pause
655 <first &#58; feature ping=1
655 >first &#58; accepted ping
655 <first &#58; feature playother=1
655 >first &#58; accepted playother
655 <first &#58; feature reuse=1
655 >first &#58; accepted reuse
655 <first &#58; feature san=0
655 >first &#58; accepted san
655 <first &#58; feature setboard=1
655 >first &#58; accepted setboard
655 <first &#58; feature sigint=0
655 >first &#58; accepted sigint
655 <first &#58; feature sigterm=0
655 >first &#58; accepted sigterm
655 <first &#58; feature time=1
655 >first &#58; accepted time
655 <first &#58; feature usermove=1
655 >first &#58; accepted usermove
655 <first &#58; feature variants="normal"
655 >first &#58; accepted variants
655 <first &#58; feature done=1
655 >first &#58; accepted done
671 >first &#58; new
random
671 >first &#58; ics -
671 >first &#58; level 0 60 0
671 >first &#58; post
671 >first &#58; hard
671 >first &#58; ping 1
671 >first &#58; force
StartChildProcess &#40;dir="C&#58;\Users\Fonzy\chesstours\Engines\Crafty-ja") "./crafty_231_x64_ja.exe" 
nice engine proc to 10
1186 >second&#58; xboard
protover 2
1186 <second&#58; unable to open book file &#91;./books.bin&#93;.
1186 <second&#58; 
1186 <second&#58; Initializing multiple threads.
1186 <second&#58; System is SMP, not NUMA.
1186 <second&#58; EGTB cache memory =   32M bytes.
1186 <second&#58; use 'settc' command if a game is restarted after Crafty
1186 <second&#58; has been terminated for any reason.
1186 <second&#58; tournament mode.
1186 <second&#58; book learning enabled
1186 <second&#58; choose from book moves randomly &#40;using weights.)
1186 <second&#58; choose from 4 best moves.
1186 <second&#58; noise level set to 1000000.
1186 <second&#58; max threads set to 2.
1186 <second&#58; hash table memory =  256M bytes.
1186 <second&#58; pawn hash table memory =   16M bytes.
1186 <second&#58; 
1186 <second&#58; 
1186 <second&#58; Crafty v23.1 JA &#40;2 cpus&#41;
1186 <second&#58; 
1186 <first &#58; pong 1
1186 <second&#58; White&#40;1&#41;&#58; 
1186 <second&#58; tellicsnoalias kibitz Hello from Crafty v23.1 JA! &#40;2 cpus&#41;
1186 <second&#58; feature ping=1 setboard=1 san=1 time=1 draw=1
1186 >second&#58; accepted ping
1186 >second&#58; accepted setboard
1186 >second&#58; accepted san
1186 >second&#58; accepted time
1186 >second&#58; accepted draw
1186 <second&#58; feature sigint=0 sigterm=0 reuse=1 analyze=1
1186 >second&#58; accepted sigint
1186 >second&#58; accepted sigterm
1186 >second&#58; accepted reuse
1186 >second&#58; accepted analyze
1186 <second&#58; feature myname="Crafty-23.1 JA" name=1
1186 >second&#58; accepted myname
1186 >second&#58; accepted name
1186 <second&#58; feature playother=1 colors=0
1186 >second&#58; accepted playother
1186 >second&#58; accepted colors
1186 <second&#58; feature variants="normal,nocastle"
1186 >second&#58; accepted variants
1186 <second&#58; feature done=1
1186 >second&#58; accepted done
1201 >second&#58; new
random
1201 >second&#58; level 0 60 0
1201 >second&#58; post
1201 >second&#58; hard
1201 >second&#58; ping 1
1201 >second&#58; force
1201 >first &#58; computer
1201 >first &#58; name Crafty-23.1 JA
1201 >second&#58; computer
1201 >second&#58; name Doch64 09.980 JA
TC string = '+60'
mps=0 tc=3600000 inc=0
TC string = '+60'
mps=0 tc=3600000 inc=0
time odds&#58; 1 1 
1201 >first &#58; time 360000
1201 >first &#58; otim 360000
book hit = &#40;NULL&#41;
1201 >first &#58; go
nps&#58; w=-1, b=-1
1217 <first &#58; move d2d4
machine move 0, castling = 7 0 4 7 0 4
move to parse&#58; d2d4
7 0 4 7 0 4 Legality test? d2d4
7 0 4 7 0 4 Legality test? d2d4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=0 &#40;3,1&#41;-&#40;3,3&#41; -
7 0 4 7 0 4 Legality test? d2d4
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; d2d4
, parse&#58; d4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=1 bmm=0 ep=-4, reps=6
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1217 >second&#58; time 360000
1217 >second&#58; otim 359998
book hit = &#40;NULL&#41;
1233 >second&#58; d4
1233 >second&#58; go
silence
1326 <second&#58; tellicsnoalias set 1 Crafty v23.1 JA &#40;2 cpus&#41;
1326 <second&#58; pong 1
1326 <second&#58; tellicsnoalias kibitz Hello from Crafty v23.1 JA! &#40;2 cpus&#41;
1326 <second&#58; move Nf6
machine move 1, castling = 7 0 4 7 0 4
move to parse&#58; Nf6
Parser Qa1&#58; yyleng=3,  23&#40;-1,-1&#41;-&#40;5,5&#41; = 0 ( )
Disambiguate in&#58;  23&#40;-1,-1&#41;-&#40;5,5&#41; = 0 (-)
Disambiguate out&#58; 23&#40;6,7&#41;-&#40;5,5&#41; = 0 (-)
7 0 4 7 0 4 Legality test? g8f6
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=23 &#40;6,7&#41;-&#40;5,5&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; g8f6
, parse&#58; Nf6 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=2 bmm=0 ep=-4, reps=6
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1326 >first &#58; time 359998
1326 >first &#58; otim 359989
book hit = &#40;NULL&#41;
1326 >first &#58; usermove 1326 >first &#58; g8f6
silence
1326 <second&#58; 
1326 <second&#58; 
1357 <first &#58; move c1g5
machine move 2, castling = 7 0 4 7 0 4
move to parse&#58; c1g5
7 0 4 7 0 4 Legality test? c1g5
7 0 4 7 0 4 Legality test? c1g5
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=2 &#40;2,0&#41;-&#40;6,4&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; c1g5
, parse&#58; Bg5 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=3 bmm=0 ep=-4, reps=6
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1357 >second&#58; time 359989
1357 >second&#58; otim 359995
book hit = &#40;NULL&#41;
1357 >second&#58; Bg5
silence
1373 <second&#58; Hint&#58; Nc3
1389 <second&#58; move Ne4
machine move 3, castling = 7 0 4 7 0 4
move to parse&#58; Ne4
Parser Qa1&#58; yyleng=3,  23&#40;-1,-1&#41;-&#40;4,3&#41; = 0 ( )
Disambiguate in&#58;  23&#40;-1,-1&#41;-&#40;4,3&#41; = 0 (-)
Disambiguate out&#58; 23&#40;5,5&#41;-&#40;4,3&#41; = 0 (-)
7 0 4 7 0 4 Legality test? f6e4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=23 &#40;5,5&#41;-&#40;4,3&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; f6e4
, parse&#58; Ne4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=4 bmm=0 ep=-4, reps=6
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1389 >first &#58; time 359995
1389 >first &#58; otim 359985
book hit = &#40;NULL&#41;
1389 >first &#58; usermove 1389 >first &#58; f6e4
silence
1389 <second&#58; 
1389 <second&#58; 
1389 <first &#58; move g5h4
machine move 4, castling = 7 0 4 7 0 4
move to parse&#58; g5h4
7 0 4 7 0 4 Legality test? g5h4
7 0 4 7 0 4 Legality test? g5h4
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=2 &#40;6,4&#41;-&#40;7,3&#41; -
MateTest&#58; K=1, my=16, his=16
move&#58; g5h4
, parse&#58; Bh4 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=5 bmm=0 ep=-4, reps=6
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
1389 >second&#58; time 359985
1389 >second&#58; otim 359995
book hit = &#40;NULL&#41;
1389 >second&#58; Bh4
silence
1404 <second&#58; Hint&#58; Bd2
2059 <second&#58; 	12     20      66 2790795  3. ... c5 4. dxc5 Nc6 5. Nf3 Nxc5 6. Nc3 Qa5 7. Rb1 Na4 8. Qd5 Nxc3 9. Qxa5 Nxa5 10. bxc3
----------------pv lines snipped-----------------------------------------
20452 <second&#58; 	17     25    1905 89070607  3. ... c5 4. Nd2 Qa5 5. c3 Nxd2 6. Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 Nc6 9. Nf3 d5 10. e3 e6 11. Bd3 Bb4+ 12. Ke2 O-O
21637 <second&#58; move c5
machine move 5, castling = 7 0 4 7 0 4
move to parse&#58; c5
Disambiguate in&#58;  22&#40;2,-1&#41;-&#40;2,4&#41; = 0 (-)
Disambiguate out&#58; 22&#40;2,6&#41;-&#40;2,4&#41; = 0 (-)
7 0 4 7 0 4 Legality test? c7c5
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=22 &#40;2,6&#41;-&#40;2,4&#41; -
7 0 4 7 0 4 Legality test? c7c5
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; c7c5
, parse&#58; c5 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=6 bmm=0 ep=-4, reps=6
6 ep=-3
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
21653 >first &#58; time 359995
21653 >first &#58; otim 357961
book hit = &#40;NULL&#41;
21653 >first &#58; usermove 21653 >first &#58; c7c5
silence
21653 <second&#58; 
21653 <second&#58; 
21653 <second&#58; Hint&#58; Nd2
21653 <first &#58; move f2f3
machine move 6, castling = 7 0 4 7 0 4
move to parse&#58; f2f3
7 0 4 7 0 4 Legality test? f2f3
7 0 4 7 0 4 Legality test? f2f3
&#40;7,0&#41; &#40;0,0&#41; &#40;4,0&#41; &#40;7,7&#41; &#40;0,7&#41; &#40;4,7&#41; castling rights
TC string = '+60'
mps=0 tc=3600000 inc=0
CoordsToAlgebraic, piece=0 &#40;5,1&#41;-&#40;5,2&#41; -
7 0 4 7 0 4 Legality test? f2f3
movetype=33, promochar=0=-
MateTest&#58; K=1, my=16, his=16
move&#58; f2f3
, parse&#58; f3 (
)
MateTest&#58; K=1, my=16, his=16
repeat test fmm=7 bmm=0 ep=-4, reps=6
7 ep=-3
6 ep=-3
5 ep=-4
4 ep=-4
3 ep=-4
2 ep=-4
1 ep=-3
0 ep=-4
time odds&#58; 1 1 
21653 >second&#58; time 357961
21653 >second&#58; otim 359993
book hit = &#40;NULL&#41;
21653 >second&#58; f3
silence
21887 <second&#58; 	13     35      25 1008668  4. ... Qa5 5. dxc5 Nxc5 6. Nf3 Nc6 7. e3 Rb8 8. Bc4 d6 9. Rb1 Be6 10. O-O Bxc4 11. Nxc4 <HT>
----------pv lines snipped--------------------------
1384485 <second&#58; 	23     28  136286 6265430505  4. ... Qa5 5. c3 Nxd2 6. Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 e6 9. e4 Nc6 10. Nf3 d5 11. Bd3 dxe4 12. Bxe4 Bd7 13. Ne5 Nxd4 <HT>
GameEnds&#40;37, White wins on time, 4&#41;
TC string = '+60'
mps=0 tc=3600000 inc=0
3601276 >first &#58; result 1-0 &#123;White wins on time&#125;
3601276 >second&#58; result 1-0 &#123;White wins on time&#125;
3601276 >first &#58; quit
3601276 >second&#58; quit
Exiting&#58; Match Doch64 09.980 JA vs. Crafty-23.1 JA&#58; final score 1-0-0
ExitEvent&#40;) during GameEnds&#40;), wait
GameEnds&#40;) seems stuck, proceed exiting
the game as winboard and Doch saw it:
[Event "BASEMENT_QUAD_2009-11-7 (1)"]
[Site "BASEMENT_QUAD"]
[Date "2009.12.12"]
[Round "2.2"]
[White "Doch 09.980 JA"]
[Black "Crafty 23.1 JA"]
[Result "1-0"]
[TimeControl "3600"]
[Annotator "3... +0.25"]
[Number "21"]

1. d4 Nf6 2. Bg5 Ne4 3. Bh4 c5 {+0.25/17 20} 4. f3
{White wins on time} 1-0
Getting 2 log.nnn files can only be caused by starting Crafty, and then sending it a "new" command. A "new" is supposed to be sent between games, not at the beginning. When you start the program up, it is pretty obvious it is a "new" game. :)

No idea on the other problem. I don't ever see losses on time, although I also never play pure sudden-death time controls either and always have some sort of increment since most tournaments are played that way.
F. Bluemers
Posts: 868
Joined: Thu Mar 09, 2006 11:21 pm
Location: Nederland

Re: Crafty 23.1 JA quirks

Post by F. Bluemers »

Ah,the "new" command causes the double logs,thanks.
About the timecontrol,I don't think this is the cause.
Checking the crafty log it seems it has another idea of the moves that got played in the game (1.d4 d5 2.Nf3 Nf6).
Weird that it only happens when crafty has black
bob
Posts: 20943
Joined: Mon Feb 27, 2006 7:30 pm
Location: Birmingham, AL

Re: Crafty 23.1 JA quirks

Post by bob »

F. Bluemers wrote:Ah,the "new" command causes the double logs,thanks.
About the timecontrol,I don't think this is the cause.
Checking the crafty log it seems it has another idea of the moves that got played in the game (1.d4 d5 2.Nf3 Nf6).
Weird that it only happens when crafty has black
Looks to me like you posted the wrong log from Crafty. I'd delete all log.nnn files, and the GUI debug file, and play one game with Crafty as black and post that. I can't imagine how the GUI can send Bg5 and Crafty claims to receive a completely different move in its log file...

None of that looks "sensible" to me based on the winboard debug output....
F. Bluemers
Posts: 868
Joined: Thu Mar 09, 2006 11:21 pm
Location: Nederland

Re: Crafty 23.1 JA quirks

Post by F. Bluemers »

You are right
this is the log file that correspondends to the posted winboard log:

Code: Select all

noise level set to 1000000.
max threads set to 2.
hash table memory =  256M bytes.
pawn hash table memory =   16M bytes.


Crafty v23.1 JA &#40;2 cpus&#41;

White&#40;1&#41;&#58; xboard
White&#40;1&#41;&#58; protover 2
feature ping=1 setboard=1 san=1 time=1 draw=1
feature sigint=0 sigterm=0 reuse=1 analyze=1
feature myname="Crafty-23.1 JA" name=1
feature playother=1 colors=0
feature variants="normal,nocastle"
feature done=1
White&#40;1&#41;&#58; accepted ping
White&#40;1&#41;&#58; accepted setboard
White&#40;1&#41;&#58; accepted san
White&#40;1&#41;&#58; accepted time
White&#40;1&#41;&#58; accepted draw
White&#40;1&#41;&#58; accepted sigint
White&#40;1&#41;&#58; accepted sigterm
White&#40;1&#41;&#58; accepted reuse
White&#40;1&#41;&#58; accepted analyze
White&#40;1&#41;&#58; accepted myname
White&#40;1&#41;&#58; accepted name
White&#40;1&#41;&#58; accepted playother
White&#40;1&#41;&#58; accepted colors
White&#40;1&#41;&#58; accepted variants
White&#40;1&#41;&#58; accepted done
White&#40;1&#41;&#58; new
parallel threads terminated.
White&#40;1&#41;&#58; random
White&#40;1&#41;&#58; level 0 60 0
 game/3600 seconds primary time control
White&#40;1&#41;&#58; post
White&#40;1&#41;&#58; hard
pondering enabled.
White&#40;1&#41;&#58; ping 1
pong 1
White&#40;1&#41;&#58; force
White&#40;1&#41;&#58; computer
playing a computer!
White&#40;1&#41;&#58; name Doch64 09.980 JA
Crafty 23.1 JA vs Doch64
White&#40;1&#41;&#58; time 360000
time remaining&#58;  60&#58;00 &#40;Crafty&#41;.
White&#40;1&#41;&#58; otim 359998
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;1&#41;&#58; d4
Black&#40;1&#41;&#58; go
               book moves &#123;Nf6&#125;
               book   0.0s     63%    Nf6
Black&#40;1&#41;&#58; Nf6
              time used&#58;   0.00
time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   1&#58;60&#58;00Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves &#123;Nf3, c4&#125;
               moves considered &#123;only non-book moves&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
starting thread 1
White&#40;2&#41;&#58; Nc3 &#91;pondering&#93;
               book moves &#123;d5&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;2&#41;&#58; time 359989
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;2&#41;&#58; otim 359995
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;2&#41;&#58; Bg5
              time used&#58;   0.05
               book moves &#123;Ne4, d5, e6, c5&#125;
               book   0.0s     40%    Ne4
Black&#40;2&#41;&#58; Ne4
              time used&#58;   0.02

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>|<P>|<P>|<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   | . |   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   | . |   | . |   |-B-|   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|<N>| . |   | . |
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-| . |-Q-|-K-|-B-|-N-|-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves &#123;Bf4&#125;
               moves considered &#123;only non-book moves&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; Bd2 &#91;pondering&#93;
              time limit 3&#58;21 (+1&#58;35&#41; &#40;10&#58;35&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; time 359985
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;3&#41;&#58; otim 359995
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;3&#41;&#58; Bh4
              time used&#58;   0.01
               book moves &#123;c5&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
               12     0.66   0.20   3. ... c5 4. dxc5 Nc6 5. Nf3 Nxc5 6.
                                    Nc3 Qa5 7. Rb1 Na4 8. Qd5 Nxc3 9. Qxa5
                                    Nxa5 10. bxc3
-------------pv lines snipped-----------------------------------------
               17->  19.05   0.25   3. ... c5 4. Nd2 Qa5 5. c3 Nxd2 6.
                                    Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 Nc6
                                    9. Nf3 d5 10. e3 e6 11. Bd3 Bb4+ 12.
                                    Ke2 O-O
              time=20.23  mat=0  n=94541889  fh=93%  nps=4.7M
              extensions=2.1M qchecks=1.4M reduced=11.2M pruned=36.9M
              predicted=2  evals=42.6M  50move=4  EGTBprobes=0  hits=0
              SMP->  splits=368  aborts=35  data=5/65536  elap=20.23
Black&#40;3&#41;&#58; c5
              time used&#58;  20.23

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>| . |<P>|<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   | . |   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   |<P>|   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|<N>| . |   |-B-|
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-| . |-Q-|-K-|-B-|-N-|-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;39Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
White&#40;4&#41;&#58; Nd2 &#91;pondering&#93;
               book moves &#123;d5&#125;
              time limit 20.00 (+1&#58;34&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;4&#41;&#58; time 357961
time remaining&#58;  59&#58;39 &#40;Crafty&#41;.
White&#40;4&#41;&#58; otim 359993
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;4&#41;&#58; f3
              time limit 3&#58;20 (+1&#58;34&#41; &#40;10&#58;31&#41;
              depth   time  score   variation &#40;1&#41;
               13->   0.25   0.35   4. ... Qa5 5. dxc5 Nxc5 6. Nf3 Nc6
                                    7. e3 Rb8 8. Bc4 d6 9. Rb1 Be6 10.
                                    O-O Bxc4 11. Nxc4 <HT>
------------------pv lines snipped--------------------------------------
               23->  22&#58;42   0.28   4. ... Qa5 5. c3 Nxd2 6. Qxd2 cxd4
                                    7. cxd4 Qxd2+ 8. Kxd2 e6 9. e4 Nc6
                                    10. Nf3 d5 11. Bd3 dxe4 12. Bxe4 Bd7
                                    13. Ne5 Nxd4 <HT> &#40;s=3&#41;
White&#40;4&#41;&#58; result 1-0 &#123;White wins on time&#125;
Updating book database
White&#40;4&#41;&#58; quit
bob
Posts: 20943
Joined: Mon Feb 27, 2006 7:30 pm
Location: Birmingham, AL

Re: Crafty 23.1 JA quirks

Post by bob »

F. Bluemers wrote:You are right
this is the log file that correspondends to the posted winboard log:

Code: Select all

noise level set to 1000000.
max threads set to 2.
hash table memory =  256M bytes.
pawn hash table memory =   16M bytes.


Crafty v23.1 JA &#40;2 cpus&#41;

White&#40;1&#41;&#58; xboard
White&#40;1&#41;&#58; protover 2
feature ping=1 setboard=1 san=1 time=1 draw=1
feature sigint=0 sigterm=0 reuse=1 analyze=1
feature myname="Crafty-23.1 JA" name=1
feature playother=1 colors=0
feature variants="normal,nocastle"
feature done=1
White&#40;1&#41;&#58; accepted ping
White&#40;1&#41;&#58; accepted setboard
White&#40;1&#41;&#58; accepted san
White&#40;1&#41;&#58; accepted time
White&#40;1&#41;&#58; accepted draw
White&#40;1&#41;&#58; accepted sigint
White&#40;1&#41;&#58; accepted sigterm
White&#40;1&#41;&#58; accepted reuse
White&#40;1&#41;&#58; accepted analyze
White&#40;1&#41;&#58; accepted myname
White&#40;1&#41;&#58; accepted name
White&#40;1&#41;&#58; accepted playother
White&#40;1&#41;&#58; accepted colors
White&#40;1&#41;&#58; accepted variants
White&#40;1&#41;&#58; accepted done
White&#40;1&#41;&#58; new
parallel threads terminated.
White&#40;1&#41;&#58; random
White&#40;1&#41;&#58; level 0 60 0
 game/3600 seconds primary time control
White&#40;1&#41;&#58; post
White&#40;1&#41;&#58; hard
pondering enabled.
White&#40;1&#41;&#58; ping 1
pong 1
White&#40;1&#41;&#58; force
White&#40;1&#41;&#58; computer
playing a computer!
White&#40;1&#41;&#58; name Doch64 09.980 JA
Crafty 23.1 JA vs Doch64
White&#40;1&#41;&#58; time 360000
time remaining&#58;  60&#58;00 &#40;Crafty&#41;.
White&#40;1&#41;&#58; otim 359998
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;1&#41;&#58; d4
Black&#40;1&#41;&#58; go
               book moves &#123;Nf6&#125;
               book   0.0s     63%    Nf6
Black&#40;1&#41;&#58; Nf6
              time used&#58;   0.00
time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   1&#58;60&#58;00Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves &#123;Nf3, c4&#125;
               moves considered &#123;only non-book moves&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
starting thread 1
White&#40;2&#41;&#58; Nc3 &#91;pondering&#93;
               book moves &#123;d5&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;2&#41;&#58; time 359989
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;2&#41;&#58; otim 359995
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;2&#41;&#58; Bg5
              time used&#58;   0.05
               book moves &#123;Ne4, d5, e6, c5&#125;
               book   0.0s     40%    Ne4
Black&#40;2&#41;&#58; Ne4
              time used&#58;   0.02

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>|<P>|<P>|<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   | . |   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   | . |   | . |   |-B-|   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|<N>| . |   | . |
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-| . |-Q-|-K-|-B-|-N-|-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;59Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
              puzzling over a move to ponder.
               book moves &#123;Bf4&#125;
               moves considered &#123;only non-book moves&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; Bd2 &#91;pondering&#93;
              time limit 3&#58;21 (+1&#58;35&#41; &#40;10&#58;35&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;3&#41;&#58; time 359985
time remaining&#58;  59&#58;59 &#40;Crafty&#41;.
White&#40;3&#41;&#58; otim 359995
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;3&#41;&#58; Bh4
              time used&#58;   0.01
               book moves &#123;c5&#125;
              time limit 20.11 (+1&#58;35&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
               12     0.66   0.20   3. ... c5 4. dxc5 Nc6 5. Nf3 Nxc5 6.
                                    Nc3 Qa5 7. Rb1 Na4 8. Qd5 Nxc3 9. Qxa5
                                    Nxa5 10. bxc3
-------------pv lines snipped-----------------------------------------
               17->  19.05   0.25   3. ... c5 4. Nd2 Qa5 5. c3 Nxd2 6.
                                    Qxd2 cxd4 7. cxd4 Qxd2+ 8. Kxd2 Nc6
                                    9. Nf3 d5 10. e3 e6 11. Bd3 Bb4+ 12.
                                    Ke2 O-O
              time=20.23  mat=0  n=94541889  fh=93%  nps=4.7M
              extensions=2.1M qchecks=1.4M reduced=11.2M pruned=36.9M
              predicted=2  evals=42.6M  50move=4  EGTBprobes=0  hits=0
              SMP->  splits=368  aborts=35  data=5/65536  elap=20.23
Black&#40;3&#41;&#58; c5
              time used&#58;  20.23

       +---+---+---+---+---+---+---+---+
    8  |<R>|<N>|<B>|<Q>|<K>|<B>|   |<R>|
       +---+---+---+---+---+---+---+---+
    7  |<P>|<P>| . |<P>|<P>|<P>|<P>|<P>|
       +---+---+---+---+---+---+---+---+
    6  |   | . |   | . |   | . |   | . |
       +---+---+---+---+---+---+---+---+
    5  | . |   |<P>|   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    4  |   | . |   |-P-|<N>| . |   |-B-|
       +---+---+---+---+---+---+---+---+
    3  | . |   | . |   | . |   | . |   |
       +---+---+---+---+---+---+---+---+
    2  |-P-|-P-|-P-| . |-P-|-P-|-P-|-P-|
       +---+---+---+---+---+---+---+---+
    1  |-R-|-N-| . |-Q-|-K-|-B-|-N-|-R-|
       +---+---+---+---+---+---+---+---+
         a   b   c   d   e   f   g   h

time remaining &#40;white&#41;&#58;   0&#58;59&#58;59time remaining &#40;black&#41;&#58;   0&#58;59&#58;39Sudden-death time control in effect
if clocks are wrong, use 'clock' command to adjust them
White&#40;4&#41;&#58; Nd2 &#91;pondering&#93;
               book moves &#123;d5&#125;
              time limit 20.00 (+1&#58;34&#41; &#40;1&#58;00&#41;
              depth   time  score   variation &#40;1&#41;
White&#40;4&#41;&#58; time 357961
time remaining&#58;  59&#58;39 &#40;Crafty&#41;.
White&#40;4&#41;&#58; otim 359993
time remaining&#58;  59&#58;59 &#40;opponent&#41;.
White&#40;4&#41;&#58; f3
              time limit 3&#58;20 (+1&#58;34&#41; &#40;10&#58;31&#41;
              depth   time  score   variation &#40;1&#41;
               13->   0.25   0.35   4. ... Qa5 5. dxc5 Nxc5 6. Nf3 Nc6
                                    7. e3 Rb8 8. Bc4 d6 9. Rb1 Be6 10.
                                    O-O Bxc4 11. Nxc4 <HT>
------------------pv lines snipped--------------------------------------
               23->  22&#58;42   0.28   4. ... Qa5 5. c3 Nxd2 6. Qxd2 cxd4
                                    7. cxd4 Qxd2+ 8. Kxd2 e6 9. e4 Nc6
                                    10. Nf3 d5 11. Bd3 dxe4 12. Bxe4 Bd7
                                    13. Ne5 Nxd4 <HT> &#40;s=3&#41;
White&#40;4&#41;&#58; result 1-0 &#123;White wins on time&#125;
Updating book database
White&#40;4&#41;&#58; quit
It looks like the time check code was somehow not working on that last move. It apparently received f3 as a move and then just kept searching. I can't imagine what could cause that, almost as if something was optimized out of the program so that it somehow failed to do any time checks in the search...
F. Bluemers
Posts: 868
Joined: Thu Mar 09, 2006 11:21 pm
Location: Nederland

Re: Crafty 23.1 JA quirks

Post by F. Bluemers »

I replaced Jim's version with the version from Peter Skinner.
Maybe this will fix the timeloss behaviour

I just tested both from the command box and both create double logfiles and gamefiles on startup...The value of mt in the rc file has no influence on this.
All this is on Vista 64bits
bob
Posts: 20943
Joined: Mon Feb 27, 2006 7:30 pm
Location: Birmingham, AL

Re: Crafty 23.1 JA quirks

Post by bob »

F. Bluemers wrote:I replaced Jim's version with the version from Peter Skinner.
Maybe this will fix the timeloss behaviour

I just tested both from the command box and both create double logfiles and gamefiles on startup...The value of mt in the rc file has no influence on this.
All this is on Vista 64bits
The only way to get multiple log files in a single game is to send the "new" command. "new" re-initializes the engine, which advances to the next log.nnn file in sequence. There was a time that xboard was doing this. I removed it from the version I used to stop it. If you look at the source, I eventually "patched" Crafty (only under linux) so that it would look at the size of the last log.nnn file, and if it was too small to represent a real game, I overwrite it rather than creating a new one. You could look for "open(log_file" and remove the #if defined(LINUX) (the comments explain the code) to see if it will work under windows. If so, I will make this the default behaviour for windows also.
F. Bluemers
Posts: 868
Joined: Thu Mar 09, 2006 11:21 pm
Location: Nederland

Re: Crafty 23.1 JA quirks

Post by F. Bluemers »

I found the cause of the double created games and logs.
both Jim and Peter used

Code: Select all

log=off
in their crafty.rc files
so I used

Code: Select all

log=on 
.Crafy does not like that,it seems .

Code: Select all

log on
works as it should.
User avatar
beachknight
Posts: 3533
Joined: Tue Jan 09, 2007 8:33 pm
Location: Antalya, Turkey

Re: Crafty 23.1 JA quirks

Post by beachknight »

ie,

ponder off
and
log off

are correct ones, instead of:

ponder=off
and
log=off

Best,
hi, merhaba, hallo HT