09 Apr 2018 12:04:35 mbusd-0.3.1 started...
09 Apr 2018 12:04:35 tty: state now is TTY_PAUSE
09 Apr 2018 12:04:35 conn_loop(): select(): max_sd = 4, t_out = 000000:100000
09 Apr 2018 12:04:35 conn_loop(): select() returns 0
09 Apr 2018 12:04:35 tty: state now is TTY_READY
09 Apr 2018 12:04:35 conn_loop(): select(): max_sd = 4, t_out = 000060:000000
09 Apr 2018 12:04:44 conn_loop(): select() returns 1
09 Apr 2018 12:04:44 conn_open(): accepting connection from 192.168.49.154
09 Apr 2018 12:04:44 queue_new_elem(): length now is 1
09 Apr 2018 12:04:45 conn[192.168.49.154]: state now is CONN_HEADER
09 Apr 2018 12:04:45 conn_loop(): select(): max_sd = 5, t_out = 000060:000000
09 Apr 2018 12:05:06 conn_loop(): select() returns 1
09 Apr 2018 12:05:06 conn[192.168.49.154]: state now is CONN_RQST
09 Apr 2018 12:05:06 conn[192.168.49.154]: state now is CONN_TTY
09 Apr 2018 12:05:06 tty: state now is TTY_RQST
09 Apr 2018 12:05:06 conn_loop(): select(): max_sd = 4, t_out = 000060:000000
09 Apr 2018 12:05:06 conn_loop(): select() returns 1
09 Apr 2018 12:05:06 tty: written 13 bytes
09 Apr 2018 12:05:06 tty: request written (total 13 bytes)
09 Apr 2018 12:05:06 tty: state now is TTY_RESP
09 Apr 2018 12:05:06 tty: estimated 8 bytes, waiting 587499 usec
09 Apr 2018 12:05:06 conn_loop(): select(): max_sd = 4, t_out = 000000:587499
09 Apr 2018 12:05:07 conn_loop(): select() returns 0
09 Apr 2018 12:05:07 tty: response timeout
09 Apr 2018 12:05:07 tty: attempt to retry request (1 of 3)
09 Apr 2018 12:05:07 tty: state now is TTY_RQST
09 Apr 2018 12:05:07 tty: written 13 bytes
09 Apr 2018 12:05:07 tty: request written (total 13 bytes)
09 Apr 2018 12:05:07 tty: state now is TTY_RESP
09 Apr 2018 12:05:07 tty: estimated 8 bytes, waiting 587499 usec
09 Apr 2018 12:05:07 conn_loop(): select(): max_sd = 4, t_out = 000000:587499
09 Apr 2018 12:05:08 conn_loop(): select() returns 0
09 Apr 2018 12:05:08 tty: response timeout
09 Apr 2018 12:05:08 tty: attempt to retry request (2 of 3)
09 Apr 2018 12:05:08 tty: state now is TTY_RQST
09 Apr 2018 12:05:08 tty: written 13 bytes
09 Apr 2018 12:05:08 tty: request written (total 13 bytes)
09 Apr 2018 12:05:08 tty: state now is TTY_RESP
09 Apr 2018 12:05:08 tty: estimated 8 bytes, waiting 587499 usec
09 Apr 2018 12:05:08 conn_loop(): select(): max_sd = 4, t_out = 000000:587499
09 Apr 2018 12:05:08 conn_loop(): select() returns 0
09 Apr 2018 12:05:08 tty: response timeout
09 Apr 2018 12:05:08 tty: attempt to retry request (3 of 3)
09 Apr 2018 12:05:08 tty: state now is TTY_RQST
09 Apr 2018 12:05:08 tty: written 13 bytes
09 Apr 2018 12:05:08 tty: request written (total 13 bytes)
09 Apr 2018 12:05:08 tty: state now is TTY_RESP
09 Apr 2018 12:05:08 tty: estimated 8 bytes, waiting 587499 usec
09 Apr 2018 12:05:08 conn_loop(): select(): max_sd = 4, t_out = 000000:587499
09 Apr 2018 12:05:09 conn_loop(): select() returns 0
09 Apr 2018 12:05:09 tty: response timeout
09 Apr 2018 12:05:09 conn[192.168.49.154]: state now is CONN_RESP
09 Apr 2018 12:05:09 tty: state now is TTY_PAUSE
09 Apr 2018 12:05:09 conn_loop(): select(): max_sd = 5, t_out = 000000:100000
09 Apr 2018 12:05:09 conn_loop(): select() returns 1
09 Apr 2018 12:05:09 conn[192.168.49.154]: state now is CONN_HEADER
09 Apr 2018 12:05:09 conn_loop(): select(): max_sd = 5, t_out = 000000:099686
09 Apr 2018 12:05:09 conn_loop(): select() returns 0
09 Apr 2018 12:05:09 tty: state now is TTY_READY
09 Apr 2018 12:05:09 conn_loop(): select(): max_sd = 5, t_out = 000060:000000
09 Apr 2018 12:06:09 conn_loop(): select() returns 0
09 Apr 2018 12:06:09 conn[192.168.49.154]: timeout, closing connection
09 Apr 2018 12:06:09 conn_close(): closing connection from 192.168.49.154
09 Apr 2018 12:06:09 queue_delete_elem(): length now is 0
09 Apr 2018 12:06:09 conn_loop(): select(): max_sd = 4, t_out = 000060:000000
09 Apr 2018 12:06:13 conn_loop(): select() returns -1
09 Apr 2018 12:06:13 Terminated by signal: SIGTERM