직렬-WiFi 어댑터를 통해 연결을 설정하려고 합니다. 저는 Socat을 사용하여 pppd와 PTY의 연결을 연결하는 소켓을 만들고 있습니다. 데이터가 양방향으로 흐르는 것 같지만 pppd가 클라이언트로부터 응답을 받지 못하는 것 같습니다. Socat의 디버그 출력에는 들어오고 나가는 데이터가 표시되고, 클라이언트 디버그 출력에는 서버의 LCP 협상 패킷을 승인하는 것으로 표시되지만, 서버 디버그에는 SENT 패킷만 표시되고 응답은 표시되지 않습니다. 나는 도대체 무슨 일이 일어나고 있는지 알아내려고 2주 동안 벽에 머리를 부딪혔습니다.
클라이언트는 USB 케이블과 완벽하게 작동하는 dosppp를 실행하는 오래된 DOS 휴대용 컴퓨터입니다. Socat과 관련이 있는 것으로 의심되지만 수신된 데이터가 pppd에 전달되는지 여부를 디버깅하는 방법을 모르겠습니다.
내가 무엇을 놓치고 있나요? 어떻게 작동하게 할 수 있나요?
내가 사용하는 Socat 명령은 다음과 같습니다.
socat -d -d -v tcp-l:2323,fork,reuseaddr exec:'/usr/sbin/pppd notty',pty,rawer,nonblock=1,iexten=0,b19200
.ppprc
debug
nodetach
default-asyncmap
local
mtu 296
mru 296
noipv6
noauth
notty
소카트 출력:
root# socat -d -d -v tcp-l:2323,fork,reuseaddr exec:'/usr/sbin/pppd notty',pty,rawer,nonblock=1,iexten=0,b19200
2021/05/08 00:27:04 socat[1082] N listening on AF=2 0.0.0.0:2323
2021/05/08 00:27:20 socat[1082] N accepting connection from AF=2 10.0.10.46:26185 on AF=2 10.0.10.17:2323
2021/05/08 00:27:20 socat[1082] N forked off child process 1083
2021/05/08 00:27:20 socat[1082] N listening on AF=2 0.0.0.0:2323
2021/05/08 00:27:20 socat[1083] N forking off child, using pty for reading and writing
2021/05/08 00:27:20 socat[1083] N forked off child process 1084
2021/05/08 00:27:20 socat[1083] N forked off child process 1084
2021/05/08 00:27:20 socat[1083] N starting data transfer loop with FDs [6,6] and [5,5]
2021/05/08 00:27:20 socat[1084] N execvp'ing "/usr/sbin/pppd"
< 2021/05/08 00:27:20.122440 length=52 from=0 to=51
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~< 2021/05/08 00:27:23.117722 length=52 from=52 to=103
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~< 2021/05/08 00:27:26.122209 length=52 from=104 to=155
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:26.128144 length=41 from=0 to=40
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ > 2021/05/08 00:27:26.881958 length=50 from=41 to=90
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ < 2021/05/08 00:27:29.124308 length=52 from=156 to=207
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:29.504403 length=41 from=91 to=131
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ > 2021/05/08 00:27:30.154487 length=50 from=132 to=181
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ < 2021/05/08 00:27:32.127473 length=52 from=208 to=259
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:33.004495 length=50 from=182 to=231
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:33.329502 length=41 from=232 to=272
~.}#.!}!}!} }2}!}}!(}%}&}:}4@} }}"}(}"%.~ < 2021/05/08 00:27:35.130645 length=52 from=260 to=311
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:36.056441 length=50 from=273 to=322
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:36.679459 length=41 from=323 to=363
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ < 2021/05/08 00:27:38.133840 length=52 from=312 to=363
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:39.054527 length=50 from=364 to=413
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:39.655287 length=41 from=414 to=454
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ < 2021/05/08 00:27:41.137063 length=52 from=364 to=415
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:42.079453 length=50 from=455 to=504
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:43.029525 length=41 from=505 to=545
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ < 2021/05/08 00:27:44.140293 length=52 from=416 to=467
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:45.079471 length=50 from=546 to=595
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:46.279660 length=41 from=596 to=636
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ < 2021/05/08 00:27:47.143465 length=52 from=468 to=519
~.}#.!}!}!} }8}!}$}!(}"}&} } } } }%}&.sr.}'}"}(}">.~> 2021/05/08 00:27:48.054620 length=50 from=637 to=686
~.}#.!}"}!} }8}}$}!(}"}&} } } }%}&.sr.}'}"}(".} ~ > 2021/05/08 00:27:49.554776 length=41 from=687 to=727
~.}#.!}!}!} }2}}$}!(}%}&}:}4@}}'}"}(}"%.~ 2021/05/08 00:27:50 socat[1083] N read(5, 0x11f15c8, 8192): Input/output error (probably PTY closed)
2021/05/08 00:27:50 socat[1083] N socket 2 (fd 5) is at EOF
2021/05/08 00:27:50 socat[1083] E waitpid(): child 1084 exited with status 16
2021/05/08 00:27:50 socat[1083] N exit(1)
2021/05/08 00:27:50 socat[1082] N childdied(): handling signal 17
2021/05/08 00:27:50 socat[1082] N childdied(): handling signal 17
2021/05/08 00:28:42 socat[1082] N socat_signal(): handling signal 2
2021/05/08 00:28:42 socat[1082] N exiting on signal 2
2021/05/08 00:28:42 socat[1082] N socat_signal(): finishing signal 2
2021/05/08 00:28:42 socat[1082] N exit(130)
시스템 로그
May 8 00:27:20 pppd[1084]: pppd 2.4.7 started by pi, uid 0
May 8 00:27:20 pppd[1084]: using channel 2
May 8 00:27:20 pppd[1084]: Using interface ppp0
May 8 00:27:20 pppd[1084]: Connect: ppp0 <--> /dev/pts/2
May 8 00:27:20 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:23 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:26 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:29 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:32 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:35 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:38 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:41 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:44 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:47 pppd[1084]: sent [LCP ConfReq id=0x1 <mru 296> <asyncmap 0x0> <magic 0x957372ed> <pcomp> <accomp>]
May 8 00:27:50 pppd[1084]: LCP: timeout sending Config-Requests
May 8 00:27:50 pppd[1084]: Connection terminated.
May 8 00:27:50 pppd[1084]: Modem hangup
May 8 00:27:50 pppd[1084]: Waiting for 1 child processes...
May 8 00:27:50 pppd[1084]: script pppd (charshunt), pid 1085
May 8 00:27:50 pppd[1084]: Script pppd (charshunt) finished (pid 1085), status = 0x0
May 8 00:27:50 pppd[1084]: Exit.
클라이언트 디버그 출력:
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
rcvd [LCP ConfReq id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_rconfreq(LCP): Rcvd id 1.
lcp_reqci: rcvd MRU (296) (ACK)
lcp_reqci: rcvd MAGICNUMBER (99ed93e8) (ACK)
lcp_reqci: rcvd PCOMPRESSION (ACK)
lcp_reqci: rcvd ACCOMPRESSION (ACK)
lcp_reqci: returning CONFACK.
sent [LCP ConfAck id=0x1 <mru 296> <magic 0x99ed93e8> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 2, id 1.
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
calltimeout, calling 53ce:2a06.
sent [LCP ConfReq id=0x1 <mru 296> <magic 0x1aed278> <pcomp> <accomp>]
fsm_sdata(LCP): Sent code 1, id 1.
Timeout 53ce:2a06 in 3 seconds.
LCP: sending Configure-Request, id 1
calltimeout, calling 53ce:2a06.
LCP: timeout sending Config-Requests
고쳐 쓰다:이전에 Wireshark를 시도한 적이 있으며 데이터를 보기 위해 패킷을 드릴다운하는 것을 제외하면 내용은 -v 옵션을 사용한 Socat의 출력과 동일합니다. 또한 시도
socat PTY,link=/tmp/ptya,rawer,nonblock=1,b19200,waitslave tcp-l:2323,fork,reuseaddr
od -ah `readlink /tmp/ptya`
LCP 패킷이 정확합니다(PPP Design-Implementation-Debugging_James-Carlson에 따라). pppd가 클라이언트 패킷을 받지 못하는데 socat이 클라이언트 패킷을 받고 있는 것처럼 문제가 계속 발생합니다. 나는 서버에서 ppp를 시작하지 않고 이 작업을 수행했습니다.
root# od -h --endian=big `readlink /tmp/ptya`
# Every 7D XX sequence should be replaced with XX xor 20 (hex)
0000000 7eff 7d23 c021 7d21 7d21 7d20 7d32 7d7d
0000020 227d 287d 2256 6c7e 7eff 7d23 c021 7d21
0000040 7d21 7d20 7d32 7d7d 247d 2128 7d25 7d26
0000060 7d22 6791 2b7d 7d22 7d28 7d22 566c 7e7e
0000100 ff7d 23c0 217d 217d 217d 207d 327d 7d24
0000120 7d21 287d 257d 267d 2267 912b 7d7d 227d
0000140 287d 2256 6c7e 7eff 7d23 c021 7d21 7d21
0000160 7d20 7d32 7d7d 247d 2128 7d25 7d26 7d22
0000200 6791 2b7d 7d22 7d28 7d22 566c 7e7e ff7d
0000220 23c0 217d 217d 217d 207d 327d 7d24 7d21
0000240 287d 257d 267d 2267 912b 7d7d 227d 287d
0000260 2256 6c7e 7eff 7d23 c021 7d21 7d21 7d20
0000300 7d32 7d7d 247d 2128 7d25 7d26 7d22 6791
0000320 2b7d 7d22 7d28 7d22 566c 7e7e ff7d 23c0
0000340 217d 217d 217d 207d 327d 7d24 7d21 287d
0000360 257d 267d 2267 912b 7d7d 227d 287d 2256
0000400 6c7e 7eff 7d23 c021 7d21 7d21 7d20 7d32
0000420 7d7d 247d 2128 7d25 7d26 7d22 6791 2b7d
0000440 7d22 7d28 7d22 566c 7e7e ff7d 23c0 217d
0000460 217d 217d 207d 327d 7d24 7d21 287d 257d
0000500 267d 2267 912b 7d7d 227d 287d 2256 6c7e
0000520 7eff 7d23 c021 7d21 7d21 7d20 7d32 7d7d
0000540 247d 2128 7d25 7d26 7d22 6791 2b7d 7d22
kdebug 옵션을 사용해 보았으나 다시 syslog에 ppp에서 수신한 패킷이 표시되지 않습니다.
업데이트 2: 이 문제는 확실히 socat과 관련이 있습니다. 직렬 케이블로 직접 연결하여 매우 빠르게 ppp 연결을 얻을 수 있지만, PTY를 직렬 포트에 연결한 다음 PTY를 사용하여 ppp에 연결하려고 하면 실패합니다.정확히같은 방법. PPP 서버는 "보낸" 메시지만 표시하고 메시지는 수신되지 않습니다. Socat은 PPP 서버가 클라이언트로부터 응답을 받는 것을 방지하고 있습니다.어떻게든, 또는 ppp가 다른 곳으로부터 수신을 찾고 있습니다. 이는 또한 kdebug가 ppp에 대해 수신되는 패킷을 표시하지 않는 이유를 설명하는 데 도움이 되지만, socat을 통해 연결된 다른 응용 프로그램에서 데이터가 수신되는 것을 표시하는 이유는 설명하지 않습니다. 내가 시도했지만 실패한 명령은 다음과 같습니다.
socat -d -d -v file:/dev/ttyUSB0,nonblock,rawer PTY,rawer,link=/tmp/ptya
pppd `readlink /tmp/ptya`
답변1
실제 질문에 대한 답변은 아니지만 도움이 될 수 있습니다.
PTY 만 사용하고 싶다면 명령에서 직접 지정해 보는 것은 pppd어떨까요 ? pppd예를 들어, 내가 놀았을 때 다음이 나에게 효과적이었습니다 pppd.
socat PTY,link=/tmp/ptya PTY,link=/tmp/ptyb
sudo pppd `readlink /tmp/ptya` noauth nocrtscts xonxoff local maxfail 0 10.0.3.1:10.0.3.2 persist
sudo pppd `readlink /tmp/ptyb` noauth nocrtscts xonxoff local maxfail 0 10.0.3.2:10.0.3.1 persist
세부 사항을 보지 않으면 이것이 pppd notty제대로 작동하지 않는 것과 관련이 있다고 의심할 수 있습니다.
Socat 소켓을 ppp 터미널 장치에 연결하려면 PTY가 필요합니다.
예. 예를 들어 마찬가지입니다.
socat -d -d -v tcp-l:2323,fork,reuseaddr PTY,link=/tmp/ptya
/usr/sbin/pppd `readlink /tmp/ptya` ...
더 잘 작동하는지 확인하세요.
이 옵션을 사용하면 pppd는 자체적으로 pseudo-tty 마스터/슬레이브 쌍을 할당하고 슬레이브 장치를 최종 장치로 사용합니다.
그렇다면 socat하나의 PTY가 할당되고 pppd다른 PTY도 할당되어 socat첫 번째 PTY를 사용하고 pppd두 번째 PTY를 사용한다면 어떻게 서로 통신해야 할까요? 그들은 사용해야 해동일한PTY(음, 그것의 다른 측면).
저는 Socat을 사용하여 pppd와 PTY의 연결을 연결하는 소켓을 만들고 있습니다.
클라이언트는 USB 케이블과 완벽하게 작동하는 dosppp를 실행하는 오래된 DOS 휴대용 컴퓨터입니다.
이전에 Wireshark를 시도한 적이 있으며 데이터를 보기 위해 패킷을 드릴다운하는 것을 제외하면 내용은 -v 옵션을 사용하여 Socat의 출력과 동일합니다.
이제 포트 2323에 누가 연결되어 있는지, 이 끝에 무엇이 있는지, 그리고 이것이 기존 DOS 휴대용 컴퓨터와 어떤 관련이 있는지 설명해야 합니다. 왜냐하면 저는 그 부분을 정말 이해하지 못하기 때문입니다.
설명에 따르면 pppd가 작동하고, socat이 작동하고, 공유 PTY가 작동하고, 무엇이든(무엇이든) 2323에 연결되어 있고 socat이 해당 장치에 데이터를 보내고 있지만 데이터를 받지 못하는 것 같습니다.
맞습니까? (원격 디버깅은 자세한 내용을 모르면 정말 어렵습니다.)