☰

專有軟體上 SSH 問題的故障排除提示

tag-icon • tag-icon linux ssh python putty ruby
專有軟體上 SSH 問題的故障排除提示

我在使用我們購買的硬體建立管道時遇到問題。我可以使用 Putty（在 Windows 上）和 Ubuntu 的 CLI 透過 SSH 存取 VXworks 作業系統，但是，當我使用 Ruby 或 Python 向硬體發送命令時，我收到「連線被遠端主機關閉」。

我做了以下事情：

  1. 嘗試不同的程式語言在不同的作業系統上有不同的實現
  2. 嘗試了不同版本的 Ruby 和 Net::SSH，包括 4.0 alpha
  3. 允許連接埠 22 存取硬件，在硬體上
  4. 新增超時
  5. 指定特定的 Kex 鍵
  6. 縮小 KEXIT（我相信它被稱為）
  7. 聯繫了工程師。他們不相信這是他們的結局，但他們正在將其提升到鏈條上
  8. secureCRT 中的 Python 腳本確實有效。

接下來我該檢查哪些事項？我沒主意了。

一位工程師說：

“腳本確實需要在命令之間進行緩衝。我使用 securecrt 來編寫腳本。”

這是允許我連接到裝置的 secureCRT 腳本。我並不完全相信這是相關的：

host = "x.x.x.x"
user = "admin"

def main():
    # Prompt for a password instead of embedding it in a script...
    #
    passwd = crt.Dialog.Prompt("Enter password for " + host, "Login", "", True)

    # Build a command-line string to pass to the Connect method.
    cmd = "/SSH2 /L %s /PASSWORD %s /C 3DES /M MD5 %s" % (user, passwd, host)
    crt.Session.Connect(cmd)


main()

以下是 VXworks 系統的日誌：

logged out from slot 1
    [82]: JAN 23 05:13:17: alert  : 1/1/1028: clitask1: User [email protected] logged in on slot 1
    [83]: JAN 23 05:17:41: debug  : 1/1/1038: sshs: tSshServer: accept socket active.
    [84]: JAN 23 05:17:41: debug  : 1/1/1038: sshs: tSshServer: session index = 0 remote IP x.x.x.x.
    [85]: JAN 23 05:17:41: debug  : 1/1/1038: sshs: connInstance = 4218
    [86]: JAN 23 05:17:42: debug  : 1/1/1078: sshs: AuthPassword Callback: conn: 4218: user = admin
    [87]: JAN 23 05:17:42: alert  : 1/1/1078: clitask0: User [email protected] logged in on slot 1
    [88]: JAN 23 05:17:42: debug  : 1/1/1078: sshs: RxCallback: session: 0 event: OPEN
    [89]: JAN 23 05:17:42: debug  : 1/1/1078: sshs: SshInTask: after while() loop, status = -6911, cleanUp = 0
    [90]: JAN 23 05:17:42: debug  : 1/1/1078: sshs: _SshExit(0, 0) called
    [91]: JAN 23 05:19:43: debug  : 1/1/1038: sshs: tSshServer: accept socket active.
    [92]: JAN 23 05:19:43: debug  : 1/1/1038: sshs: tSshServer: session index = 0 remote IP x.x.x.x.
    [93]: JAN 23 05:19:43: debug  : 1/1/1038: sshs: connInstance = 4219
    [94]: JAN 23 05:19:46: debug  : 1/1/1078: sshs: AuthPassword Callback: conn: 4219: user = admin
    [95]: JAN 23 05:19:46: alert  : 1/1/1078: clitask0: User [email protected] logged in on slot 1
    [96]: JAN 23 05:19:46: debug  : 1/1/1078: sshs: RxCallback: session: 0 event: OPEN
    [97]: JAN 23 05:19:46: debug  : 1/1/1078: sshs: SshInTask: after while() loop, status = -6911, cleanUp = 0
    [98]: JAN 23 05:19:46: debug  : 1/1/1078: sshs: _SshExit(0, 0) called
    [99]: JAN 23 05:21:55: alert  : 1/1/1028: clitask1: User [email protected] logged out from slot 1
    [100]: JAN 23 05:23:29: alert  : 1/1/1028: clitask1: User [email protected] logged in on slot 1

