root@wirenboard-AVZTYW4Z:~# docker run -ti -v /dev/ttyRS485-1:/dev/serial --privileged -v /etc/mbusd.conf:/opt/mbusd.conf -p 1502:502  --name=mbusd  quenorha/mbusd -v9
24 Sep 2023 16:10:07 mbusd-0.5.1 started...
24 Sep 2023 16:10:07 tty: trying to open /dev/ttyS0 (speed 9600 mode 8n2)
24 Sep 2023 16:10:07 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:07 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:07 conn_loop(): select() returns 0
24 Sep 2023 16:10:07 tty: state now is TTY_READY
24 Sep 2023 16:10:07 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:13 conn_loop(): select() returns 1
24 Sep 2023 16:10:13 conn_open(): accepting connection from 192.168.0.135
24 Sep 2023 16:10:13 queue_new_elem(): length now is 1
24 Sep 2023 16:10:13 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:13 conn_loop(): select(): max_sd = 5, t_out = 4227156:000060
24 Sep 2023 16:10:14 conn_loop(): select() returns 1
24 Sep 2023 16:10:14 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:14 conn_loop(): select(): max_sd = 5, t_out = 4227156:000060
24 Sep 2023 16:10:14 conn_loop(): select() returns 1
24 Sep 2023 16:10:14 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:14 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:14 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:14 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:14 tty: state now is TTY_RQST
24 Sep 2023 16:10:14 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:14 conn_loop(): select() returns 1
24 Sep 2023 16:10:14 tty: written 8 bytes
24 Sep 2023 16:10:14 tty: request written (total 8 bytes)
24 Sep 2023 16:10:14 tty: state now is TTY_RESP
24 Sep 2023 16:10:14 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:14 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:14 conn_loop(): select() returns 0
24 Sep 2023 16:10:14 tty: response timeout
24 Sep 2023 16:10:14 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:14 tty: state now is TTY_RQST
24 Sep 2023 16:10:14 tty: written 8 bytes
24 Sep 2023 16:10:14 tty: request written (total 8 bytes)
24 Sep 2023 16:10:14 tty: state now is TTY_RESP
24 Sep 2023 16:10:14 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:14 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:15 conn_loop(): select() returns 0
24 Sep 2023 16:10:15 tty: response timeout
24 Sep 2023 16:10:15 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:15 tty: state now is TTY_RQST
24 Sep 2023 16:10:15 tty: written 8 bytes
24 Sep 2023 16:10:15 tty: request written (total 8 bytes)
24 Sep 2023 16:10:15 tty: state now is TTY_RESP
24 Sep 2023 16:10:15 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:15 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 0
24 Sep 2023 16:10:16 tty: response timeout
24 Sep 2023 16:10:16 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:16 tty: state now is TTY_RQST
24 Sep 2023 16:10:16 tty: written 8 bytes
24 Sep 2023 16:10:16 tty: request written (total 8 bytes)
24 Sep 2023 16:10:16 tty: state now is TTY_RESP
24 Sep 2023 16:10:16 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 0
24 Sep 2023 16:10:16 tty: response timeout
24 Sep 2023 16:10:16 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:16 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 1
24 Sep 2023 16:10:16 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 1
24 Sep 2023 16:10:16 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 1
24 Sep 2023 16:10:16 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:16 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:16 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:16 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:16 conn_loop(): select() returns 0
24 Sep 2023 16:10:16 tty: state now is TTY_RQST
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 4, t_out = 4227156:000059
24 Sep 2023 16:10:16 conn_loop(): select() returns 1
24 Sep 2023 16:10:16 tty: written 8 bytes
24 Sep 2023 16:10:16 tty: request written (total 8 bytes)
24 Sep 2023 16:10:16 tty: state now is TTY_RESP
24 Sep 2023 16:10:16 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:16 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:17 conn_loop(): select() returns 0
24 Sep 2023 16:10:17 tty: response timeout
24 Sep 2023 16:10:17 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:17 tty: state now is TTY_RQST
24 Sep 2023 16:10:17 tty: written 8 bytes
24 Sep 2023 16:10:17 tty: request written (total 8 bytes)
24 Sep 2023 16:10:17 tty: state now is TTY_RESP
24 Sep 2023 16:10:17 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:17 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:17 conn_loop(): select() returns 0
24 Sep 2023 16:10:17 tty: response timeout
24 Sep 2023 16:10:17 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:17 tty: state now is TTY_RQST
24 Sep 2023 16:10:17 tty: written 8 bytes
24 Sep 2023 16:10:17 tty: request written (total 8 bytes)
24 Sep 2023 16:10:17 tty: state now is TTY_RESP
24 Sep 2023 16:10:17 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:17 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 0
24 Sep 2023 16:10:18 tty: response timeout
24 Sep 2023 16:10:18 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:18 tty: state now is TTY_RQST
24 Sep 2023 16:10:18 tty: written 8 bytes
24 Sep 2023 16:10:18 tty: request written (total 8 bytes)
24 Sep 2023 16:10:18 tty: state now is TTY_RESP
24 Sep 2023 16:10:18 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 0
24 Sep 2023 16:10:18 tty: response timeout
24 Sep 2023 16:10:18 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:18 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 1
24 Sep 2023 16:10:18 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 1
24 Sep 2023 16:10:18 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 1
24 Sep 2023 16:10:18 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:18 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:18 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:18 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:18 conn_loop(): select() returns 0
24 Sep 2023 16:10:18 tty: state now is TTY_RQST
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:18 conn_loop(): select() returns 1
24 Sep 2023 16:10:18 tty: written 8 bytes
24 Sep 2023 16:10:18 tty: request written (total 8 bytes)
24 Sep 2023 16:10:18 tty: state now is TTY_RESP
24 Sep 2023 16:10:18 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:18 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:19 conn_loop(): select() returns 0
24 Sep 2023 16:10:19 tty: response timeout
24 Sep 2023 16:10:19 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:19 tty: state now is TTY_RQST
24 Sep 2023 16:10:19 tty: written 8 bytes
24 Sep 2023 16:10:19 tty: request written (total 8 bytes)
24 Sep 2023 16:10:19 tty: state now is TTY_RESP
24 Sep 2023 16:10:19 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:19 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:19 conn_loop(): select() returns 0
24 Sep 2023 16:10:19 tty: response timeout
24 Sep 2023 16:10:19 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:19 tty: state now is TTY_RQST
24 Sep 2023 16:10:19 tty: written 8 bytes
24 Sep 2023 16:10:19 tty: request written (total 8 bytes)
24 Sep 2023 16:10:19 tty: state now is TTY_RESP
24 Sep 2023 16:10:19 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:19 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:20 conn_loop(): select() returns 0
24 Sep 2023 16:10:20 tty: response timeout
24 Sep 2023 16:10:20 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:20 tty: state now is TTY_RQST
24 Sep 2023 16:10:20 tty: written 8 bytes
24 Sep 2023 16:10:20 tty: request written (total 8 bytes)
24 Sep 2023 16:10:20 tty: state now is TTY_RESP
24 Sep 2023 16:10:20 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:20 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:20 conn_loop(): select() returns 0
24 Sep 2023 16:10:20 tty: response timeout
24 Sep 2023 16:10:20 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:20 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:20 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:20 conn_loop(): select() returns 1
24 Sep 2023 16:10:20 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:20 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:20 conn_loop(): select() returns 1
24 Sep 2023 16:10:20 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:20 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:20 conn_loop(): select() returns 1
24 Sep 2023 16:10:20 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:20 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:20 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:20 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:20 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:21 conn_loop(): select() returns 0
24 Sep 2023 16:10:21 tty: state now is TTY_RQST
24 Sep 2023 16:10:21 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:21 conn_loop(): select() returns 1
24 Sep 2023 16:10:21 tty: written 8 bytes
24 Sep 2023 16:10:21 tty: request written (total 8 bytes)
24 Sep 2023 16:10:21 tty: state now is TTY_RESP
24 Sep 2023 16:10:21 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:21 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:21 conn_loop(): select() returns 0
24 Sep 2023 16:10:21 tty: response timeout
24 Sep 2023 16:10:21 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:21 tty: state now is TTY_RQST
24 Sep 2023 16:10:21 tty: written 8 bytes
24 Sep 2023 16:10:21 tty: request written (total 8 bytes)
24 Sep 2023 16:10:21 tty: state now is TTY_RESP
24 Sep 2023 16:10:21 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:21 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:22 conn_loop(): select() returns 0
24 Sep 2023 16:10:22 tty: response timeout
24 Sep 2023 16:10:22 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:22 tty: state now is TTY_RQST
24 Sep 2023 16:10:22 tty: written 8 bytes
24 Sep 2023 16:10:22 tty: request written (total 8 bytes)
24 Sep 2023 16:10:22 tty: state now is TTY_RESP
24 Sep 2023 16:10:22 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:22 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:22 conn_loop(): select() returns 0
24 Sep 2023 16:10:22 tty: response timeout
24 Sep 2023 16:10:22 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:22 tty: state now is TTY_RQST
24 Sep 2023 16:10:22 tty: written 8 bytes
24 Sep 2023 16:10:22 tty: request written (total 8 bytes)
24 Sep 2023 16:10:22 tty: state now is TTY_RESP
24 Sep 2023 16:10:22 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:22 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 0
24 Sep 2023 16:10:23 tty: response timeout
24 Sep 2023 16:10:23 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:23 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 1
24 Sep 2023 16:10:23 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 1
24 Sep 2023 16:10:23 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 1
24 Sep 2023 16:10:23 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:23 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:23 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:23 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 0
24 Sep 2023 16:10:23 tty: state now is TTY_RQST
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:23 conn_loop(): select() returns 1
24 Sep 2023 16:10:23 tty: written 8 bytes
24 Sep 2023 16:10:23 tty: request written (total 8 bytes)
24 Sep 2023 16:10:23 tty: state now is TTY_RESP
24 Sep 2023 16:10:23 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:23 conn_loop(): select() returns 0
24 Sep 2023 16:10:23 tty: response timeout
24 Sep 2023 16:10:23 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:23 tty: state now is TTY_RQST
24 Sep 2023 16:10:23 tty: written 8 bytes
24 Sep 2023 16:10:23 tty: request written (total 8 bytes)
24 Sep 2023 16:10:23 tty: state now is TTY_RESP
24 Sep 2023 16:10:23 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:23 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:24 conn_loop(): select() returns 0
24 Sep 2023 16:10:24 tty: response timeout
24 Sep 2023 16:10:24 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:24 tty: state now is TTY_RQST
24 Sep 2023 16:10:24 tty: written 8 bytes
24 Sep 2023 16:10:24 tty: request written (total 8 bytes)
24 Sep 2023 16:10:24 tty: state now is TTY_RESP
24 Sep 2023 16:10:24 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:24 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:24 conn_loop(): select() returns 0
24 Sep 2023 16:10:24 tty: response timeout
24 Sep 2023 16:10:24 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:24 tty: state now is TTY_RQST
24 Sep 2023 16:10:24 tty: written 8 bytes
24 Sep 2023 16:10:24 tty: request written (total 8 bytes)
24 Sep 2023 16:10:24 tty: state now is TTY_RESP
24 Sep 2023 16:10:24 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:24 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 0
24 Sep 2023 16:10:25 tty: response timeout
24 Sep 2023 16:10:25 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:25 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 1
24 Sep 2023 16:10:25 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 1
24 Sep 2023 16:10:25 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 1
24 Sep 2023 16:10:25 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:25 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:25 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:25 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 0
24 Sep 2023 16:10:25 tty: state now is TTY_RQST
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:25 conn_loop(): select() returns 1
24 Sep 2023 16:10:25 tty: written 8 bytes
24 Sep 2023 16:10:25 tty: request written (total 8 bytes)
24 Sep 2023 16:10:25 tty: state now is TTY_RESP
24 Sep 2023 16:10:25 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:25 conn_loop(): select() returns 0
24 Sep 2023 16:10:25 tty: response timeout
24 Sep 2023 16:10:25 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:25 tty: state now is TTY_RQST
24 Sep 2023 16:10:25 tty: written 8 bytes
24 Sep 2023 16:10:25 tty: request written (total 8 bytes)
24 Sep 2023 16:10:25 tty: state now is TTY_RESP
24 Sep 2023 16:10:25 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:25 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:26 conn_loop(): select() returns 0
24 Sep 2023 16:10:26 tty: response timeout
24 Sep 2023 16:10:26 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:26 tty: state now is TTY_RQST
24 Sep 2023 16:10:26 tty: written 8 bytes
24 Sep 2023 16:10:26 tty: request written (total 8 bytes)
24 Sep 2023 16:10:26 tty: state now is TTY_RESP
24 Sep 2023 16:10:26 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:26 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 0
24 Sep 2023 16:10:27 tty: response timeout
24 Sep 2023 16:10:27 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:27 tty: state now is TTY_RQST
24 Sep 2023 16:10:27 tty: written 8 bytes
24 Sep 2023 16:10:27 tty: request written (total 8 bytes)
24 Sep 2023 16:10:27 tty: state now is TTY_RESP
24 Sep 2023 16:10:27 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 0
24 Sep 2023 16:10:27 tty: response timeout
24 Sep 2023 16:10:27 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:27 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 1
24 Sep 2023 16:10:27 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 1
24 Sep 2023 16:10:27 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 1
24 Sep 2023 16:10:27 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:27 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:27 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:27 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:27 conn_loop(): select() returns 0
24 Sep 2023 16:10:27 tty: state now is TTY_RQST
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 4, t_out = 4227156:000059
24 Sep 2023 16:10:27 conn_loop(): select() returns 1
24 Sep 2023 16:10:27 tty: written 8 bytes
24 Sep 2023 16:10:27 tty: request written (total 8 bytes)
24 Sep 2023 16:10:27 tty: state now is TTY_RESP
24 Sep 2023 16:10:27 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:27 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:28 conn_loop(): select() returns 0
24 Sep 2023 16:10:28 tty: response timeout
24 Sep 2023 16:10:28 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:28 tty: state now is TTY_RQST
24 Sep 2023 16:10:28 tty: written 8 bytes
24 Sep 2023 16:10:28 tty: request written (total 8 bytes)
24 Sep 2023 16:10:28 tty: state now is TTY_RESP
24 Sep 2023 16:10:28 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:28 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:28 conn_loop(): select() returns 0
24 Sep 2023 16:10:28 tty: response timeout
24 Sep 2023 16:10:28 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:28 tty: state now is TTY_RQST
24 Sep 2023 16:10:28 tty: written 8 bytes
24 Sep 2023 16:10:28 tty: request written (total 8 bytes)
24 Sep 2023 16:10:28 tty: state now is TTY_RESP
24 Sep 2023 16:10:28 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:28 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 0
24 Sep 2023 16:10:29 tty: response timeout
24 Sep 2023 16:10:29 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:29 tty: state now is TTY_RQST
24 Sep 2023 16:10:29 tty: written 8 bytes
24 Sep 2023 16:10:29 tty: request written (total 8 bytes)
24 Sep 2023 16:10:29 tty: state now is TTY_RESP
24 Sep 2023 16:10:29 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 0
24 Sep 2023 16:10:29 tty: response timeout
24 Sep 2023 16:10:29 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:29 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 1
24 Sep 2023 16:10:29 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 1
24 Sep 2023 16:10:29 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 1
24 Sep 2023 16:10:29 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:29 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:29 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:29 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:29 conn_loop(): select() returns 0
24 Sep 2023 16:10:29 tty: state now is TTY_RQST
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:29 conn_loop(): select() returns 1
24 Sep 2023 16:10:29 tty: written 8 bytes
24 Sep 2023 16:10:29 tty: request written (total 8 bytes)
24 Sep 2023 16:10:29 tty: state now is TTY_RESP
24 Sep 2023 16:10:29 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:29 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:30 conn_loop(): select() returns 0
24 Sep 2023 16:10:30 tty: response timeout
24 Sep 2023 16:10:30 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:30 tty: state now is TTY_RQST
24 Sep 2023 16:10:30 tty: written 8 bytes
24 Sep 2023 16:10:30 tty: request written (total 8 bytes)
24 Sep 2023 16:10:30 tty: state now is TTY_RESP
24 Sep 2023 16:10:30 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:30 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:30 conn_loop(): select() returns 0
24 Sep 2023 16:10:30 tty: response timeout
24 Sep 2023 16:10:30 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:30 tty: state now is TTY_RQST
24 Sep 2023 16:10:30 tty: written 8 bytes
24 Sep 2023 16:10:30 tty: request written (total 8 bytes)
24 Sep 2023 16:10:30 tty: state now is TTY_RESP
24 Sep 2023 16:10:30 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:30 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:31 conn_loop(): select() returns 0
24 Sep 2023 16:10:31 tty: response timeout
24 Sep 2023 16:10:31 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:31 tty: state now is TTY_RQST
24 Sep 2023 16:10:31 tty: written 8 bytes
24 Sep 2023 16:10:31 tty: request written (total 8 bytes)
24 Sep 2023 16:10:31 tty: state now is TTY_RESP
24 Sep 2023 16:10:31 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:31 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:31 conn_loop(): select() returns 0
24 Sep 2023 16:10:31 tty: response timeout
24 Sep 2023 16:10:31 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:31 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:31 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:31 conn_loop(): select() returns 1
24 Sep 2023 16:10:31 conn[192.168.0.135]: state now is CONN_HEADER
24 Sep 2023 16:10:31 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:31 conn_loop(): select() returns 1
24 Sep 2023 16:10:31 conn[192.168.0.135]: state now is CONN_RQST_FUNC
24 Sep 2023 16:10:31 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:31 conn_loop(): select() returns 1
24 Sep 2023 16:10:31 conn[192.168.0.135]: read request fc 3
24 Sep 2023 16:10:31 conn[192.168.0.135]: state now is CONN_RQST_TAIL
24 Sep 2023 16:10:31 conn[192.168.0.135]: request: [1f][03][00][00][00][02]
24 Sep 2023 16:10:31 conn[192.168.0.135]: state now is CONN_TTY
24 Sep 2023 16:10:31 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:32 conn_loop(): select() returns 0
24 Sep 2023 16:10:32 tty: state now is TTY_RQST
24 Sep 2023 16:10:32 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
24 Sep 2023 16:10:32 conn_loop(): select() returns 1
24 Sep 2023 16:10:32 tty: written 8 bytes
24 Sep 2023 16:10:32 tty: request written (total 8 bytes)
24 Sep 2023 16:10:32 tty: state now is TTY_RESP
24 Sep 2023 16:10:32 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:32 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:32 conn_loop(): select() returns 0
24 Sep 2023 16:10:32 tty: response timeout
24 Sep 2023 16:10:32 tty: attempt to retry request (1 of 3)
24 Sep 2023 16:10:32 tty: state now is TTY_RQST
24 Sep 2023 16:10:32 tty: written 8 bytes
24 Sep 2023 16:10:32 tty: request written (total 8 bytes)
24 Sep 2023 16:10:32 tty: state now is TTY_RESP
24 Sep 2023 16:10:32 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:32 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:33 conn_loop(): select() returns 0
24 Sep 2023 16:10:33 tty: response timeout
24 Sep 2023 16:10:33 tty: attempt to retry request (2 of 3)
24 Sep 2023 16:10:33 tty: state now is TTY_RQST
24 Sep 2023 16:10:33 tty: written 8 bytes
24 Sep 2023 16:10:33 tty: request written (total 8 bytes)
24 Sep 2023 16:10:33 tty: state now is TTY_RESP
24 Sep 2023 16:10:33 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:33 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:33 conn_loop(): select() returns 0
24 Sep 2023 16:10:33 tty: response timeout
24 Sep 2023 16:10:33 tty: attempt to retry request (3 of 3)
24 Sep 2023 16:10:33 tty: state now is TTY_RQST
24 Sep 2023 16:10:33 tty: written 8 bytes
24 Sep 2023 16:10:33 tty: request written (total 8 bytes)
24 Sep 2023 16:10:33 tty: state now is TTY_RESP
24 Sep 2023 16:10:33 tty: estimated 9 bytes, waiting 519478 usec
24 Sep 2023 16:10:33 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:34 conn_loop(): select() returns 0
24 Sep 2023 16:10:34 tty: response timeout
24 Sep 2023 16:10:34 conn[192.168.0.135]: state now is CONN_RESP
24 Sep 2023 16:10:34 tty: state now is TTY_PAUSE
24 Sep 2023 16:10:34 conn_loop(): select(): max_sd = 5, t_out = 4227156:000000
24 Sep 2023 16:10:34 conn_loop(): select() returns 1
24 Sep 2023 16:10:34 conn_close(): closing connection from 192.168.0.135
24 Sep 2023 16:10:34 queue_delete_elem(): length now is 0
24 Sep 2023 16:10:34 conn_loop(): select(): max_sd = 4, t_out = 4227156:000000
24 Sep 2023 16:10:34 conn_loop(): select() returns 0
24 Sep 2023 16:10:34 tty: state now is TTY_READY
24 Sep 2023 16:10:34 conn_loop(): select(): max_sd = 4, t_out = 4227156:000060
^C24 Sep 2023 16:10:36 conn_loop(): select() returns -1
24 Sep 2023 16:10:36 conn_loop(): error in select() (Invalid argument)
24 Sep 2023 16:10:36 conn_open(): error in accept() (Resource temporarily unavailable)
24 Sep 2023 16:10:36 tty: read(): no data available
24 Sep 2023 16:10:36 Terminated by signal: SIGINT