info string Info 2021-07-06 11:11:42-944: Received command : "go ponder wtime 28236 btime 25724 winc 300 binc 300"
[...] <<<<==== starting the search
info string Info 2021-07-06 11:11:42-944: Received command : "ponderhit" <<<<<==== at the exact same time (ms resolution)
[...] <<<<===== at this point Minic will thus search BUT as ponderhit is already sent, will use a finite time
info string Info 2021-07-06 11:11:42-944: requested time 1798 (1798)
[...]
info string Info 2021-07-06 11:11:44-602: sending move to GUI g8f6
bestmove g8f6 ponder b1c3
[...]
info string Info 2021-07-06 11:11:44-603: Received command : "position startpos moves e2e4 e7e6 d2d4 d7d5 e4d5 e6d5 g1f3 g8f6 b1c3"
[...]
I'm a bit confused
If I filter the log to get only received command from Banksia and best move sending from Minic
info string Info 2021-07-06 11:11:34-711: Received command : "uci"
info string Info 2021-07-06 11:11:34-711: Received command : "setoption name Hash value 64"
info string Info 2021-07-06 11:11:34-733: Received command : "setoption name Threads value 1"
info string Info 2021-07-06 11:11:34-738: Received command : "setoption name Ponder value true"
info string Info 2021-07-06 11:11:34-738: Received command : "isready"
info string Info 2021-07-06 11:11:34-904: Received command : "ucinewgame"
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:37-058: Received command : "position startpos moves e2e4"
info string Info 2021-07-06 11:11:37-058: Received command : "go wtime 28346 btime 30000 winc 300 binc 300"
bestmove e7e6 ponder d2d4
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:38-525: Received command : "position startpos moves e2e4 e7e6 d2d4"
info string Info 2021-07-06 11:11:38-525: Received command : "go ponder wtime 28646 btime 28532 winc 300 binc 300"
info string Info 2021-07-06 11:11:38-599: Received command : "ponderhit"
bestmove d7d5 ponder b1c3
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:39-820: Received command : "position startpos moves e2e4 e7e6 d2d4 d7d5 b1c3"
info string Info 2021-07-06 11:11:39-820: Received command : "go ponder wtime 28872 btime 27615 winc 300 binc 300"
info string Info 2021-07-06 11:11:40-753: Received command : "stop"
bestmove g8f6 ponder e4d5
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:40-754: Received command : "position startpos moves e2e4 e7e6 d2d4 d7d5 e4d5"
info string Info 2021-07-06 11:11:40-754: Received command : "go wtime 27936 btime 27915 winc 300 binc 300"
bestmove e6d5 ponder g1f3
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:42-944: Received command : "position startpos moves e2e4 e7e6 d2d4 d7d5 e4d5 e6d5 g1f3"
info string Info 2021-07-06 11:11:42-944: Received command : "go ponder wtime 28236 btime 25724 winc 300 binc 300"
info string Info 2021-07-06 11:11:42-944: Received command : "ponderhit" <<<<<<<<<<<<========== ????????
bestmove g8f6 ponder b1c3
---------------------------------------------------------------------------------------------
info string Info 2021-07-06 11:11:44-603: Received command : "position startpos moves e2e4 e7e6 d2d4 d7d5 e4d5 e6d5 g1f3 g8f6 b1c3"
info string Info 2021-07-06 11:11:44-603: Received command : "go ponder wtime 28526 btime 24366 winc 300 binc 300"
info string Info 2021-07-06 11:11:44-603: Received command : "stop" <<<<<<<<<<<<========== ????????
info string Info 2021-07-06 12:51:44-266: Received command : "go ponder wtime 596 btime 260 winc 100 binc 100"
info string Info 2021-07-06 12:51:44-266: Received command : "ponderhit"
xr_a_y wrote: ↑Tue Jul 06, 2021 1:18 pm
cutechess can do the exact same thing : send go ponder and just after ponderhit. Seems it is related to very near mate situation
info string Info 2021-07-06 12:51:44-266: Received command : "go ponder wtime 596 btime 260 winc 100 binc 100"
info string Info 2021-07-06 12:51:44-266: Received command : "ponderhit"
Maybe it's because when it's the opponent's turn, it's an instant move (as it was also pondering), so it's a very fast sequence. I don't know, just thinking what may be the reason.
Engine A plays a move and starts pondering
Engine B starts thinking
Engine B plays a move and starts pondering, but engine A answers that move with another move instantly, as it guessed the Engine B's move
xr_a_y wrote: ↑Tue Jul 06, 2021 1:18 pm
cutechess can do the exact same thing : send go ponder and just after ponderhit. Seems it is related to very near mate situation
info string Info 2021-07-06 12:51:44-266: Received command : "go ponder wtime 596 btime 260 winc 100 binc 100"
info string Info 2021-07-06 12:51:44-266: Received command : "ponderhit"
Maybe it's because when it's the opponent's turn, it's an instant move (as it was also pondering), so it's a very fast sequence. I don't know, just thinking what may be the reason.
Engine A plays a move and starts pondering
Engine B starts thinking
Engine B plays a move and starts pondering, but engine A answers that move with another move instantly, as it guessed the Engine B's move