這是來自 Net::SSH 的日誌

[2016-05-02T13:41:48.064959 #89562] DEBUG -- net.ssh.transport.session[11a9720]: establishing connection to 10.100.0.31:22
D, [2016-05-02T13:41:48.066315 #89562] DEBUG -- net.ssh.transport.session[11a9720]: connection established
I, [2016-05-02T13:41:48.066422 #89562]  INFO -- net.ssh.transport.server_version[11a8eec]: negotiating protocol version
D, [2016-05-02T13:41:48.066440 #89562] DEBUG -- net.ssh.transport.server_version[11a8eec]: local is `SSH-2.0-Ruby/Net::SSH_4.0.0.alpha3 x86_64-linux'
D, [2016-05-02T13:41:48.069158 #89562] DEBUG -- net.ssh.transport.server_version[11a8eec]: remote is `SSH-2.0-Mocana SSH'
D, [2016-05-02T13:41:48.070131 #89562] DEBUG -- socket[11a934c]: read 424 bytes
D, [2016-05-02T13:41:48.070230 #89562] DEBUG -- socket[11a934c]: received packet nr 0 type 20 len 420
I, [2016-05-02T13:41:48.070288 #89562]  INFO -- net.ssh.transport.algorithms[11a85f0]: got KEXINIT from server
I, [2016-05-02T13:41:48.070350 #89562]  INFO -- net.ssh.transport.algorithms[11a85f0]: sending KEXINIT
D, [2016-05-02T13:41:48.070450 #89562] DEBUG -- socket[11a934c]: queueing packet nr 0 type 20 len 1156
D, [2016-05-02T13:41:48.070574 #89562] DEBUG -- socket[11a934c]: sent 1160 bytes
I, [2016-05-02T13:41:48.070615 #89562]  INFO -- net.ssh.transport.algorithms[11a85f0]: negotiating algorithms
D, [2016-05-02T13:41:48.070694 #89562] DEBUG -- net.ssh.transport.algorithms[11a85f0]: negotiated:
* kex: diffie-hellman-group1-sha1
* host_key: ssh-dss
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client: 
* language_server: 
D, [2016-05-02T13:41:48.070740 #89562] DEBUG -- net.ssh.transport.algorithms[11a85f0]: exchanging keys
D, [2016-05-02T13:41:48.071565 #89562] DEBUG -- socket[11a934c]: queueing packet nr 1 type 30 len 140
D, [2016-05-02T13:41:48.071659 #89562] DEBUG -- socket[11a934c]: sent 144 bytes
D, [2016-05-02T13:41:48.276487 #89562] DEBUG -- socket[11a934c]: read 448 bytes
D, [2016-05-02T13:41:48.276613 #89562] DEBUG -- socket[11a934c]: received packet nr 1 type 31 len 444
D, [2016-05-02T13:41:48.277173 #89562] DEBUG -- socket[11a934c]: queueing packet nr 2 type 21 len 20
D, [2016-05-02T13:41:48.277280 #89562] DEBUG -- socket[11a934c]: sent 24 bytes
D, [2016-05-02T13:41:48.280778 #89562] DEBUG -- socket[11a934c]: read 16 bytes
D, [2016-05-02T13:41:48.280829 #89562] DEBUG -- socket[11a934c]: received packet nr 2 type 21 len 12
D, [2016-05-02T13:41:48.281017 #89562] DEBUG -- net.ssh.authentication.session[11d6f40]: beginning authentication of `admin'
D, [2016-05-02T13:41:48.281089 #89562] DEBUG -- socket[11a934c]: queueing packet nr 3 type 5 len 28
D, [2016-05-02T13:41:48.281231 #89562] DEBUG -- socket[11a934c]: sent 52 bytes
D, [2016-05-02T13:41:48.282232 #89562] DEBUG -- socket[11a934c]: read 52 bytes
D, [2016-05-02T13:41:48.282290 #89562] DEBUG -- socket[11a934c]: received packet nr 3 type 6 len 28
D, [2016-05-02T13:41:48.282386 #89562] DEBUG -- net.ssh.authentication.session[11d6f40]: trying none
D, [2016-05-02T13:41:48.282458 #89562] DEBUG -- socket[11a934c]: queueing packet nr 4 type 50 len 44
D, [2016-05-02T13:41:48.282537 #89562] DEBUG -- socket[11a934c]: sent 68 bytes
D, [2016-05-02T13:41:48.284239 #89562] DEBUG -- socket[11a934c]: read 52 bytes
D, [2016-05-02T13:41:48.284306 #89562] DEBUG -- socket[11a934c]: received packet nr 4 type 51 len 28
D, [2016-05-02T13:41:48.284352 #89562] DEBUG -- net.ssh.authentication.session[11d6f40]: allowed methods: password
D, [2016-05-02T13:41:48.284387 #89562] DEBUG -- net.ssh.authentication.methods.none[11dfcf8]: none failed
D, [2016-05-02T13:41:48.284420 #89562] DEBUG -- net.ssh.authentication.session[11d6f40]: trying password
D, [2016-05-02T13:41:48.284489 #89562] DEBUG -- socket[11a934c]: queueing packet nr 5 type 50 len 60
D, [2016-05-02T13:41:48.284569 #89562] DEBUG -- socket[11a934c]: sent 84 bytes
D, [2016-05-02T13:41:48.295419 #89562] DEBUG -- socket[11a934c]: read 36 bytes
D, [2016-05-02T13:41:48.295559 #89562] DEBUG -- socket[11a934c]: received packet nr 5 type 52 len 12
D, [2016-05-02T13:41:48.295638 #89562] DEBUG -- net.ssh.authentication.methods.password[11de8a8]: password succeeded
D, [2016-05-02T13:41:48.295769 #89562] DEBUG -- socket[11a934c]: queueing packet nr 6 type 90 len 44
D, [2016-05-02T13:41:48.295911 #89562] DEBUG -- socket[11a934c]: sent 68 bytes
D, [2016-05-02T13:41:48.297023 #89562] DEBUG -- socket[11a934c]: read 52 bytes
D, [2016-05-02T13:41:48.297124 #89562] DEBUG -- socket[11a934c]: received packet nr 6 type 91 len 28
I, [2016-05-02T13:41:48.297203 #89562]  INFO -- net.ssh.connection.session[11e3f88]: channel_open_confirmation: 0 85460946 1000 1000
I, [2016-05-02T13:41:48.297353 #89562]  INFO -- net.ssh.connection.channel[11e3df8]: sending channel request "env"
D, [2016-05-02T13:41:48.297444 #89562] DEBUG -- socket[11a934c]: queueing packet nr 7 type 98 len 44
I, [2016-05-02T13:41:48.297579 #89562]  INFO -- net.ssh.connection.channel[11e3df8]: sending channel request "exec"
D, [2016-05-02T13:41:48.297637 #89562] DEBUG -- socket[11a934c]: queueing packet nr 8 type 98 len 28
D, [2016-05-02T13:41:48.297871 #89562] DEBUG -- socket[11a934c]: sent 120 bytes
D, [2016-05-02T13:41:49.297172 #89562] DEBUG -- socket[11a934c]: read 140 bytes
D, [2016-05-02T13:41:49.297469 #89562] DEBUG -- socket[11a934c]: read 0 bytes
I, [2016-05-02T13:41:49.297762 #89562]  INFO -- net.ssh.connection.session[11e3f88]: closing remaining channels (1 open)
D, [2016-05-02T13:41:49.297895 #89562] DEBUG -- socket[11a934c]: read 0 bytes
Net::SSH::Disconnect: connection closed by remote host

相關內容