Forums: Forum d’aide (Thread #35021)

TTSSHのSCPが99%で停止してしまう (2014-01-30 23:05 by kusuda_keiji #71611)

お世話になっております。

teratermマクロにより、リモートホスト(Linux)へ自動ログイン後、スクリプトを実行し、作成されたtar.gz(約3〜5MB)ファイルをSCPによるローカルホスト(windows7)への転送を実現したいと考えておりますが、SCPの転送中に99%で停止してしまうことがあります
複数台(10台位)で同時実行すると発生することが多いように(しないこともある)感じますが、原因としてはどのようなことが考えられるのでしょうか。

また、回避策等はありますでしょうか。
なお、teratermのverは4.64です。

Re: TTSSHのSCPが99%で停止してしまう (2014-01-30 23:09 by (del#1144) #71613)

最新版をお試しください。
Répondre à #71611

Re: TTSSHのSCPが99%で停止してしまう (2014-01-30 23:40 by kusuda_keiji #71614)

業務の都合上、最新版を使用することができません。
最新版を使用する他に回避策はないのでしょうか?
Répondre à #71613

Re: TTSSHのSCPが99%で停止してしまう (2014-01-30 23:48 by (del#1144) #71615)

SSHの圧縮を無効にすると落ちないかもしれません。
Répondre à #71614

Re: TTSSHのSCPが99%で停止してしまう (2014-01-31 13:02 by kusuda_keiji #71635)

ヘルプを確認した所、圧縮無効のオプションはver4.64付属のTTSSHでは対応していませんでした。
最新のTTSSHの改版履歴ではSCPが落ちるという事象は改善されているようなので、バグということなのでしょうか。
Répondre à #71615

Re: TTSSHのSCPが99%で停止してしまう (2014-01-31 13:19 by (del#1144) #71636)

> ヘルプを確認した所、圧縮無効のオプションはver4.64付属のTTSSHでは対応していませんでした。
TERATERM.INIでTTSSHのCompressionを0にすれば無効にできます。

> 最新のTTSSHの改版履歴ではSCPが落ちるという事象は改善されているようなので、バグということなのでしょうか。
SSHの圧縮が有効だと落ちるという問題が過去にあり修正されましたが、あなたのところで起きている現象がそのせいなのか、それとも別の問題なのかは試してみないとわかりません。
Répondre à #71635

Re: TTSSHのSCPが99%で停止してしまう (2014-01-31 23:43 by kusuda_keiji #71659)

ありがとうございます。

>TERATERM.INIでTTSSHのCompressionを0にすれば無効にできます。
コマンドのオプションしか見ていませんでした。iniファイルにも設定できたのですね。こちらを確認したところ0になっていたため、圧縮は無効となっていました。

>SSHの圧縮が有効だと落ちるという問題が過去にあり修正されましたが、あなたのところで起きている現象がそのせいなのか、それとも別の問題なのかは試してみないとわかりません。
確かにその通りですね。
最新版は業務では使用することはできませんが、検証するくらいはで出来るので最新版でもこの事象が再現するか来週試してみたいと思います。
Répondre à #71636

Re: TTSSHのSCPが99%で停止してしまう (2014-02-01 10:22 by (del#1144) #71667)

よろしくお願いします。
少し気になることがあります。

「99%で停止してしまう」というのは、進捗ダイアログが表示された状態で99%を指したまま進まないのでしょうか。それともダイアログは消えるもののファイルが99%までしか転送されていないのでしょうか。それともSSH接続自体が切れてしまうのでしょうか。

ひとつのSSH接続から同時に複数のSCPダウンロードをしているわけではありませんよね?
cf. https://sourceforge.jp/ticket/browse.php?group_id=1412&tid=25167

TERATERM.INI の TTSSH の LogLevel=100 にして、現象が起きたときの TTSSH.LOG がどうなるか見せてもらうことは可能ですか?
Répondre à #71659

Re: TTSSHのSCPが99%で停止してしまう (2014-02-01 11:48 by kusuda_keiji #71682)

> 「99%で停止してしまう」というのは、進捗ダイアログが表示された状態で99%を指したまま進まないのでしょうか。それともダイアログは消えるもののファイルが99%までしか転送されていないのでしょうか。それともSSH接続自体が切れてしまうのでしょうか。
「進捗ダイアログが表示された状態で99%を指したまま進まない」の状態です。

> ひとつのSSH接続から同時に複数のSCPダウンロードをしているわけではありませんよね?
はい、各リモートホスト毎にSSH接続しSCPダウンロード(1ファイル)を実行しています。
複数台で実施する場合は1台ずつSCPを実施するような処理にしています。

> TERATERM.INI の TTSSH の LogLevel=100 にして、現象が起きたときの TTSSH.LOG がどうなるか見せてもらうことは可能ですか?
はい、確認してみます。
Répondre à #71667

Re: TTSSHのSCPが99%で停止してしまう (2014-02-08 14:18 by kusuda_keiji #71833)

遅くなりました。

最新版(teraterm4.80)を使用し、同環境で実施してみました。
結果、少なくとも現在までに事象は発生は確認出来ませんでした。
とはいえ、最新版は使用できずver4.64をでどうにかしなきゃいけない状況は変わらないわけですが回避策はないものでしょうか。引き続き考えてみたいと思います。

また、TERATERM.iniをLogLevel=100にして、事象発生時、事象未発生時のものを比べてみましたが、特に異常を示す箇所は見当たりませんでした。
以下、事象発生時のログの内、停止したサーバと覆われるPIDを抜粋したものです。


Tue Feb 04 06:55:58 2014 [7304] ---------------------------------------------------------------------
Tue Feb 04 06:55:58 2014 [7304] Initiating SSH session
Tue Feb 04 06:56:01 2014 [7304] Received server prologue string: SSH-2.0-OpenSSH_4.3
Tue Feb 04 06:56:02 2014 [7304] SSH2_MSG_KEXINIT was sent at SSH2_send_kexinit().
Tue Feb 04 06:56:02 2014 [7304] SSH2_MSG_KEXINIT was received.
Tue Feb 04 06:56:02 2014 [7304] KEX algorithm: diffie-hellman-group-exchange-sha1
Tue Feb 04 06:56:02 2014 [7304] server host key algorithm: ssh-rsa
Tue Feb 04 06:56:02 2014 [7304] encryption algorithm client to server: aes256-ctr
Tue Feb 04 06:56:02 2014 [7304] encryption algorithm server to client: aes256-ctr
Tue Feb 04 06:56:02 2014 [7304] MAC algorithm client to server: hmac-sha1
Tue Feb 04 06:56:02 2014 [7304] MAC algorithm server to client: hmac-sha1
Tue Feb 04 06:56:02 2014 [7304] compression algorithm client to server: none
Tue Feb 04 06:56:02 2014 [7304] compression algorithm server to client: none
Tue Feb 04 06:56:02 2014 [7304] SSH2_MSG_KEX_DH_GEX_REQUEST was sent at SSH2_dh_gex_kex_init().
Tue Feb 04 06:56:02 2014 [7304] SSH2_MSG_KEX_DH_GEX_GROUP was received.
Tue Feb 04 06:56:03 2014 [7304] SSH2_MSG_KEX_DH_GEX_INIT was sent at handle_SSH2_dh_gex_group().
Tue Feb 04 06:56:03 2014 [7304] SSH2_MSG_KEX_DH_GEX_REPLY was received.
Tue Feb 04 06:56:03 2014 [7304] SSH2_MSG_NEWKEYS was sent at handle_SSH2_dh_gex_reply().
Tue Feb 04 06:56:03 2014 [7304] SSH2_MSG_NEWKEYS was received(DH key generation is completed).
Tue Feb 04 06:56:03 2014 [7304] Server reports supported authentication method mask = 65580
Tue Feb 04 06:56:03 2014 [7304] Entering secure mode
Tue Feb 04 06:56:03 2014 [7304] SSH2_MSG_SERVICE_REQUEST was sent at do_SSH2_userauth().
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_SERVICE_ACCEPT was received. service name=ssh-userauth
[7304] SSH2_MSG_USERAUTH_REQUEST was sent do_SSH2_authrequest(). (method 3)
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_USERAUTH_FAILURE was received.
Tue Feb 04 06:56:04 2014 [7304] Server reports supported authentication method mask = 65548
[7304] method list from server: publickey,gssapi-with-mic,password
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_USERAUTH_REQUEST was sent do_SSH2_authrequest(). (method 3)
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_USERAUTH_SUCCESS was received.
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_OPEN was sent at handle_SSH2_userauth_success().
Tue Feb 04 06:56:04 2014 [7304] User authentication is successful and SSH heartbeat thread is starting.
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_OPEN_CONFIRMATION was received.
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_REQUEST was sent at send_pty_request().
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_SUCCESS was received(nego_status 2).
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_REQUEST was sent at handle_SSH2_channel_success().
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_CHANNEL_SUCCESS was received(nego_status 3).
Tue Feb 04 06:56:04 2014 [7304] SSH2_MSG_IGNORE was received.
Tue Feb 04 07:05:02 2014 [7304] SSH2_MSG_CHANNEL_OPEN was sent at SSH_scp_transaction().
Tue Feb 04 07:05:02 2014 [7304] SSH2_MSG_CHANNEL_OPEN_CONFIRMATION was received.
Tue Feb 04 07:05:02 2014 [7304] SSH2_MSG_CHANNEL_REQUEST was sent at handle_SSH2_open_confirm().
Tue Feb 04 07:05:02 2014 [7304] SSH2_MSG_CHANNEL_SUCCESS was received(nego_status 4).
Tue Feb 04 07:13:06 2014 [7304] SSH2_MSG_CHANNEL_CLOSE was sent at ssh2_channel_send_close(). local:1 remote:1
Tue Feb 04 07:13:06 2014 [7304] SSH2_MSG_CHANNEL_REQUEST was received.
Tue Feb 04 07:13:06 2014 [7304] SSH2_MSG_CHANNEL_CLOSE was received. local:1 remote:1
Tue Feb 04 07:13:22 2014 [7304] SSH2_MSG_CHANNEL_OPEN was sent at SSH_scp_transaction().
Tue Feb 04 07:13:22 2014 [7304] SSH2_MSG_CHANNEL_OPEN was sent at SSH_scp_transaction().





Répondre à #71682