1450287603:996806 mbusd-0.2.1 started... 1450287604:000307 tty: state now is TTY_PAUSE 1450287604:001310 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287604:102049 conn_loop(): select() returns 0 1450287604:102778 tty: state now is TTY_READY 1450287604:103351 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287607:930356 conn_loop(): select() returns 1 1450287607:930852 conn_open(): accepting connection from 192.168.0.104 1450287607:931049 queue_new_elem(): length now is 1 1450287607:931208 conn[192.168.0.104]: state now is CONN_HEADER 1450287607:931371 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287608:374668 conn_loop(): select() returns 1 1450287608:375145 conn[192.168.0.104]: state now is CONN_RQST 1450287608:375337 conn[192.168.0.104]: state now is CONN_TTY 1450287608:375466 tty: state now is TTY_RQST 1450287608:377713 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287608:377872 conn_loop(): select() returns 1 1450287608:390180 tty: written 8 bytes 1450287608:390758 tty: request written (total 8 bytes) 1450287608:391402 tty: state now is TTY_RESP 1450287608:391869 tty: estimated 25 bytes, waiting 84374 usec 1450287608:392297 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287608:425399 conn_loop(): select() returns 1 1450287608:426242 tty: read 1 bytes 1450287608:427125 tty: read 1 bytes of 25, offset 0 1450287608:428250 conn_loop(): select(): max_sd = 4, t_out = 000000:050448 1450287608:428939 conn_loop(): select() returns 1 1450287608:429925 tty: read 4 bytes 1450287608:430543 tty: rx offset is 0 1450287608:431452 tty: read 5 bytes of 25, offset 0 1450287608:432129 conn_loop(): select(): max_sd = 4, t_out = 000000:048790 1450287608:433151 conn_loop(): select() returns 1 1450287608:433986 tty: read 4 bytes 1450287608:434813 tty: read 9 bytes of 25, offset 0 1450287608:435628 conn_loop(): select(): max_sd = 4, t_out = 000000:046994 1450287608:436434 conn_loop(): select() returns 1 1450287608:437233 tty: read 3 bytes 1450287608:438241 tty: read 12 bytes of 25, offset 0 1450287608:439006 conn_loop(): select(): max_sd = 4, t_out = 000000:045406 1450287608:440234 conn_loop(): select() returns 1 1450287608:440975 tty: read 4 bytes 1450287608:441398 tty: read 16 bytes of 25, offset 0 1450287608:441853 conn_loop(): select(): max_sd = 4, t_out = 000000:043473 1450287608:442521 conn_loop(): select() returns 1 1450287608:443218 tty: read 1 bytes 1450287608:443778 tty: read 17 bytes of 25, offset 0 1450287608:444249 conn_loop(): select(): max_sd = 4, t_out = 000000:042141 1450287608:444932 conn_loop(): select() returns 1 1450287608:445476 tty: read 3 bytes 1450287608:445904 tty: read 20 bytes of 25, offset 0 1450287608:446535 conn_loop(): select(): max_sd = 4, t_out = 000000:040925 1450287608:447304 conn_loop(): select() returns 1 1450287608:447812 tty: read 3 bytes 1450287608:448129 tty: read 23 bytes of 25, offset 0 1450287608:448418 conn_loop(): select(): max_sd = 4, t_out = 000000:039657 1450287608:449185 conn_loop(): select() returns 1 1450287608:449667 tty: read 1 bytes 1450287608:450248 tty: read 24 bytes of 25, offset 0 1450287608:450886 conn_loop(): select(): max_sd = 4, t_out = 000000:038420 1450287608:451324 conn_loop(): select() returns 1 1450287608:451867 tty: read 1 bytes 1450287608:452355 tty: read 25 bytes of 25, offset 0 1450287608:453170 tty: state now is TTY_PROC 1450287608:453759 tty: response read (total 25 bytes, offset 0 bytes) 1450287608:454459 tty: response is correct 1450287608:455087 conn[192.168.0.104]: state now is CONN_RESP 1450287608:455795 tty: state now is TTY_PAUSE 1450287608:456350 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287608:457228 conn_loop(): select() returns 1 1450287608:458099 conn[192.168.0.104]: state now is CONN_HEADER 1450287608:458894 conn_loop(): select(): max_sd = 5, t_out = 000000:098430 1450287608:558614 conn_loop(): select() returns 0 1450287608:559448 tty: state now is TTY_READY 1450287608:560011 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287608:879913 conn_loop(): select() returns 1 1450287608:880537 conn[192.168.0.104]: state now is CONN_RQST 1450287608:880761 conn[192.168.0.104]: state now is CONN_TTY 1450287608:880897 tty: state now is TTY_RQST 1450287608:883136 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287608:883378 conn_loop(): select() returns 1 1450287608:895715 tty: written 8 bytes 1450287608:896087 tty: request written (total 8 bytes) 1450287608:896259 tty: state now is TTY_RESP 1450287608:896391 tty: estimated 25 bytes, waiting 84374 usec 1450287608:896545 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287608:935700 conn_loop(): select() returns 1 1450287608:936470 tty: read 1 bytes 1450287608:937118 tty: read 1 bytes of 25, offset 0 1450287608:937541 conn_loop(): select(): max_sd = 4, t_out = 000000:044467 1450287608:938171 conn_loop(): select() returns 1 1450287608:938905 tty: read 3 bytes 1450287608:939604 tty: rx offset is 0 1450287608:940306 tty: read 4 bytes of 25, offset 0 1450287608:940737 conn_loop(): select(): max_sd = 4, t_out = 000000:043114 1450287608:941297 conn_loop(): select() returns 1 1450287608:941828 tty: read 2 bytes 1450287608:942226 tty: read 6 bytes of 25, offset 0 1450287608:943175 conn_loop(): select(): max_sd = 4, t_out = 000000:042034 1450287608:943522 conn_loop(): select() returns 1 1450287608:944183 tty: read 3 bytes 1450287608:944861 tty: read 9 bytes of 25, offset 0 1450287608:945546 conn_loop(): select(): max_sd = 4, t_out = 000000:041074 1450287608:945998 conn_loop(): select() returns 1 1450287608:946560 tty: read 1 bytes 1450287608:947245 tty: read 10 bytes of 25, offset 0 1450287608:947661 conn_loop(): select(): max_sd = 4, t_out = 000000:040070 1450287608:948102 conn_loop(): select() returns 1 1450287608:948690 tty: read 3 bytes 1450287608:949082 tty: read 13 bytes of 25, offset 0 1450287608:949966 conn_loop(): select(): max_sd = 4, t_out = 000000:039051 1450287608:950834 conn_loop(): select() returns 1 1450287608:951426 tty: read 3 bytes 1450287608:951835 tty: read 16 bytes of 25, offset 0 1450287608:952506 conn_loop(): select(): max_sd = 4, t_out = 000000:037601 1450287608:952978 conn_loop(): select() returns 1 1450287608:953875 tty: read 2 bytes 1450287608:954377 tty: read 18 bytes of 25, offset 0 1450287608:954808 conn_loop(): select(): max_sd = 4, t_out = 000000:036242 1450287608:955706 conn_loop(): select() returns 1 1450287608:956185 tty: read 2 bytes 1450287608:956813 tty: read 20 bytes of 25, offset 0 1450287608:957228 conn_loop(): select(): max_sd = 4, t_out = 000000:034876 1450287608:957671 conn_loop(): select() returns 1 1450287608:958256 tty: read 2 bytes 1450287608:958663 tty: read 22 bytes of 25, offset 0 1450287608:959345 conn_loop(): select(): max_sd = 4, t_out = 000000:033858 1450287608:959786 conn_loop(): select() returns 1 1450287608:960120 tty: read 2 bytes 1450287608:961060 tty: read 24 bytes of 25, offset 0 1450287608:961600 conn_loop(): select(): max_sd = 4, t_out = 000000:033094 1450287608:962422 conn_loop(): select() returns 1 1450287608:963132 tty: read 1 bytes 1450287608:963585 tty: read 25 bytes of 25, offset 0 1450287608:963998 tty: state now is TTY_PROC 1450287608:964331 tty: response read (total 25 bytes, offset 0 bytes) 1450287608:965153 tty: response is correct 1450287608:965672 conn[192.168.0.104]: state now is CONN_RESP 1450287608:966476 tty: state now is TTY_PAUSE 1450287608:966968 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287608:967540 conn_loop(): select() returns 1 1450287608:968088 conn[192.168.0.104]: state now is CONN_HEADER 1450287608:968627 conn_loop(): select(): max_sd = 5, t_out = 000000:099001 1450287609:068231 conn_loop(): select() returns 0 1450287609:069083 tty: state now is TTY_READY 1450287609:069927 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287609:388649 conn_loop(): select() returns 1 1450287609:389005 conn[192.168.0.104]: state now is CONN_RQST 1450287609:389187 conn[192.168.0.104]: state now is CONN_TTY 1450287609:389332 tty: state now is TTY_RQST 1450287609:391597 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287609:391808 conn_loop(): select() returns 1 1450287609:404125 tty: written 8 bytes 1450287609:404739 tty: request written (total 8 bytes) 1450287609:405205 tty: state now is TTY_RESP 1450287609:405520 tty: estimated 25 bytes, waiting 84374 usec 1450287609:405900 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287609:447322 conn_loop(): select() returns 1 1450287609:448154 tty: read 1 bytes 1450287609:449283 tty: read 1 bytes of 25, offset 0 1450287609:450187 conn_loop(): select(): max_sd = 4, t_out = 000000:042139 1450287609:451141 conn_loop(): select() returns 1 1450287609:451885 tty: read 4 bytes 1450287609:452826 tty: rx offset is 0 1450287609:453282 tty: read 5 bytes of 25, offset 0 1450287609:453855 conn_loop(): select(): max_sd = 4, t_out = 000000:040458 1450287609:454387 conn_loop(): select() returns 1 1450287609:454924 tty: read 3 bytes 1450287609:455435 tty: read 8 bytes of 25, offset 0 1450287609:455974 conn_loop(): select(): max_sd = 4, t_out = 000000:039401 1450287609:456408 conn_loop(): select() returns 1 1450287609:457106 tty: read 3 bytes 1450287609:457548 tty: read 11 bytes of 25, offset 0 1450287609:458208 conn_loop(): select(): max_sd = 4, t_out = 000000:038307 1450287609:458662 conn_loop(): select() returns 1 1450287609:459564 tty: read 2 bytes 1450287609:459987 tty: read 13 bytes of 25, offset 0 1450287609:460388 conn_loop(): select(): max_sd = 4, t_out = 000000:036963 1450287609:461620 conn_loop(): select() returns 1 1450287609:462838 tty: read 3 bytes 1450287609:463543 tty: read 16 bytes of 25, offset 0 1450287609:464640 conn_loop(): select(): max_sd = 4, t_out = 000000:034534 1450287609:465650 conn_loop(): select() returns 1 1450287609:466999 tty: read 4 bytes 1450287609:467598 tty: read 20 bytes of 25, offset 0 1450287609:468235 conn_loop(): select(): max_sd = 4, t_out = 000000:032193 1450287609:468811 conn_loop(): select() returns 1 1450287609:469527 tty: read 3 bytes 1450287609:469992 tty: read 23 bytes of 25, offset 0 1450287609:470480 conn_loop(): select(): max_sd = 4, t_out = 000000:030920 1450287609:471170 conn_loop(): select() returns 1 1450287609:471613 tty: read 1 bytes 1450287609:473112 tty: read 24 bytes of 25, offset 0 1450287609:473648 conn_loop(): select(): max_sd = 4, t_out = 000000:029773 1450287609:474355 conn_loop(): select() returns 1 1450287609:474936 tty: read 1 bytes 1450287609:475397 tty: read 25 bytes of 25, offset 0 1450287609:475876 tty: state now is TTY_PROC 1450287609:476292 tty: response read (total 25 bytes, offset 0 bytes) 1450287609:476675 tty: response is correct 1450287609:477189 conn[192.168.0.104]: state now is CONN_RESP 1450287609:477562 tty: state now is TTY_PAUSE 1450287609:477959 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287609:478491 conn_loop(): select() returns 1 1450287609:479289 conn[192.168.0.104]: state now is CONN_HEADER 1450287609:480533 conn_loop(): select(): max_sd = 5, t_out = 000000:098918 1450287609:580399 conn_loop(): select() returns 0 1450287609:581245 tty: state now is TTY_READY 1450287609:581777 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287609:896867 conn_loop(): select() returns 1 1450287609:897739 conn[192.168.0.104]: state now is CONN_RQST 1450287609:898324 conn[192.168.0.104]: state now is CONN_TTY 1450287609:898944 tty: state now is TTY_RQST 1450287609:901462 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287609:901935 conn_loop(): select() returns 1 1450287609:914548 tty: written 8 bytes 1450287609:915121 tty: request written (total 8 bytes) 1450287609:915564 tty: state now is TTY_RESP 1450287609:916018 tty: estimated 25 bytes, waiting 84374 usec 1450287609:916548 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287609:948633 conn_loop(): select() returns 1 1450287609:948981 tty: read 1 bytes 1450287609:949123 tty: read 1 bytes of 25, offset 0 1450287609:949287 conn_loop(): select(): max_sd = 4, t_out = 000000:051965 1450287609:950076 conn_loop(): select() returns 1 1450287609:950323 tty: read 1 bytes 1450287609:950459 tty: read 2 bytes of 25, offset 0 1450287609:950588 conn_loop(): select(): max_sd = 4, t_out = 000000:050941 1450287609:951255 conn_loop(): select() returns 1 1450287609:951452 tty: read 1 bytes 1450287609:951579 tty: rx offset is 0 1450287609:951703 tty: read 3 bytes of 25, offset 0 1450287609:951859 conn_loop(): select(): max_sd = 4, t_out = 000000:050088 1450287609:952731 conn_loop(): select() returns 1 1450287609:953352 tty: read 2 bytes 1450287609:954272 tty: read 5 bytes of 25, offset 0 1450287609:954932 conn_loop(): select(): max_sd = 4, t_out = 000000:048611 1450287609:955595 conn_loop(): select() returns 1 1450287609:956217 tty: read 2 bytes 1450287609:956742 tty: read 7 bytes of 25, offset 0 1450287609:957092 conn_loop(): select(): max_sd = 4, t_out = 000000:047339 1450287609:957439 conn_loop(): select() returns 1 1450287609:957738 tty: read 2 bytes 1450287609:958395 tty: read 9 bytes of 25, offset 0 1450287609:959090 conn_loop(): select(): max_sd = 4, t_out = 000000:046703 1450287609:959609 conn_loop(): select() returns 1 1450287609:959944 tty: read 2 bytes 1450287609:960559 tty: read 11 bytes of 25, offset 0 1450287609:961001 conn_loop(): select(): max_sd = 4, t_out = 000000:045862 1450287609:961606 conn_loop(): select() returns 1 1450287609:961957 tty: read 2 bytes 1450287609:962635 tty: read 13 bytes of 25, offset 0 1450287609:963108 conn_loop(): select(): max_sd = 4, t_out = 000000:044917 1450287609:964123 conn_loop(): select() returns 1 1450287609:964707 tty: read 2 bytes 1450287609:965338 tty: read 15 bytes of 25, offset 0 1450287609:965735 conn_loop(): select(): max_sd = 4, t_out = 000000:043330 1450287609:966628 conn_loop(): select() returns 1 1450287609:967051 tty: read 3 bytes 1450287609:967575 tty: read 18 bytes of 25, offset 0 1450287609:968206 conn_loop(): select(): max_sd = 4, t_out = 000000:042024 1450287609:968627 conn_loop(): select() returns 1 1450287609:969386 tty: read 3 bytes 1450287609:969823 tty: read 21 bytes of 25, offset 0 1450287609:970242 conn_loop(): select(): max_sd = 4, t_out = 000000:040856 1450287609:970935 conn_loop(): select() returns 1 1450287609:971345 tty: read 1 bytes 1450287609:971866 tty: read 22 bytes of 25, offset 0 1450287609:972444 conn_loop(): select(): max_sd = 4, t_out = 000000:039762 1450287609:972961 conn_loop(): select() returns 1 1450287609:973623 tty: read 3 bytes 1450287609:974086 tty: read 25 bytes of 25, offset 0 1450287609:974560 tty: state now is TTY_PROC 1450287609:975100 tty: response read (total 25 bytes, offset 0 bytes) 1450287609:975518 tty: response is correct 1450287609:976048 conn[192.168.0.104]: state now is CONN_RESP 1450287609:976455 tty: state now is TTY_PAUSE 1450287609:976961 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287609:977423 conn_loop(): select() returns 1 1450287609:978019 conn[192.168.0.104]: state now is CONN_HEADER 1450287609:978569 conn_loop(): select(): max_sd = 5, t_out = 000000:099045 1450287610:078235 conn_loop(): select() returns 0 1450287610:079085 tty: state now is TTY_READY 1450287610:079656 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287610:402729 conn_loop(): select() returns 1 1450287610:403526 conn[192.168.0.104]: state now is CONN_RQST 1450287610:404028 conn[192.168.0.104]: state now is CONN_TTY 1450287610:404619 tty: state now is TTY_RQST 1450287610:407157 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287610:407914 conn_loop(): select() returns 1 1450287610:420642 tty: written 8 bytes 1450287610:421334 tty: request written (total 8 bytes) 1450287610:421798 tty: state now is TTY_RESP 1450287610:422742 tty: estimated 25 bytes, waiting 84374 usec 1450287610:423116 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287610:461113 conn_loop(): select() returns 1 1450287610:461640 tty: read 2 bytes 1450287610:462100 tty: read 2 bytes of 25, offset 0 1450287610:462800 conn_loop(): select(): max_sd = 4, t_out = 000000:045864 1450287610:463315 conn_loop(): select() returns 1 1450287610:464033 tty: read 2 bytes 1450287610:465077 tty: rx offset is 0 1450287610:465586 tty: read 4 bytes of 25, offset 0 1450287610:465921 conn_loop(): select(): max_sd = 4, t_out = 000000:044644 1450287610:466265 conn_loop(): select() returns 1 1450287610:466700 tty: read 3 bytes 1450287610:467039 tty: read 7 bytes of 25, offset 0 1450287610:467350 conn_loop(): select(): max_sd = 4, t_out = 000000:043875 1450287610:467961 conn_loop(): select() returns 1 1450287610:468668 tty: read 1 bytes 1450287610:469029 tty: read 8 bytes of 25, offset 0 1450287610:470256 conn_loop(): select(): max_sd = 4, t_out = 000000:042569 1450287610:470710 conn_loop(): select() returns 1 1450287610:471354 tty: read 3 bytes 1450287610:471730 tty: read 11 bytes of 25, offset 0 1450287610:472350 conn_loop(): select(): max_sd = 4, t_out = 000000:041482 1450287610:472987 conn_loop(): select() returns 1 1450287610:473572 tty: read 3 bytes 1450287610:474147 tty: read 14 bytes of 25, offset 0 1450287610:474769 conn_loop(): select(): max_sd = 4, t_out = 000000:040272 1450287610:475666 conn_loop(): select() returns 1 1450287610:476437 tty: read 2 bytes 1450287610:477160 tty: read 16 bytes of 25, offset 0 1450287610:477910 conn_loop(): select(): max_sd = 4, t_out = 000000:038620 1450287610:478654 conn_loop(): select() returns 1 1450287610:479497 tty: read 3 bytes 1450287610:480339 tty: read 19 bytes of 25, offset 0 1450287610:481079 conn_loop(): select(): max_sd = 4, t_out = 000000:037050 1450287610:482269 conn_loop(): select() returns 1 1450287610:483162 tty: read 3 bytes 1450287610:484427 tty: read 22 bytes of 25, offset 0 1450287610:485350 conn_loop(): select(): max_sd = 4, t_out = 000000:034987 1450287610:486122 conn_loop(): select() returns 1 1450287610:486721 tty: read 3 bytes 1450287610:487152 tty: read 25 bytes of 25, offset 0 1450287610:487529 tty: state now is TTY_PROC 1450287610:487825 tty: response read (total 25 bytes, offset 0 bytes) 1450287610:488155 tty: response is correct 1450287610:488510 conn[192.168.0.104]: state now is CONN_RESP 1450287610:488827 tty: state now is TTY_PAUSE 1450287610:489431 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287610:489952 conn_loop(): select() returns 1 1450287610:490568 conn[192.168.0.104]: state now is CONN_HEADER 1450287610:491043 conn_loop(): select(): max_sd = 5, t_out = 000000:098966 1450287610:590713 conn_loop(): select() returns 0 1450287610:591588 tty: state now is TTY_READY 1450287610:592124 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287610:906627 conn_loop(): select() returns 1 1450287610:907655 conn[192.168.0.104]: state now is CONN_RQST 1450287610:908181 conn[192.168.0.104]: state now is CONN_TTY 1450287610:908816 tty: state now is TTY_RQST 1450287610:911348 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287610:911783 conn_loop(): select() returns 1 1450287610:924438 tty: written 8 bytes 1450287610:925019 tty: request written (total 8 bytes) 1450287610:925464 tty: state now is TTY_RESP 1450287610:925855 tty: estimated 25 bytes, waiting 84374 usec 1450287610:926680 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287610:961399 conn_loop(): select() returns 1 1450287610:962247 tty: read 1 bytes 1450287610:963232 tty: read 1 bytes of 25, offset 0 1450287610:964549 conn_loop(): select(): max_sd = 4, t_out = 000000:048829 1450287610:965541 conn_loop(): select() returns 1 1450287610:966131 tty: read 4 bytes 1450287610:966979 tty: rx offset is 0 1450287610:967446 tty: read 5 bytes of 25, offset 0 1450287610:968024 conn_loop(): select(): max_sd = 4, t_out = 000000:047263 1450287610:968623 conn_loop(): select() returns 1 1450287610:969176 tty: read 3 bytes 1450287610:969714 tty: read 8 bytes of 25, offset 0 1450287610:970218 conn_loop(): select(): max_sd = 4, t_out = 000000:046124 1450287610:970647 conn_loop(): select() returns 1 1450287610:971181 tty: read 2 bytes 1450287610:971745 tty: read 10 bytes of 25, offset 0 1450287610:972462 conn_loop(): select(): max_sd = 4, t_out = 000000:045172 1450287610:973040 conn_loop(): select() returns 1 1450287610:973638 tty: read 2 bytes 1450287610:974158 tty: read 12 bytes of 25, offset 0 1450287610:974571 conn_loop(): select(): max_sd = 4, t_out = 000000:044008 1450287610:975360 conn_loop(): select() returns 1 1450287610:976102 tty: read 2 bytes 1450287610:977331 tty: read 14 bytes of 25, offset 0 1450287610:978028 conn_loop(): select(): max_sd = 4, t_out = 000000:042496 1450287610:978495 conn_loop(): select() returns 1 1450287610:979402 tty: read 4 bytes 1450287610:980139 tty: read 18 bytes of 25, offset 0 1450287610:980853 conn_loop(): select(): max_sd = 4, t_out = 000000:041142 1450287610:981475 conn_loop(): select() returns 1 1450287610:981939 tty: read 2 bytes 1450287610:982676 tty: read 20 bytes of 25, offset 0 1450287610:983179 conn_loop(): select(): max_sd = 4, t_out = 000000:040098 1450287610:983845 conn_loop(): select() returns 1 1450287610:984311 tty: read 2 bytes 1450287610:984957 tty: read 22 bytes of 25, offset 0 1450287610:985370 conn_loop(): select(): max_sd = 4, t_out = 000000:038999 1450287610:985884 conn_loop(): select() returns 1 1450287610:986411 tty: read 3 bytes 1450287610:986892 tty: read 25 bytes of 25, offset 0 1450287610:987368 tty: state now is TTY_PROC 1450287610:988220 tty: response read (total 25 bytes, offset 0 bytes) 1450287610:988782 tty: response is correct 1450287610:989219 conn[192.168.0.104]: state now is CONN_RESP 1450287610:989620 tty: state now is TTY_PAUSE 1450287610:990168 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287610:990708 conn_loop(): select() returns 1 1450287610:991250 conn[192.168.0.104]: state now is CONN_HEADER 1450287610:992011 conn_loop(): select(): max_sd = 5, t_out = 000000:099040 1450287611:091659 conn_loop(): select() returns 0 1450287611:092595 tty: state now is TTY_READY 1450287611:093282 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287611:416813 conn_loop(): select() returns 1 1450287611:417583 conn[192.168.0.104]: state now is CONN_RQST 1450287611:418120 conn[192.168.0.104]: state now is CONN_TTY 1450287611:418556 tty: state now is TTY_RQST 1450287611:421598 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287611:422079 conn_loop(): select() returns 1 1450287611:434886 tty: written 8 bytes 1450287611:435457 tty: request written (total 8 bytes) 1450287611:435885 tty: state now is TTY_RESP 1450287611:436486 tty: estimated 25 bytes, waiting 84374 usec 1450287611:436899 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287611:472747 conn_loop(): select() returns 1 1450287611:473255 tty: read 1 bytes 1450287611:473689 tty: read 1 bytes of 25, offset 0 1450287611:474225 conn_loop(): select(): max_sd = 4, t_out = 000000:048030 1450287611:474791 conn_loop(): select() returns 1 1450287611:475253 tty: read 1 bytes 1450287611:475890 tty: read 2 bytes of 25, offset 0 1450287611:476465 conn_loop(): select(): max_sd = 4, t_out = 000000:047013 1450287611:477057 conn_loop(): select() returns 1 1450287611:477571 tty: read 3 bytes 1450287611:477956 tty: rx offset is 0 1450287611:478572 tty: read 5 bytes of 25, offset 0 1450287611:478964 conn_loop(): select(): max_sd = 4, t_out = 000000:045919 1450287611:479536 conn_loop(): select() returns 1 1450287611:480073 tty: read 3 bytes 1450287611:480468 tty: read 8 bytes of 25, offset 0 1450287611:481011 conn_loop(): select(): max_sd = 4, t_out = 000000:044819 1450287611:481688 conn_loop(): select() returns 1 1450287611:482129 tty: read 1 bytes 1450287611:482881 tty: read 9 bytes of 25, offset 0 1450287611:483384 conn_loop(): select(): max_sd = 4, t_out = 000000:043712 1450287611:483842 conn_loop(): select() returns 1 1450287611:484502 tty: read 3 bytes 1450287611:484880 tty: read 12 bytes of 25, offset 0 1450287611:485505 conn_loop(): select(): max_sd = 4, t_out = 000000:042606 1450287611:486039 conn_loop(): select() returns 1 1450287611:486515 tty: read 1 bytes 1450287611:487156 tty: read 13 bytes of 25, offset 0 1450287611:488097 conn_loop(): select(): max_sd = 4, t_out = 000000:041608 1450287611:488572 conn_loop(): select() returns 1 1450287611:488900 tty: read 3 bytes 1450287611:489254 tty: read 16 bytes of 25, offset 0 1450287611:489656 conn_loop(): select(): max_sd = 4, t_out = 000000:040816 1450287611:490188 conn_loop(): select() returns 1 1450287611:490537 tty: read 1 bytes 1450287611:491233 tty: read 17 bytes of 25, offset 0 1450287611:491573 conn_loop(): select(): max_sd = 4, t_out = 000000:039945 1450287611:492448 conn_loop(): select() returns 1 1450287611:493072 tty: read 3 bytes 1450287611:493517 tty: read 20 bytes of 25, offset 0 1450287611:494113 conn_loop(): select(): max_sd = 4, t_out = 000000:038458 1450287611:494650 conn_loop(): select() returns 1 1450287611:495192 tty: read 2 bytes 1450287611:495695 tty: read 22 bytes of 25, offset 0 1450287611:496111 conn_loop(): select(): max_sd = 4, t_out = 000000:037388 1450287611:496704 conn_loop(): select() returns 1 1450287611:497167 tty: read 2 bytes 1450287611:497827 tty: read 24 bytes of 25, offset 0 1450287611:498271 conn_loop(): select(): max_sd = 4, t_out = 000000:036344 1450287611:498806 conn_loop(): select() returns 1 1450287611:499516 tty: read 1 bytes 1450287611:499947 tty: read 25 bytes of 25, offset 0 1450287611:500727 tty: state now is TTY_PROC 1450287611:501146 tty: response read (total 25 bytes, offset 0 bytes) 1450287611:501735 tty: response is correct 1450287611:502194 conn[192.168.0.104]: state now is CONN_RESP 1450287611:502900 tty: state now is TTY_PAUSE 1450287611:503371 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287611:503924 conn_loop(): select() returns 1 1450287611:504497 conn[192.168.0.104]: state now is CONN_HEADER 1450287611:505014 conn_loop(): select(): max_sd = 5, t_out = 000000:098976 1450287611:604654 conn_loop(): select() returns 0 1450287611:605528 tty: state now is TTY_READY 1450287611:606058 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287611:918696 conn_loop(): select() returns 1 1450287611:919666 conn[192.168.0.104]: state now is CONN_RQST 1450287611:920209 conn[192.168.0.104]: state now is CONN_TTY 1450287611:920673 tty: state now is TTY_RQST 1450287611:923073 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287611:923631 conn_loop(): select() returns 1 1450287611:936107 tty: written 8 bytes 1450287611:936650 tty: request written (total 8 bytes) 1450287611:937151 tty: state now is TTY_RESP 1450287611:937742 tty: estimated 25 bytes, waiting 84374 usec 1450287611:938466 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287611:976788 conn_loop(): select() returns 1 1450287611:977317 tty: read 1 bytes 1450287611:977756 tty: read 1 bytes of 25, offset 0 1450287611:978294 conn_loop(): select(): max_sd = 4, t_out = 000000:045537 1450287611:978676 conn_loop(): select() returns 1 1450287611:979007 tty: read 1 bytes 1450287611:979713 tty: read 2 bytes of 25, offset 0 1450287611:980114 conn_loop(): select(): max_sd = 4, t_out = 000000:044834 1450287611:980558 conn_loop(): select() returns 1 1450287611:981222 tty: read 3 bytes 1450287611:981656 tty: rx offset is 0 1450287611:982075 tty: read 5 bytes of 25, offset 0 1450287611:982715 conn_loop(): select(): max_sd = 4, t_out = 000000:043741 1450287611:983201 conn_loop(): select() returns 1 1450287611:983840 tty: read 1 bytes 1450287611:984313 tty: read 6 bytes of 25, offset 0 1450287611:984771 conn_loop(): select(): max_sd = 4, t_out = 000000:042795 1450287611:985521 conn_loop(): select() returns 1 1450287611:985970 tty: read 3 bytes 1450287611:986996 tty: read 9 bytes of 25, offset 0 1450287611:987638 conn_loop(): select(): max_sd = 4, t_out = 000000:041612 1450287611:988722 conn_loop(): select() returns 1 1450287611:989737 tty: read 4 bytes 1450287611:990526 tty: read 13 bytes of 25, offset 0 1450287611:991279 conn_loop(): select(): max_sd = 4, t_out = 000000:039534 1450287611:992211 conn_loop(): select() returns 1 1450287611:992858 tty: read 3 bytes 1450287611:993633 tty: read 16 bytes of 25, offset 0 1450287611:994081 conn_loop(): select(): max_sd = 4, t_out = 000000:037972 1450287611:994702 conn_loop(): select() returns 1 1450287611:995264 tty: read 2 bytes 1450287611:995794 tty: read 18 bytes of 25, offset 0 1450287611:996336 conn_loop(): select(): max_sd = 4, t_out = 000000:036800 1450287611:996866 conn_loop(): select() returns 1 1450287611:997311 tty: read 2 bytes 1450287611:997998 tty: read 20 bytes of 25, offset 0 1450287611:998709 conn_loop(): select(): max_sd = 4, t_out = 000000:035854 1450287611:999361 conn_loop(): select() returns 1 1450287611:999779 tty: read 2 bytes 1450287612:000375 tty: read 22 bytes of 25, offset 0 1450287612:001169 conn_loop(): select(): max_sd = 4, t_out = 000000:034794 1450287612:001722 conn_loop(): select() returns 1 1450287612:002936 tty: read 3 bytes 1450287612:003179 tty: read 25 bytes of 25, offset 0 1450287612:003365 tty: state now is TTY_PROC 1450287612:003531 tty: response read (total 25 bytes, offset 0 bytes) 1450287612:003692 tty: response is correct 1450287612:003849 conn[192.168.0.104]: state now is CONN_RESP 1450287612:003984 tty: state now is TTY_PAUSE 1450287612:004119 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287612:004315 conn_loop(): select() returns 1 1450287612:004629 conn[192.168.0.104]: state now is CONN_HEADER 1450287612:004817 conn_loop(): select(): max_sd = 5, t_out = 000000:099640 1450287612:104784 conn_loop(): select() returns 0 1450287612:105145 tty: state now is TTY_READY 1450287612:105311 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287612:430741 conn_loop(): select() returns 1 1450287612:431152 conn[192.168.0.104]: state now is CONN_RQST 1450287612:431321 conn[192.168.0.104]: state now is CONN_TTY 1450287612:431463 tty: state now is TTY_RQST 1450287612:433681 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287612:433862 conn_loop(): select() returns 1 1450287612:446125 tty: written 8 bytes 1450287612:446615 tty: request written (total 8 bytes) 1450287612:447017 tty: state now is TTY_RESP 1450287612:447330 tty: estimated 25 bytes, waiting 84374 usec 1450287612:447648 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287612:488389 conn_loop(): select() returns 1 1450287612:488649 tty: read 1 bytes 1450287612:488786 tty: read 1 bytes of 25, offset 0 1450287612:488917 conn_loop(): select(): max_sd = 4, t_out = 000000:043389 1450287612:489712 conn_loop(): select() returns 1 1450287612:489924 tty: read 2 bytes 1450287612:490054 tty: rx offset is 0 1450287612:490203 tty: read 3 bytes of 25, offset 0 1450287612:490329 conn_loop(): select(): max_sd = 4, t_out = 000000:042393 1450287612:491081 conn_loop(): select() returns 1 1450287612:491322 tty: read 1 bytes 1450287612:491450 tty: read 4 bytes of 25, offset 0 1450287612:491738 conn_loop(): select(): max_sd = 4, t_out = 000000:041413 1450287612:492550 conn_loop(): select() returns 1 1450287612:492746 tty: read 1 bytes 1450287612:492902 tty: read 5 bytes of 25, offset 0 1450287612:493043 conn_loop(): select(): max_sd = 4, t_out = 000000:040417 1450287612:493837 conn_loop(): select() returns 1 1450287612:494076 tty: read 2 bytes 1450287612:494615 tty: read 7 bytes of 25, offset 0 1450287612:494809 conn_loop(): select(): max_sd = 4, t_out = 000000:039394 1450287612:495445 conn_loop(): select() returns 1 1450287612:495732 tty: read 1 bytes 1450287612:495914 tty: read 8 bytes of 25, offset 0 1450287612:496314 conn_loop(): select(): max_sd = 4, t_out = 000000:038522 1450287612:496723 conn_loop(): select() returns 1 1450287612:497089 tty: read 1 bytes 1450287612:497293 tty: read 9 bytes of 25, offset 0 1450287612:497576 conn_loop(): select(): max_sd = 4, t_out = 000000:037758 1450287612:498058 conn_loop(): select() returns 1 1450287612:498298 tty: read 2 bytes 1450287612:498738 tty: read 11 bytes of 25, offset 0 1450287612:498930 conn_loop(): select(): max_sd = 4, t_out = 000000:037048 1450287612:499544 conn_loop(): select() returns 1 1450287612:499739 tty: read 1 bytes 1450287612:499962 tty: read 12 bytes of 25, offset 0 1450287612:500507 conn_loop(): select(): max_sd = 4, t_out = 000000:036250 1450287612:501258 conn_loop(): select() returns 1 1450287612:502148 tty: read 3 bytes 1450287612:502663 tty: read 15 bytes of 25, offset 0 1450287612:503271 conn_loop(): select(): max_sd = 4, t_out = 000000:034660 1450287612:503878 conn_loop(): select() returns 1 1450287612:504440 tty: read 1 bytes 1450287612:505221 tty: read 16 bytes of 25, offset 0 1450287612:505806 conn_loop(): select(): max_sd = 4, t_out = 000000:033503 1450287612:506772 conn_loop(): select() returns 1 1450287612:507321 tty: read 3 bytes 1450287612:508049 tty: read 19 bytes of 25, offset 0 1450287612:508612 conn_loop(): select(): max_sd = 4, t_out = 000000:031999 1450287612:509342 conn_loop(): select() returns 1 1450287612:509787 tty: read 2 bytes 1450287612:510200 tty: read 21 bytes of 25, offset 0 1450287612:511033 conn_loop(): select(): max_sd = 4, t_out = 000000:030836 1450287612:511415 conn_loop(): select() returns 1 1450287612:511910 tty: read 3 bytes 1450287612:512227 tty: read 24 bytes of 25, offset 0 1450287612:512594 conn_loop(): select(): max_sd = 4, t_out = 000000:029971 1450287612:513456 conn_loop(): select() returns 1 1450287612:513931 tty: read 1 bytes 1450287612:514557 tty: read 25 bytes of 25, offset 0 1450287612:514968 tty: state now is TTY_PROC 1450287612:515538 tty: response read (total 25 bytes, offset 0 bytes) 1450287612:516074 tty: response is correct 1450287612:516742 conn[192.168.0.104]: state now is CONN_RESP 1450287612:517292 tty: state now is TTY_PAUSE 1450287612:517687 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287612:518260 conn_loop(): select() returns 1 1450287612:518839 conn[192.168.0.104]: state now is CONN_HEADER 1450287612:519310 conn_loop(): select(): max_sd = 5, t_out = 000000:099027 1450287612:619326 conn_loop(): select() returns 0 1450287612:620167 tty: state now is TTY_READY 1450287612:620712 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287612:929969 conn_loop(): select() returns 1 1450287612:930970 conn[192.168.0.104]: state now is CONN_RQST 1450287612:931521 conn[192.168.0.104]: state now is CONN_TTY 1450287612:932002 tty: state now is TTY_RQST 1450287612:934793 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287612:935282 conn_loop(): select() returns 1 1450287612:947840 tty: written 8 bytes 1450287612:948422 tty: request written (total 8 bytes) 1450287612:948879 tty: state now is TTY_RESP 1450287612:949308 tty: estimated 25 bytes, waiting 84374 usec 1450287612:949678 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287612:979667 conn_loop(): select() returns 1 1450287612:980215 tty: read 1 bytes 1450287612:980658 tty: read 1 bytes of 25, offset 0 1450287612:981219 conn_loop(): select(): max_sd = 4, t_out = 000000:053850 1450287612:981576 conn_loop(): select() returns 1 1450287612:981878 tty: read 1 bytes 1450287612:982205 tty: read 2 bytes of 25, offset 0 1450287612:982711 conn_loop(): select(): max_sd = 4, t_out = 000000:053200 1450287612:983072 conn_loop(): select() returns 1 1450287612:983442 tty: read 1 bytes 1450287612:983882 tty: rx offset is 0 1450287612:984435 tty: read 3 bytes of 25, offset 0 1450287612:984879 conn_loop(): select(): max_sd = 4, t_out = 000000:052479 1450287612:985484 conn_loop(): select() returns 1 1450287612:985809 tty: read 3 bytes 1450287612:986095 tty: read 6 bytes of 25, offset 0 1450287612:986514 conn_loop(): select(): max_sd = 4, t_out = 000000:051559 1450287612:986851 conn_loop(): select() returns 1 1450287612:987144 tty: read 1 bytes 1450287612:987477 tty: read 7 bytes of 25, offset 0 1450287612:987894 conn_loop(): select(): max_sd = 4, t_out = 000000:050938 1450287612:988435 conn_loop(): select() returns 1 1450287612:988773 tty: read 2 bytes 1450287612:989103 tty: read 9 bytes of 25, offset 0 1450287612:989509 conn_loop(): select(): max_sd = 4, t_out = 000000:050069 1450287612:989986 conn_loop(): select() returns 1 1450287612:990322 tty: read 1 bytes 1450287612:990739 tty: read 10 bytes of 25, offset 0 1450287612:991341 conn_loop(): select(): max_sd = 4, t_out = 000000:049266 1450287612:991712 conn_loop(): select() returns 1 1450287612:992262 tty: read 3 bytes 1450287612:992715 tty: read 13 bytes of 25, offset 0 1450287612:993042 conn_loop(): select(): max_sd = 4, t_out = 000000:048356 1450287612:993581 conn_loop(): select() returns 1 1450287612:993905 tty: read 1 bytes 1450287612:994229 tty: read 14 bytes of 25, offset 0 1450287612:994523 conn_loop(): select(): max_sd = 4, t_out = 000000:047503 1450287612:994990 conn_loop(): select() returns 1 1450287612:995349 tty: read 1 bytes 1450287612:995659 tty: read 15 bytes of 25, offset 0 1450287612:995968 conn_loop(): select(): max_sd = 4, t_out = 000000:046687 1450287612:996409 conn_loop(): select() returns 1 1450287612:996738 tty: read 2 bytes 1450287612:997019 tty: read 17 bytes of 25, offset 0 1450287612:997347 conn_loop(): select(): max_sd = 4, t_out = 000000:045926 1450287612:997774 conn_loop(): select() returns 1 1450287612:998068 tty: read 1 bytes 1450287612:998381 tty: read 18 bytes of 25, offset 0 1450287612:998748 conn_loop(): select(): max_sd = 4, t_out = 000000:045215 1450287612:999226 conn_loop(): select() returns 1 1450287613:000020 tty: read 1 bytes 1450287613:000470 tty: read 19 bytes of 25, offset 0 1450287613:000795 conn_loop(): select(): max_sd = 4, t_out = 000000:043953 1450287613:001401 conn_loop(): select() returns 1 1450287613:001890 tty: read 3 bytes 1450287613:002536 tty: read 22 bytes of 25, offset 0 1450287613:002911 conn_loop(): select(): max_sd = 4, t_out = 000000:042868 1450287613:003703 conn_loop(): select() returns 1 1450287613:004320 tty: read 1 bytes 1450287613:004953 tty: read 23 bytes of 25, offset 0 1450287613:005392 conn_loop(): select(): max_sd = 4, t_out = 000000:041490 1450287613:006201 conn_loop(): select() returns 1 1450287613:006837 tty: read 2 bytes 1450287613:007620 tty: read 25 bytes of 25, offset 0 1450287613:008156 tty: state now is TTY_PROC 1450287613:008901 tty: response read (total 25 bytes, offset 0 bytes) 1450287613:009517 tty: response is correct 1450287613:010352 conn[192.168.0.104]: state now is CONN_RESP 1450287613:011099 tty: state now is TTY_PAUSE 1450287613:012011 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287613:012890 conn_loop(): select() returns 1 1450287613:013933 conn[192.168.0.104]: state now is CONN_HEADER 1450287613:014740 conn_loop(): select(): max_sd = 5, t_out = 000000:098229 1450287613:113898 conn_loop(): select() returns 0 1450287613:114738 tty: state now is TTY_READY 1450287613:115419 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287613:444816 conn_loop(): select() returns 1 1450287613:445619 conn[192.168.0.104]: state now is CONN_RQST 1450287613:446145 conn[192.168.0.104]: state now is CONN_TTY 1450287613:446729 tty: state now is TTY_RQST 1450287613:449254 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287613:449801 conn_loop(): select() returns 1 1450287613:462371 tty: written 8 bytes 1450287613:462937 tty: request written (total 8 bytes) 1450287613:463428 tty: state now is TTY_RESP 1450287613:463896 tty: estimated 25 bytes, waiting 84374 usec 1450287613:464217 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287613:497363 conn_loop(): select() returns 1 1450287613:497934 tty: read 1 bytes 1450287613:498402 tty: read 1 bytes of 25, offset 0 1450287613:498852 conn_loop(): select(): max_sd = 4, t_out = 000000:050671 1450287613:499180 conn_loop(): select() returns 1 1450287613:499550 tty: read 1 bytes 1450287613:499941 tty: read 2 bytes of 25, offset 0 1450287613:500682 conn_loop(): select(): max_sd = 4, t_out = 000000:049985 1450287613:501019 conn_loop(): select() returns 1 1450287613:501867 tty: read 3 bytes 1450287613:502442 tty: rx offset is 0 1450287613:503056 tty: read 5 bytes of 25, offset 0 1450287613:503599 conn_loop(): select(): max_sd = 4, t_out = 000000:048812 1450287613:504081 conn_loop(): select() returns 1 1450287613:505296 tty: read 3 bytes 1450287613:505802 tty: read 8 bytes of 25, offset 0 1450287613:506142 conn_loop(): select(): max_sd = 4, t_out = 000000:047130 1450287613:506512 conn_loop(): select() returns 1 1450287613:507215 tty: read 2 bytes 1450287613:507700 tty: read 10 bytes of 25, offset 0 1450287613:508012 conn_loop(): select(): max_sd = 4, t_out = 000000:046068 1450287613:508682 conn_loop(): select() returns 1 1450287613:509089 tty: read 2 bytes 1450287613:509411 tty: read 12 bytes of 25, offset 0 1450287613:509833 conn_loop(): select(): max_sd = 4, t_out = 000000:045003 1450287613:510376 conn_loop(): select() returns 1 1450287613:510721 tty: read 1 bytes 1450287613:511360 tty: read 13 bytes of 25, offset 0 1450287613:511823 conn_loop(): select(): max_sd = 4, t_out = 000000:044124 1450287613:512345 conn_loop(): select() returns 1 1450287613:512985 tty: read 3 bytes 1450287613:513537 tty: read 16 bytes of 25, offset 0 1450287613:514079 conn_loop(): select(): max_sd = 4, t_out = 000000:042972 1450287613:514429 conn_loop(): select() returns 1 1450287613:514760 tty: read 1 bytes 1450287613:515061 tty: read 17 bytes of 25, offset 0 1450287613:515565 conn_loop(): select(): max_sd = 4, t_out = 000000:042301 1450287613:516218 conn_loop(): select() returns 1 1450287613:516608 tty: read 1 bytes 1450287613:517082 tty: read 18 bytes of 25, offset 0 1450287613:517408 conn_loop(): select(): max_sd = 4, t_out = 000000:041268 1450287613:517740 conn_loop(): select() returns 1 1450287613:518072 tty: read 2 bytes 1450287613:518737 tty: read 20 bytes of 25, offset 0 1450287613:519040 conn_loop(): select(): max_sd = 4, t_out = 000000:040613 1450287613:519693 conn_loop(): select() returns 1 1450287613:520083 tty: read 2 bytes 1450287613:520602 tty: read 22 bytes of 25, offset 0 1450287613:521152 conn_loop(): select(): max_sd = 4, t_out = 000000:039579 1450287613:521511 conn_loop(): select() returns 1 1450287613:521842 tty: read 2 bytes 1450287613:522171 tty: read 24 bytes of 25, offset 0 1450287613:522643 conn_loop(): select(): max_sd = 4, t_out = 000000:038898 1450287613:523301 conn_loop(): select() returns 1 1450287613:523695 tty: read 1 bytes 1450287613:524286 tty: read 25 bytes of 25, offset 0 1450287613:524589 tty: state now is TTY_PROC 1450287613:525379 tty: response read (total 25 bytes, offset 0 bytes) 1450287613:525935 tty: response is correct 1450287613:526427 conn[192.168.0.104]: state now is CONN_RESP 1450287613:526984 tty: state now is TTY_PAUSE 1450287613:527440 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287613:527979 conn_loop(): select() returns 1 1450287613:528515 conn[192.168.0.104]: state now is CONN_HEADER 1450287613:529043 conn_loop(): select(): max_sd = 5, t_out = 000000:099041 1450287613:628710 conn_loop(): select() returns 0 1450287613:629531 tty: state now is TTY_READY 1450287613:630286 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287613:949963 conn_loop(): select() returns 1 1450287613:950950 conn[192.168.0.104]: state now is CONN_RQST 1450287613:951528 conn[192.168.0.104]: state now is CONN_TTY 1450287613:951979 tty: state now is TTY_RQST 1450287613:954432 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287613:954969 conn_loop(): select() returns 1 1450287613:967451 tty: written 8 bytes 1450287613:967965 tty: request written (total 8 bytes) 1450287613:968415 tty: state now is TTY_RESP 1450287613:968991 tty: estimated 25 bytes, waiting 84374 usec 1450287613:969422 conn_loop(): select(): max_sd = 4, t_out = 000000:084374 1450287614:011356 conn_loop(): select() returns 1 1450287614:011970 tty: read 2 bytes 1450287614:012654 tty: read 2 bytes of 25, offset 0 1450287614:013032 conn_loop(): select(): max_sd = 4, t_out = 000000:041840 1450287614:013437 conn_loop(): select() returns 1 1450287614:013793 tty: read 1 bytes 1450287614:014223 tty: rx offset is 0 1450287614:014542 tty: read 3 bytes of 25, offset 0 1450287614:014861 conn_loop(): select(): max_sd = 4, t_out = 000000:041091 1450287614:015218 conn_loop(): select() returns 1 1450287614:015642 tty: read 3 bytes 1450287614:015956 tty: read 6 bytes of 25, offset 0 1450287614:016635 conn_loop(): select(): max_sd = 4, t_out = 000000:040319 1450287614:017194 conn_loop(): select() returns 1 1450287614:017768 tty: read 1 bytes 1450287614:018702 tty: read 7 bytes of 25, offset 0 1450287614:019255 conn_loop(): select(): max_sd = 4, t_out = 000000:039197 1450287614:019852 conn_loop(): select() returns 1 1450287614:020250 tty: read 3 bytes 1450287614:020590 tty: read 10 bytes of 25, offset 0 1450287614:021020 conn_loop(): select(): max_sd = 4, t_out = 000000:038210 1450287614:021554 conn_loop(): select() returns 1 1450287614:021984 tty: read 1 bytes 1450287614:022419 tty: read 11 bytes of 25, offset 0 1450287614:023155 conn_loop(): select(): max_sd = 4, t_out = 000000:037257 1450287614:023893 conn_loop(): select() returns 1 1450287614:024462 tty: read 3 bytes 1450287614:024913 tty: read 14 bytes of 25, offset 0 1450287614:025526 conn_loop(): select(): max_sd = 4, t_out = 000000:035963 1450287614:025960 conn_loop(): select() returns 1 1450287614:026611 tty: read 2 bytes 1450287614:027026 tty: read 16 bytes of 25, offset 0 1450287614:027458 conn_loop(): select(): max_sd = 4, t_out = 000000:034992 1450287614:028123 conn_loop(): select() returns 1 1450287614:028535 tty: read 2 bytes 1450287614:028882 tty: read 18 bytes of 25, offset 0 1450287614:029636 conn_loop(): select(): max_sd = 4, t_out = 000000:033925 1450287614:030136 conn_loop(): select() returns 1 1450287614:030531 tty: read 1 bytes 1450287614:031627 tty: read 19 bytes of 25, offset 0 1450287614:032547 conn_loop(): select(): max_sd = 4, t_out = 000000:033043 1450287614:033273 conn_loop(): select() returns 1 1450287614:033919 tty: read 4 bytes 1450287614:034652 tty: read 23 bytes of 25, offset 0 1450287614:035649 conn_loop(): select(): max_sd = 4, t_out = 000000:031686 1450287614:036512 conn_loop(): select() returns 1 1450287614:037354 tty: read 2 bytes 1450287614:038010 tty: read 25 bytes of 25, offset 0 1450287614:038797 tty: state now is TTY_PROC 1450287614:039429 tty: response read (total 25 bytes, offset 0 bytes) 1450287614:040201 tty: response is correct 1450287614:040781 conn[192.168.0.104]: state now is CONN_RESP 1450287614:041669 tty: state now is TTY_PAUSE 1450287614:042560 conn_loop(): select(): max_sd = 5, t_out = 000000:100000 1450287614:043500 conn_loop(): select() returns 1 1450287614:044257 conn[192.168.0.104]: state now is CONN_HEADER 1450287614:045300 conn_loop(): select(): max_sd = 5, t_out = 000000:098448 1450287614:144621 conn_loop(): select() returns 0 1450287614:145693 tty: state now is TTY_READY 1450287614:146405 conn_loop(): select(): max_sd = 5, t_out = 000060:000000 1450287614:441202 conn_loop(): select() returns 1 1450287614:442103 conn[192.168.0.104]: state now is CONN_RQST 1450287614:442857 conn[192.168.0.104]: state now is CONN_TTY 1450287614:443456 tty: state now is TTY_RQST 1450287614:446031 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287614:446602 conn_loop(): select() returns 1 1450287614:459177 tty: written 8 bytes 1450287614:459711 tty: request written (total 8 bytes) 1450287614:460186 tty: state now is TTY_RESP 1450287614:460603 tty: estimated 8 bytes, waiting 66666 usec 1450287614:461184 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287614:501460 conn_loop(): select() returns 1 1450287614:502582 tty: read 1 bytes 1450287614:503672 tty: read 1 bytes of 8, offset 0 1450287614:504438 conn_loop(): select(): max_sd = 4, t_out = 000000:025292 1450287614:505072 conn_loop(): select() returns 1 1450287614:505892 tty: read 4 bytes 1450287614:506471 tty: rx offset is 0 1450287614:507103 tty: rx len changed from 8 to 0 1450287614:507550 tty: read 5 bytes of 0, offset 0 1450287614:508108 conn_loop(): select(): max_sd = 4, t_out = 000000:023850 1450287614:509285 conn_loop(): select() returns 1 1450287614:509837 tty: error in read() (Bad address) 1450287614:510703 closing tty on error... 1450287614:762992 tty closed, re-opening... 1450287614:766214 tty: state now is TTY_PAUSE 1450287614:766836 re-init ok... 1450287614:767490 tty: read -1 bytes 1450287614:767956 tty: read 4 bytes of 0, offset 0 1450287614:768531 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287614:869146 conn_loop(): select() returns 0 1450287614:870036 tty: state now is TTY_RQST 1450287614:872669 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287614:873289 conn_loop(): select() returns 1 1450287614:885875 tty: written 8 bytes 1450287614:886367 tty: request written (total 8 bytes) 1450287614:886857 tty: state now is TTY_RESP 1450287614:887389 tty: estimated 8 bytes, waiting 66666 usec 1450287614:887886 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287614:920933 conn_loop(): select() returns 1 1450287614:921782 tty: read 1 bytes 1450287614:922868 tty: read 1 bytes of 8, offset 0 1450287614:924306 conn_loop(): select(): max_sd = 4, t_out = 000000:032788 1450287614:925247 conn_loop(): select() returns 1 1450287614:925953 tty: read 4 bytes 1450287614:926838 tty: rx offset is 0 1450287614:927383 tty: rx len changed from 8 to 0 1450287614:928731 tty: read 5 bytes of 0, offset 0 1450287614:930003 conn_loop(): select(): max_sd = 4, t_out = 000000:031159 1450287614:930769 conn_loop(): select() returns 1 1450287614:931728 tty: error in read() (Bad address) 1450287614:932360 closing tty on error... 1450287615:193010 tty closed, re-opening... 1450287615:196146 tty: state now is TTY_PAUSE 1450287615:196365 re-init ok... 1450287615:196534 tty: read -1 bytes 1450287615:196685 tty: read 4 bytes of 0, offset 0 1450287615:196862 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287615:297148 conn_loop(): select() returns 0 1450287615:297408 tty: state now is TTY_RQST 1450287615:299666 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287615:299828 conn_loop(): select() returns 1 1450287615:312102 tty: written 8 bytes 1450287615:312312 tty: request written (total 8 bytes) 1450287615:312449 tty: state now is TTY_RESP 1450287615:313514 tty: estimated 8 bytes, waiting 66666 usec 1450287615:314090 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287615:351883 conn_loop(): select() returns 1 1450287615:352395 tty: read 2 bytes 1450287615:353096 tty: read 2 bytes of 8, offset 0 1450287615:353950 conn_loop(): select(): max_sd = 4, t_out = 000000:028375 1450287615:354664 conn_loop(): select() returns 1 1450287615:355185 tty: read 2 bytes 1450287615:355623 tty: rx offset is 0 1450287615:356221 tty: rx len changed from 8 to 0 1450287615:356626 tty: read 4 bytes of 0, offset 0 1450287615:357040 conn_loop(): select(): max_sd = 4, t_out = 000000:027151 1450287615:357674 conn_loop(): select() returns 1 1450287615:358189 tty: error in read() (Bad address) 1450287615:358770 closing tty on error... 1450287615:615123 tty closed, re-opening... 1450287615:618326 tty: state now is TTY_PAUSE 1450287615:618943 re-init ok... 1450287615:619375 tty: read -1 bytes 1450287615:620349 tty: read 3 bytes of 0, offset 0 1450287615:620850 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287615:721564 conn_loop(): select() returns 0 1450287615:722382 tty: state now is TTY_RQST 1450287615:725154 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287615:725695 conn_loop(): select() returns 1 1450287615:738294 tty: written 8 bytes 1450287615:738866 tty: request written (total 8 bytes) 1450287615:739590 tty: state now is TTY_RESP 1450287615:739941 tty: estimated 8 bytes, waiting 66666 usec 1450287615:740286 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287615:781604 conn_loop(): select() returns 1 1450287615:782304 tty: read 1 bytes 1450287615:783003 tty: read 1 bytes of 8, offset 0 1450287615:783611 conn_loop(): select(): max_sd = 4, t_out = 000000:024664 1450287615:784109 conn_loop(): select() returns 1 1450287615:784629 tty: read 3 bytes 1450287615:785241 tty: rx offset is 0 1450287615:785885 tty: rx len changed from 8 to 0 1450287615:786212 tty: read 4 bytes of 0, offset 0 1450287615:786506 conn_loop(): select(): max_sd = 4, t_out = 000000:023657 1450287615:786879 conn_loop(): select() returns 1 1450287615:787415 tty: error in read() (Bad address) 1450287615:787995 closing tty on error... 1450287616:043037 tty closed, re-opening... 1450287616:046384 tty: state now is TTY_PAUSE 1450287616:047020 re-init ok... 1450287616:047460 tty: read -1 bytes 1450287616:047803 tty: read 3 bytes of 0, offset 0 1450287616:048157 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287616:148651 conn_loop(): select() returns 0 1450287616:149493 tty: state now is TTY_RQST 1450287616:152131 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287616:152738 conn_loop(): select() returns 1 1450287616:165414 tty: written 8 bytes 1450287616:166220 tty: request written (total 8 bytes) 1450287616:166670 tty: state now is TTY_RESP 1450287616:167052 tty: estimated 8 bytes, waiting 66666 usec 1450287616:167351 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287616:199638 conn_loop(): select() returns 1 1450287616:200215 tty: read 1 bytes 1450287616:200681 tty: read 1 bytes of 8, offset 0 1450287616:201416 conn_loop(): select(): max_sd = 4, t_out = 000000:033815 1450287616:202023 conn_loop(): select() returns 1 1450287616:202682 tty: read 2 bytes 1450287616:203208 tty: rx offset is 0 1450287616:203826 tty: rx len changed from 8 to 0 1450287616:204349 tty: read 3 bytes of 0, offset 0 1450287616:204756 conn_loop(): select(): max_sd = 4, t_out = 000000:032561 1450287616:205301 conn_loop(): select() returns 1 1450287616:205925 tty: error in read() (Bad address) 1450287616:206432 closing tty on error... 1450287616:462941 tty closed, re-opening... 1450287616:465939 tty: state now is TTY_PAUSE 1450287616:466500 re-init ok... 1450287616:467134 tty: read -1 bytes 1450287616:467570 tty: read 2 bytes of 0, offset 0 1450287616:468159 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287616:568724 conn_loop(): select() returns 0 1450287616:569402 tty: state now is TTY_RQST 1450287616:571971 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287616:572727 conn_loop(): select() returns 1 1450287616:585513 tty: written 8 bytes 1450287616:586047 tty: request written (total 8 bytes) 1450287616:586503 tty: state now is TTY_RESP 1450287616:587082 tty: estimated 8 bytes, waiting 66666 usec 1450287616:587486 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287616:621683 conn_loop(): select() returns 1 1450287616:622195 tty: read 2 bytes 1450287616:622707 tty: read 2 bytes of 8, offset 0 1450287616:623165 conn_loop(): select(): max_sd = 4, t_out = 000000:031970 1450287616:623501 conn_loop(): select() returns 1 1450287616:623839 tty: read 1 bytes 1450287616:624171 tty: rx offset is 0 1450287616:624563 tty: rx len changed from 8 to 0 1450287616:624878 tty: read 3 bytes of 0, offset 0 1450287616:625198 conn_loop(): select(): max_sd = 4, t_out = 000000:031306 1450287616:625640 conn_loop(): select() returns 1 1450287616:626274 tty: error in read() (Bad address) 1450287616:626727 closing tty on error... 1450287616:883000 tty closed, re-opening... 1450287616:886118 tty: state now is TTY_PAUSE 1450287616:886356 re-init ok... 1450287616:886514 tty: read -1 bytes 1450287616:886665 tty: read 2 bytes of 0, offset 0 1450287616:886847 conn_loop(): select(): max_sd = 4, t_out = 000000:100000 1450287616:987136 conn_loop(): select() returns 0 1450287616:987737 tty: state now is TTY_RQST 1450287616:990338 conn_loop(): select(): max_sd = 4, t_out = 000060:000000 1450287616:990876 conn_loop(): select() returns 1 1450287617:003457 tty: written 8 bytes 1450287617:004033 tty: request written (total 8 bytes) 1450287617:004766 tty: state now is TTY_RESP 1450287617:005308 tty: estimated 8 bytes, waiting 66666 usec 1450287617:006479 conn_loop(): select(): max_sd = 4, t_out = 000000:066666 1450287617:037411 conn_loop(): select() returns -1 1450287617:037669 Terminated by signal: SIGINT