Discussions related to using object storage as a backup target.
Post Reply
az1234567890
Novice
Posts: 6
Liked: never
Joined: May 31, 2023 1:30 pm
Full Name: az
Contact:

Case # 06144598 - Move to Archive Tier is failing

Post by az1234567890 »

Hi,

Archiving from Capacity Tier is failing with the following error:
Image

i followed https://www.veeam.com/kb4320 and i can confirm SSH and HTTPS are reachable from the VBR server.

Proxy appliance logs in C:\ProgramData\Veeam\Backup\ are showing that the VBR server is able to connect to SSH and deploy whatever needs to be deployed but after enabling redirector, is no longer able to connect via SSH:

Code: Select all

[17.07.2023 09:13:47.846] <27> Info         [CSshRenciConnectionImpl] Establishing SSH Renci connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' to host 74.234.89.204
[17.07.2023 09:13:47.983] <27> Info         [CSshRenciConnectionImpl] SSH Renci connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' has been established. Session: [SSH Session; Local: 192.168.1.175:64674; Remote: 74.234.89.204:22]
[17.07.2023 09:13:47.983] <27> Info         [Ssh] SSH connection 708021c9-f89d-44db-a6c3-4dba3dc7b8fc to server 74.234.89.204 created successfully
[17.07.2023 09:13:50.588] <27> Info         [Ssh] Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc': Elevate method: "sudo" in TTY
[17.07.2023 09:13:50.591] <27> Info         [CSshFileCommConnection] SSH file commander connection has been created. Id: '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:50.599] <27> Info         [CSshFileCommConnection] SSH file commander connection has been created. Id: '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:50.600] <27> Info         [CSshFileCommConnection] SSH disposing for file comm connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' has been suppressed
[17.07.2023 09:13:50.601] <27> Info         [BImageSDKProxyInstaller] Installing SDK files
[17.07.2023 09:13:50.601] <27> Info         [BImageSDKProxyInstaller] Installation of SDK files. 1 attempt
[17.07.2023 09:13:50.609] <27> Info         [FileManager] IsExists. Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:50.637] <27> Info         Starting perlSoap protocol to "74.234.89.204"
[17.07.2023 09:13:50.639] <27> Info         Installing perlsoap library to /tmp/veed0999b8c-c8dd-49dc-9364-79334fa76c19
[17.07.2023 09:13:50.702] <27> Info         Reading "veeam_soap.tar" from directory "E:\Program Files\Veeam\Backup and Replication\Backup\"
[17.07.2023 09:13:51.414] <27> Info         [CSshRenciConnectionImpl] SFTP Renci connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' has been established. Session: [SSH Session; Local: 192.168.1.175:64677; Remote: 74.234.89.204:22]
[17.07.2023 09:13:51.608] <27> Info         [Perlsoap] Trying to remove temp dir '/tmp/veed0999b8c-c8dd-49dc-9364-79334fa76c19' and error file '/tmp/veeam_errord0999b8c-c8dd-49dc-9364-79334fa76c19' if it still exist
[17.07.2023 09:13:51.621] <27> Info         [Perlsoap] Answer to remove: :
[17.07.2023 09:13:51.622] <27> Info         Answer to installation: :
[17.07.2023 09:13:52.004] <27> Info         [Ssh] Creating dir '/tmp/veeam'
[17.07.2023 09:13:52.004] <27> Info         [FileManager] IsExists. Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:52.013] <27> Info         [FileManager] IsExists. Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:52.023] <27> Info         [FileManager] IsExists. Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:52.036] <27> Info         [FileManager] Creating dir "/tmp/veeam" (Connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc')
[17.07.2023 09:13:52.191] <27> Info         [BImageSDKProxyInstaller] Uploading veeamnetworkredirector from E:\Program Files\Veeam\Backup and Replication\Backup\Packages to /tmp/veeam
[17.07.2023 09:13:53.120] <27> Info         [BImageSDKProxyInstaller] Installation of SDK files complete
[17.07.2023 09:13:53.121] <27> Info         [CloudLinuxAppliance] Starting SOBR network redirector on cloud appliance '74.234.89.204'
[17.07.2023 09:13:53.122] <27> Info         Executing command 'screen -d -m sh -c "sudo /tmp/veeam/veeamnetworkredirector -cloud_appliance -cloud_port 443"'
[17.07.2023 09:13:53.192] <27> Info         Command answer: 
[17.07.2023 09:13:53.193] <27> Info         [CSshFileCommConnection] Deinitializing file connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:53.195] <27> Info         [CSshFileCommConnection] Disposing SSH file connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc'
[17.07.2023 09:13:53.196] <27> Info         [Ssh] Connection 708021c9-f89d-44db-a6c3-4dba3dc7b8fc - [host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]] is disposing.
[17.07.2023 09:13:53.207] <27> Info         [CSshRenciConnectionImpl] SSH Renci connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' has been closed. Session: [SSH Session; Local: 192.168.1.175:64674; Remote: 74.234.89.204:22]
[17.07.2023 09:13:53.213] <27> Info         [CSshRenciConnectionImpl] SFTP Renci connection '708021c9-f89d-44db-a6c3-4dba3dc7b8fc' has been closed. Session: [SSH Session; Local: 192.168.1.175:64677; Remote: 74.234.89.204:22]
[17.07.2023 09:13:53.220] <27> Info         [Ssh] Connection 708021c9-f89d-44db-a6c3-4dba3dc7b8fc - [host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]] already disposed
[17.07.2023 09:13:53.221] <27> Info         Removing -881509284:27 from cache. Reason: Removed
[17.07.2023 09:13:53.225] <27> Info         Trying to enable network traffic redirection for host 74.234.89.204. Redirector 74.234.89.204:443
[17.07.2023 09:13:53.227] <27> Info         Redirector addresses: 74.234.89.204
[17.07.2023 09:13:53.227] <27> Info         Host addresses: 74.234.89.204;74.234.89.204
[17.07.2023 09:13:53.230] <27> Info         [HookRedirection] Adding redirection rule: 74.234.89.204 -> 74.234.89.204:443
[17.07.2023 09:13:53.233] < 18620>          | Initializing redirection hook
[17.07.2023 09:13:53.233] < 18620>          |   Subscribing for adapters
[17.07.2023 09:13:53.233] < 18620> hook     |   [Hook] Installing redirection hooks
[17.07.2023 09:13:53.233] < 18620>          |     [Hook] Getting ConnectEx function pointer
[17.07.2023 09:13:53] <20> Info     [Hook] Creating redirection hooks rules instance.
[17.07.2023 09:13:53] <20> Info     [Hook] Add redirection rule for address 74.234.89.204, redirector: 74.234.89.204:443, target: 127.0.0.1
[17.07.2023 09:13:53.255] <27> Info         [HookRedirection] Adding redirection rule: 74.234.89.204 -> 74.234.89.204:443
[17.07.2023 09:13:53] <20> Info     [Hook] Add redirection rule for address 74.234.89.204, redirector: 74.234.89.204:443, target: 127.0.0.1
[17.07.2023 09:13:53.258] <27> Info         [CloudLinuxAppliance] Testing agent connection to 74.234.89.204
[17.07.2023 09:13:53] <20> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:13:53.260] <27> Info         IP addresses of LiveCD VM: 74.234.89.204
[17.07.2023 09:13:53.261] <27> Info         [Ssh] Creating new connection 76dcb9ca-ba49-4580-87a9-b591de512002 [host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]].
[17.07.2023 09:13:53.261] <27> Info         [Ssh] Creating SSH connection 76dcb9ca-ba49-4580-87a9-b591de512002 to server 74.234.89.204
[17.07.2023 09:13:53.262] <27> Info         [Ssh] Creating Granados SSH connection '76dcb9ca-ba49-4580-87a9-b591de512002' (unknown protocol)
[17.07.2023 09:13:53.262] <27> Info         [Ssh] logon, host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]
[17.07.2023 09:13:53.262] <27> Info         [Ssh] Granados '76dcb9ca-ba49-4580-87a9-b591de512002' connected to . Session: [SSH Session; Local: ; Remote: ]
[17.07.2023 09:13:53] <20> Info     Executing WSAConnect function for socket: '7524'
[17.07.2023 09:13:53] <20> Info       [Hook] Requested connection to 74.234.89.204:22
[17.07.2023 09:13:53] <20> Info       [Hook] Found Redirection rule source ip: '74.234.89.204:*', redirector: '74.234.89.204:443', target ip: '127.0.0.1'
[17.07.2023 09:13:53] <20> Info       [Hook] Connecting to rule target host: 74.234.89.204:443
[17.07.2023 09:13:53] <20> Info       [Hook] Connection was established
[17.07.2023 09:13:53] <20> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:13:53] <20> Info         [NetworkPolicy] Global network policy has been set (default):
[17.07.2023 09:13:53] <20> Info         [NetworkPolicy]     IPv4 disabled: False
[17.07.2023 09:13:53] <20> Info         [NetworkPolicy]     IPv6 disabled: False
[17.07.2023 09:13:53] <20> Info       [Hook] Handshake procedure completed
[17.07.2023 09:13:53.274] <27> Info         [Ssh] Connected to 74.234.89.204 while other addresses () are unavailable.
[17.07.2023 09:13:54.135] <27> Warning      Failed to create SSH connection to host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]. An existing connection was forcibly closed by the remote host
[17.07.2023 09:13:54.136] <27> Error        Failed to connect by SSH. RetryCount: '0'. MaxRetryCount: '100'.
[17.07.2023 09:13:54.136] <27> Error        An existing connection was forcibly closed by the remote host (Veeam.Backup.Common.SSHException)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.ReceivePacket()
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.SSHCV2.KeyExchanger.SynchronousKexExchange()
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.Connect(AbstractSocket s)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.SSHC.SSHConnection.ConnectMain(SSHConnectionParameter param, ISSHConnectionEventReceiver receiver, ProtocolNegotiationHandler pnh, AbstractSocket s)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.CSshGranadosConnectionImpl.Connect()
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnectionImpl(CSshConnectionSpec connSpec)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.CSshConnection.InternalCreateNotCachedConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.SSH.CSshConnection..ctor(CSshConnectionSpec spec, ISshConfig sshCore, Boolean useCache, LogLevels logLevel)
[17.07.2023 09:13:54.136] <27> Error           at Veeam.Backup.Core.CApplianceSshConnection.ConnectSshWithRetry(CSshConnectionSpec spec, Int32 retryCount, Boolean useCache, Action cancelCheckActionCanBeNull)
[17.07.2023 09:13:55] <48> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:13:55] <48> Info     Executing WSAConnect function for socket: '7372'
[17.07.2023 09:13:55] <48> Info       [Hook] Requested connection to 74.234.89.197:22
[17.07.2023 09:13:55] <48> Info       [Hook] Rule has not found. Skipped arguments: [22];[74.234.89.197];
[17.07.2023 09:13:55] <48> Info       [Hook] Going to connect to original 74.234.89.197:22 without handshakes
[17.07.2023 09:13:56] <80> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:13:56] <80> Info     Executing WSAConnect function for socket: '6472'
[17.07.2023 09:13:56] <80> Info       [Hook] Requested connection to 74.234.89.183:22
[17.07.2023 09:13:56] <80> Info       [Hook] Rule has not found. Skipped arguments: [22];[74.234.89.183];
[17.07.2023 09:13:56] <80> Info       [Hook] Going to connect to original 74.234.89.183:22 without handshakes
[17.07.2023 09:13:56] <36> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:13:56] <36> Info     Executing WSAConnect function for socket: '6652'
[17.07.2023 09:13:56] <36> Info       [Hook] Requested connection to 74.234.95.122:22
[17.07.2023 09:13:56] <36> Info       [Hook] Rule has not found. Skipped arguments: [22];[74.234.95.122];
[17.07.2023 09:13:56] <36> Info       [Hook] Going to connect to original 74.234.95.122:22 without handshakes
[17.07.2023 09:13:59.138] <27> Info         [LinFLR] Retrying to connect by SSH ...
[17.07.2023 09:13:59.138] <27> Info         [Ssh] Creating new connection 553873d7-e59b-4c06-b914-fe795ebde185 [host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]].
[17.07.2023 09:13:59.138] <27> Info         [Ssh] Creating SSH connection 553873d7-e59b-4c06-b914-fe795ebde185 to server 74.234.89.204
[17.07.2023 09:13:59.139] <27> Info         [Ssh] Creating Granados SSH connection '553873d7-e59b-4c06-b914-fe795ebde185' (unknown protocol)
[17.07.2023 09:13:59.139] <27> Info         [Ssh] logon, host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]
[17.07.2023 09:13:59.139] <27> Info         [Ssh] Granados '553873d7-e59b-4c06-b914-fe795ebde185' connected to . Session: [SSH Session; Local: ; Remote: ]
[17.07.2023 09:13:59] <20> Info     Executing WSAConnect function for socket: '5596'
[17.07.2023 09:13:59] <20> Info       [Hook] Requested connection to 74.234.89.204:22
[17.07.2023 09:13:59] <20> Info       [Hook] Found Redirection rule source ip: '74.234.89.204:*', redirector: '74.234.89.204:443', target ip: '127.0.0.1'
[17.07.2023 09:13:59] <20> Info       [Hook] Connecting to rule target host: 74.234.89.204:443
[17.07.2023 09:13:59] <20> Info       [Hook] Connection was established
[17.07.2023 09:13:59] <20> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:13:59] <20> Info       [Hook] Handshake procedure completed
[17.07.2023 09:13:59.162] <27> Info         [Ssh] Connected to 74.234.89.204 while other addresses () are unavailable.
[17.07.2023 09:14:01] <48> Info     [Hook] Add redirection rule for address 74.234.89.197, redirector: 74.234.89.197:443, target: 127.0.0.1
[17.07.2023 09:14:01] <48> Info     [Hook] Add redirection rule for address 74.234.89.197, redirector: 74.234.89.197:443, target: 127.0.0.1
[17.07.2023 09:14:01] <48> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:01] <48> Info     Executing WSAConnect function for socket: '3620'
[17.07.2023 09:14:01] <48> Info       [Hook] Requested connection to 74.234.89.197:22
[17.07.2023 09:14:01] <48> Info       [Hook] Found Redirection rule source ip: '74.234.89.197:*', redirector: '74.234.89.197:443', target ip: '127.0.0.1'
[17.07.2023 09:14:01] <48> Info       [Hook] Connecting to rule target host: 74.234.89.197:443
[17.07.2023 09:14:01] <48> Info       [Hook] Connection was established
[17.07.2023 09:14:01] <48> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:01] <48> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:02] <80> Info     [Hook] Add redirection rule for address 74.234.89.183, redirector: 74.234.89.183:443, target: 127.0.0.1
[17.07.2023 09:14:02] <80> Info     [Hook] Add redirection rule for address 74.234.89.183, redirector: 74.234.89.183:443, target: 127.0.0.1
[17.07.2023 09:14:02] <80> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:02] <80> Info     Executing WSAConnect function for socket: '6232'
[17.07.2023 09:14:02] <80> Info       [Hook] Requested connection to 74.234.89.183:22
[17.07.2023 09:14:02] <80> Info       [Hook] Found Redirection rule source ip: '74.234.89.183:*', redirector: '74.234.89.183:443', target ip: '127.0.0.1'
[17.07.2023 09:14:02] <80> Info       [Hook] Connecting to rule target host: 74.234.89.183:443
[17.07.2023 09:14:02] <80> Info       [Hook] Connection was established
[17.07.2023 09:14:02] <80> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:02] <80> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:02] <36> Info     [Hook] Add redirection rule for address 74.234.95.122, redirector: 74.234.95.122:443, target: 127.0.0.1
[17.07.2023 09:14:02] <36> Info     [Hook] Add redirection rule for address 74.234.95.122, redirector: 74.234.95.122:443, target: 127.0.0.1
[17.07.2023 09:14:02] <36> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:02] <36> Info     Executing WSAConnect function for socket: '5996'
[17.07.2023 09:14:02] <36> Info       [Hook] Requested connection to 74.234.95.122:22
[17.07.2023 09:14:02] <36> Info       [Hook] Found Redirection rule source ip: '74.234.95.122:*', redirector: '74.234.95.122:443', target ip: '127.0.0.1'
[17.07.2023 09:14:02] <36> Info       [Hook] Connecting to rule target host: 74.234.95.122:443
[17.07.2023 09:14:02] <36> Info       [Hook] Connection was established
[17.07.2023 09:14:02] <36> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:02] <36> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:07] <48> Info     Executing WSAConnect function for socket: '6780'
[17.07.2023 09:14:07] <48> Info       [Hook] Requested connection to 74.234.89.197:22
[17.07.2023 09:14:07] <48> Info       [Hook] Found Redirection rule source ip: '74.234.89.197:*', redirector: '74.234.89.197:443', target ip: '127.0.0.1'
[17.07.2023 09:14:07] <48> Info       [Hook] Connecting to rule target host: 74.234.89.197:443
[17.07.2023 09:14:07] <48> Info       [Hook] Connection was established
[17.07.2023 09:14:07] <48> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:07] <48> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:08] <36> Info     Executing WSAConnect function for socket: '4912'
[17.07.2023 09:14:08] <36> Info       [Hook] Requested connection to 74.234.95.122:22
[17.07.2023 09:14:08] <36> Info       [Hook] Found Redirection rule source ip: '74.234.95.122:*', redirector: '74.234.95.122:443', target ip: '127.0.0.1'
[17.07.2023 09:14:08] <36> Info       [Hook] Connecting to rule target host: 74.234.95.122:443
[17.07.2023 09:14:08] <36> Info       [Hook] Connection was established
[17.07.2023 09:14:08] <36> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:08] <36> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:08] <80> Info     Executing WSAConnect function for socket: '6952'
[17.07.2023 09:14:08] <80> Info       [Hook] Requested connection to 74.234.89.183:22
[17.07.2023 09:14:08] <80> Info       [Hook] Found Redirection rule source ip: '74.234.89.183:*', redirector: '74.234.89.183:443', target ip: '127.0.0.1'
[17.07.2023 09:14:08] <80> Info       [Hook] Connecting to rule target host: 74.234.89.183:443
[17.07.2023 09:14:08] <80> Info       [Hook] Connection was established
[17.07.2023 09:14:08] <80> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:08] <80> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:20.469] <27> Warning      Failed to create SSH connection to host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]. A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond
[17.07.2023 09:14:20.469] <27> Error        Failed to connect by SSH. RetryCount: '1'. MaxRetryCount: '100'.
[17.07.2023 09:14:20.469] <27> Error        A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond (Veeam.Backup.Common.SSHException)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.ReceivePacket()
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.SSHCV2.KeyExchanger.SynchronousKexExchange()
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.Connect(AbstractSocket s)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.SSHC.SSHConnection.ConnectMain(SSHConnectionParameter param, ISSHConnectionEventReceiver receiver, ProtocolNegotiationHandler pnh, AbstractSocket s)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.CSshGranadosConnectionImpl.Connect()
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnectionImpl(CSshConnectionSpec connSpec)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.CSshConnection.InternalCreateNotCachedConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.SSH.CSshConnection..ctor(CSshConnectionSpec spec, ISshConfig sshCore, Boolean useCache, LogLevels logLevel)
[17.07.2023 09:14:20.469] <27> Error           at Veeam.Backup.Core.CApplianceSshConnection.ConnectSshWithRetry(CSshConnectionSpec spec, Int32 retryCount, Boolean useCache, Action cancelCheckActionCanBeNull)
[17.07.2023 09:14:25] <40> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:25.472] <27> Info         [LinFLR] Retrying to connect by SSH ...
[17.07.2023 09:14:25.472] <27> Info         [Ssh] Creating new connection efc8f627-3646-4079-9b82-d821c3c4d371 [host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]].
[17.07.2023 09:14:25.472] <27> Info         [Ssh] Creating SSH connection efc8f627-3646-4079-9b82-d821c3c4d371 to server 74.234.89.204
[17.07.2023 09:14:25.473] <27> Info         [Ssh] Creating Granados SSH connection 'efc8f627-3646-4079-9b82-d821c3c4d371' (unknown protocol)
[17.07.2023 09:14:25.473] <27> Info         [Ssh] logon, host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]
[17.07.2023 09:14:25.473] <27> Info         [Ssh] Granados 'efc8f627-3646-4079-9b82-d821c3c4d371' connected to . Session: [SSH Session; Local: ; Remote: ]
[17.07.2023 09:14:25] <20> Info     Executing WSAConnect function for socket: '7536'
[17.07.2023 09:14:25] <20> Info       [Hook] Requested connection to 74.234.89.204:22
[17.07.2023 09:14:25] <20> Info       [Hook] Found Redirection rule source ip: '74.234.89.204:*', redirector: '74.234.89.204:443', target ip: '127.0.0.1'
[17.07.2023 09:14:25] <20> Info       [Hook] Connecting to rule target host: 74.234.89.204:443
[17.07.2023 09:14:25] <20> Info       [Hook] Connection was established
[17.07.2023 09:14:25] <20> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:25] <20> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:25.483] <27> Info         [Ssh] Connected to 74.234.89.204 while other addresses () are unavailable.
[17.07.2023 09:14:26] <40> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:32] <80> Info     Executing WSAConnect function for socket: '8260'
[17.07.2023 09:14:32] <80> Info       [Hook] Requested connection to 74.234.89.183:22
[17.07.2023 09:14:32] <80> Info       [Hook] Found Redirection rule source ip: '74.234.89.183:*', redirector: '74.234.89.183:443', target ip: '127.0.0.1'
[17.07.2023 09:14:32] <80> Info       [Hook] Connecting to rule target host: 74.234.89.183:443
[17.07.2023 09:14:32] <80> Info       [Hook] Connection was established
[17.07.2023 09:14:32] <80> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:32] <80> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:34] <48> Info     Executing WSAConnect function for socket: '8284'
[17.07.2023 09:14:34] <48> Info       [Hook] Requested connection to 74.234.89.197:22
[17.07.2023 09:14:34] <48> Info       [Hook] Found Redirection rule source ip: '74.234.89.197:*', redirector: '74.234.89.197:443', target ip: '127.0.0.1'
[17.07.2023 09:14:34] <48> Info       [Hook] Connecting to rule target host: 74.234.89.197:443
[17.07.2023 09:14:34] <48> Info       [Hook] Connection was established
[17.07.2023 09:14:34] <48> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:34] <48> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:34] <36> Info     Executing WSAConnect function for socket: '8308'
[17.07.2023 09:14:34] <36> Info       [Hook] Requested connection to 74.234.95.122:22
[17.07.2023 09:14:34] <36> Info       [Hook] Found Redirection rule source ip: '74.234.95.122:*', redirector: '74.234.95.122:443', target ip: '127.0.0.1'
[17.07.2023 09:14:34] <36> Info       [Hook] Connecting to rule target host: 74.234.95.122:443
[17.07.2023 09:14:34] <36> Info       [Hook] Connection was established
[17.07.2023 09:14:34] <36> Info       [Hook] Initializing handshake procedure
[17.07.2023 09:14:34] <36> Info       [Hook] Handshake procedure completed
[17.07.2023 09:14:41] <56> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:41] <56> Info     Executing WSAConnect function for socket: '7636'
[17.07.2023 09:14:41] <56> Info       [Hook] Requested connection to ::1:9392
[17.07.2023 09:14:41] <56> Info       [Hook] Rule has not found. Skipped arguments: [9392];[::1];
[17.07.2023 09:14:41] <56> Info       [Hook] Going to connect to original ::1:9392 without handshakes
[17.07.2023 09:14:41] < 8> Info     Executing GetAddrInfoW for server: 'VBR01'
[17.07.2023 09:14:41] < 8> Info     Executing WSAConnect function for socket: '7996'
[17.07.2023 09:14:41] < 8> Info       [Hook] Requested connection to ::1:9392
[17.07.2023 09:14:41] < 8> Info       [Hook] Rule has not found. Skipped arguments: [9392];[::1];
[17.07.2023 09:14:41] < 8> Info       [Hook] Going to connect to original ::1:9392 without handshakes
[17.07.2023 09:14:44.386] <27> Warning      Failed to create SSH connection to host: '74.234.89.204', port: 22, elevation to root: 'yes', autoSudo: no, use su if sudo fails: no, host name: , IPs: [74.234.89.204], AuthenticationData: [UserName: ubuntu, AuthTypes: [KeyboardInteractive, Password]]. A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond
[17.07.2023 09:14:44.386] <27> Error        Failed to connect by SSH. RetryCount: '2'. MaxRetryCount: '100'.
[17.07.2023 09:14:44.386] <27> Error        A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond (Veeam.Backup.Common.SSHException)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.ReceivePacket()
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.SSHCV2.KeyExchanger.SynchronousKexExchange()
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.SSHCV2.SSH2Connection.Connect(AbstractSocket s)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.SSHC.SSHConnection.ConnectMain(SSHConnectionParameter param, ISSHConnectionEventReceiver receiver, ProtocolNegotiationHandler pnh, AbstractSocket s)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.CSshGranadosConnectionImpl.Connect()
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnectionImpl(CSshConnectionSpec connSpec)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.CSshConnection.CreateConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.CSshConnection.InternalCreateNotCachedConnection(CSshConnectionSpec connSpec)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.SSH.CSshConnection..ctor(CSshConnectionSpec spec, ISshConfig sshCore, Boolean useCache, LogLevels logLevel)
[17.07.2023 09:14:44.386] <27> Error           at Veeam.Backup.Core.CApplianceSshConnection.ConnectSshWithRetry(CSshConnectionSpec spec, Int32 retryCount, Boolean useCache, Action cancelCheckActionCanBeNull)
I was asked by Support to change the appliance to increase RAM but it didn't fix the problem.

Can anybody help?

Thanks,
AZ
veremin
Product Manager
Posts: 20337
Liked: 2278 times
Joined: Oct 26, 2012 3:28 pm
Full Name: Vladimir Eremin
Contact:

Re: Case # 06144598 - Move to Archive Tier is failing

Post by veremin »

It's better to continue the investigation within the existing support ticket. Let the engineer know that the proposal hasn't solved the issue and request a case escalation (via the "Talk to manager" button), if you're unsatisfied with the level of support provided. Thanks!
Post Reply

Who is online

Users browsing this forum: No registered users and 20 guests