Procurve backup failed - Oxidized 0.28.0

Hi,

I upgraded Oxidized version to 0.28.0 (last commit), and now I can't to backup old HP Procurve switchs (5406zl J8697A).

Oxidized logs:


D, [2022-11-24T10:38:54.750195 #63473] DEBUG -- : lib/oxidized/worker.rb: Jobs running: 1 of 2 - ended: 5 of 439
D, [2022-11-24T10:38:54.750282 #63473] DEBUG -- : lib/oxidized/worker.rb: 1 jobs running in parallel
D, [2022-11-24T10:38:54.750396 #63473] DEBUG -- : lib/oxidized/job.rb: Starting fetching process for my_procurve_switch at 2022-11-24 09:38:54 UTC
D, [2022-11-24T10:38:54.750767 #63473] DEBUG -- : lib/oxidized/input/ssh.rb: Connecting to my_procurve_switch
D, [2022-11-24T10:38:54.750970 #63473] DEBUG -- : AUTH METHODS::["none", "publickey", "password", "keyboard-interactive"]
D, [2022-11-24T10:38:54.751755 #63473] DEBUG -- net.ssh.transport.session[3ffd802c4e40]: establishing connection to X.X.X.X:22
D, [2022-11-24T10:38:54.754029 #63473] DEBUG -- net.ssh.transport.session[3ffd802c4e40]: connection established
I, [2022-11-24T10:38:54.754159 #63473]  INFO -- net.ssh.transport.server_version[3ffd802c46fc]: negotiating protocol version
D, [2022-11-24T10:38:54.754250 #63473] DEBUG -- net.ssh.transport.server_version[3ffd802c46fc]: local is `SSH-2.0-Ruby/Net::SSH_7.0.1 x86_64-linux'
D, [2022-11-24T10:38:54.756236 #63473] DEBUG -- net.ssh.transport.server_version[3ffd802c46fc]: remote is `SSH-2.0-Mocana SSH 5.8'
I, [2022-11-24T10:38:54.756710 #63473]  INFO -- net.ssh.transport.algorithms[3ffd802c7898]: sending KEXINIT
D, [2022-11-24T10:38:54.756956 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 0 type 20 len 1436
D, [2022-11-24T10:38:54.757069 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 1440 bytes
D, [2022-11-24T10:38:54.757636 #63473] DEBUG -- socket[3ffd802c4bd4]: read 432 bytes
D, [2022-11-24T10:38:54.757770 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 0 type 20 len 428
I, [2022-11-24T10:38:54.757868 #63473]  INFO -- net.ssh.transport.algorithms[3ffd802c7898]: got KEXINIT from server
I, [2022-11-24T10:38:54.757997 #63473]  INFO -- net.ssh.transport.algorithms[3ffd802c7898]: negotiating algorithms
D, [2022-11-24T10:38:54.758139 #63473] DEBUG -- net.ssh.transport.algorithms[3ffd802c7898]: negotiated:

kex: diffie-hellman-group14-sha1
host_key: ssh-rsa
encryption_server: aes256-ctr
encryption_client: aes256-ctr
hmac_client: hmac-sha1
hmac_server: hmac-sha1
compression_client: none
compression_server: none
language_client:
language_server: D, [2022-11-24T10:38:54.758227 #63473] DEBUG -- net.ssh.transport.algorithms[3ffd802c7898]: exchanging keys D, [2022-11-24T10:38:54.762768 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 1 type 30 len 268 D, [2022-11-24T10:38:54.762878 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 272 bytes D, [2022-11-24T10:38:55.297788 #63473] DEBUG -- socket[3ffd802c4bd4]: read 832 bytes D, [2022-11-24T10:38:55.297990 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 1 type 31 len 828 D, [2022-11-24T10:38:55.302795 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 2 type 21 len 20 D, [2022-11-24T10:38:55.302890 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 24 bytes D, [2022-11-24T10:38:55.302984 #63473] DEBUG -- socket[3ffd802c4bd4]: read 16 bytes D, [2022-11-24T10:38:55.303064 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 2 type 21 len 12 D, [2022-11-24T10:38:55.303419 #63473] DEBUG -- net.ssh.authentication.session[3ffd802ceb70]: beginning authentication of `admin' D, [2022-11-24T10:38:55.303559 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 3 type 5 len 28 D, [2022-11-24T10:38:55.303626 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 52 bytes D, [2022-11-24T10:38:55.504985 #63473] DEBUG -- socket[3ffd802c4bd4]: read 52 bytes D, [2022-11-24T10:38:55.505149 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 3 type 6 len 28 D, [2022-11-24T10:38:55.505321 #63473] DEBUG -- net.ssh.authentication.session[3ffd802ceb70]: trying none D, [2022-11-24T10:38:55.505505 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 4 type 50 len 44 D, [2022-11-24T10:38:55.505590 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 68 bytes D, [2022-11-24T10:38:55.507551 #63473] DEBUG -- socket[3ffd802c4bd4]: read 244 bytes D, [2022-11-24T10:38:55.507729 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 4 type 53 len 220 I, [2022-11-24T10:38:55.507848 #63473] INFO -- net.ssh.authentication.session[3ffd802ceb70]: We'd like to keep you up to date about:
- Software feature updates
- New product announcements
- Special events Please register your products now at: www.hp.com/networking/register

D, [2022-11-24T10:38:55.552727 #63473] DEBUG -- socket[3ffd802c4bd4]: read 52 bytes D, [2022-11-24T10:38:55.552891 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 5 type 51 len 28 D, [2022-11-24T10:38:55.553020 #63473] DEBUG -- net.ssh.authentication.session[3ffd802ceb70]: allowed methods: password D, [2022-11-24T10:38:55.553138 #63473] DEBUG -- net.ssh.authentication.methods.none[3ffd802d10dc]: none failed D, [2022-11-24T10:38:55.553249 #63473] DEBUG -- net.ssh.authentication.session[3ffd802ceb70]: trying password D, [2022-11-24T10:38:55.553462 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 5 type 50 len 60 D, [2022-11-24T10:38:55.553575 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 84 bytes D, [2022-11-24T10:38:55.563354 #63473] DEBUG -- socket[3ffd802c4bd4]: read 36 bytes D, [2022-11-24T10:38:55.563489 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 6 type 52 len 12 D, [2022-11-24T10:38:55.563615 #63473] DEBUG -- net.ssh.authentication.methods.password[3ffd802d3198]: password succeeded D, [2022-11-24T10:38:55.563820 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 6 type 90 len 44 D, [2022-11-24T10:38:55.563930 #63473] DEBUG -- : lib/oxidized/input/ssh.rb: expecting [/(^\r|\e[24;[0-9][hH])?([\w\s.-]+[#>] )($|(\e[24;[0-9][0-9]?[hH]){3})/] at my_procurve_switch D, [2022-11-24T10:38:55.751459 #63473] DEBUG -- : lib/oxidized/worker.rb: Jobs running: 1 of 2 - ended: 5 of 439 D, [2022-11-24T10:38:55.751627 #63473] DEBUG -- : lib/oxidized/worker.rb: 1 jobs running in parallel D, [2022-11-24T10:38:55.764548 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 68 bytes D, [2022-11-24T10:38:55.864916 #63473] DEBUG -- socket[3ffd802c4bd4]: read 52 bytes D, [2022-11-24T10:38:55.865218 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 7 type 91 len 28 I, [2022-11-24T10:38:55.865392 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_open_confirmation: 0 85460946 32768 32768 I, [2022-11-24T10:38:55.865566 #63473] INFO -- net.ssh.connection.channel[3ffd802d5a24]: sending channel request "env" D, [2022-11-24T10:38:55.865775 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 7 type 98 len 44 I, [2022-11-24T10:38:55.865930 #63473] INFO -- net.ssh.connection.channel[3ffd802d5a24]: sending channel request "pty-req" D, [2022-11-24T10:38:55.866114 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 8 type 98 len 60 D, [2022-11-24T10:38:55.966482 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 152 bytes D, [2022-11-24T10:38:56.066893 #63473] DEBUG -- socket[3ffd802c4bd4]: read 36 bytes D, [2022-11-24T10:38:56.067234 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 8 type 99 len 12 I, [2022-11-24T10:38:56.067370 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_success: 0 I, [2022-11-24T10:38:56.067467 #63473] INFO -- net.ssh.connection.channel[3ffd802d5a24]: sending channel request "shell" D, [2022-11-24T10:38:56.067659 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 9 type 98 len 28 D, [2022-11-24T10:38:56.168084 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 52 bytes D, [2022-11-24T10:38:56.268531 #63473] DEBUG -- socket[3ffd802c4bd4]: read 36 bytes D, [2022-11-24T10:38:56.268820 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 9 type 99 len 12 I, [2022-11-24T10:38:56.268941 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_success: 0 I, [2022-11-24T10:38:56.469522 #63473] INFO -- net.ssh.connection.keepalive[3ffd802d5a88]: sending keepalive 0 I, [2022-11-24T10:38:56.469741 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: sending global request keepalive@openssh.com D, [2022-11-24T10:38:56.470025 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 10 type 80 len 44 D, [2022-11-24T10:38:56.670470 #63473] DEBUG -- socket[3ffd802c4bd4]: read 692 bytes D, [2022-11-24T10:38:56.670615 #63473] DEBUG -- socket[3ffd802c4bd4]: sent 68 bytes D, [2022-11-24T10:38:56.752798 #63473] DEBUG -- : lib/oxidized/worker.rb: Jobs running: 1 of 2 - ended: 5 of 439 D, [2022-11-24T10:38:56.752888 #63473] DEBUG -- : lib/oxidized/worker.rb: 1 jobs running in parallel D, [2022-11-24T10:38:56.770968 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 10 type 94 len 668 I, [2022-11-24T10:38:56.771134 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_data: 0 645b D, [2022-11-24T10:38:57.172330 #63473] DEBUG -- socket[3ffd802c4bd4]: read 140 bytes D, [2022-11-24T10:38:57.272849 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 11 type 96 len 12 I, [2022-11-24T10:38:57.273054 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_eof: 0 D, [2022-11-24T10:38:57.273192 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 12 type 98 len 44 I, [2022-11-24T10:38:57.273308 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_request: 0 exit-status false D, [2022-11-24T10:38:57.273539 #63473] DEBUG -- socket[3ffd802c4bd4]: received packet nr 13 type 97 len 12 I, [2022-11-24T10:38:57.273643 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: channel_close: 0 D, [2022-11-24T10:38:57.273785 #63473] DEBUG -- socket[3ffd802c4bd4]: read 0 bytes D, [2022-11-24T10:38:57.273989 #63473] DEBUG -- socket[3ffd802c4bd4]: queueing packet nr 11 type 97 len 28 I, [2022-11-24T10:38:57.274082 #63473] INFO -- net.ssh.connection.session[3ffd802d5b3c]: X.X.X.X delete channel 0 which closed locally and remotely D, [2022-11-24T10:38:57.374320 #63473] DEBUG -- socket[3ffd802c4bd4]: read 0 bytes W, [2022-11-24T10:38:57.374665 #63473] WARN -- : X.X.X.X raised IOError with msg "closed stream" D, [2022-11-24T10:38:57.374758 #63473] DEBUG -- : lib/oxidized/node.rb: Oxidized::SSH failed for my_procurve_switch D, [2022-11-24T10:38:57.374871 #63473] DEBUG -- : lib/oxidized/job.rb: Config fetched for my_procurve_switch at 2022-11-24 09:38:57 UTC W, [2022-11-24T10:38:57.754227 #63473] WARN -- : Switch/my_procurve_switch status no_connection, retries exhausted, giving up


- _**Oxidized switch logs:**_
````HP J8697A Switch 5406zl

Software revision K.15.16.0005

Copyright (C) 1991-2014 Hewlett-Packard Development Company, L.P.

                   RESTRICTED RIGHTS LEGEND
 Confidential computer software.  Valid license from HP required for possession,
 use or copying. Consistent with FAR 12.211 and 12.212, Commercial Computer
 Software, Computer Software Documentation, and Technical Data for Commercial
 Items are licensed to the U.S. Government under vendor's standard commercial
 license.
                   HEWLETT-PACKARD DEVELOPMENT COMPANY, L.P.
                   20555 State Highway 249, Houston, TX 77070

^[[1;15r^[[1;1H

procurve.rb file:

# previous command is repeated followed by "\eE", which sometimes ends up on last line
# ssh switches prompt may start with \r, followed by the prompt itself, regex ([\w\s.-]+[#>] ), which ends the line
# telnet switches may start with various vt100 control characters, regex (\e\[24;[0-9][hH]), followed by the prompt, followed
# by at least 3 other vt100 characters
prompt /(^\r|\e\[24;[0-9][hH])?([\w\s.-]+(\((config|vlan-[0-9]{1,4}|y\/n)\)|\(o\)nce)?[#>:?\]] {1,2})($|(\e\[24;[0-9][0-9]?[hH]){3})/

comment '! '

# replace next line control sequence with a new line
expect /(\e\[1M\e\[\??\d+(;\d+)*[A-Za-z]\e\[1L)|(\eE)/ do |data, re|
data.gsub re, "\n"
end

# replace all used vt100 control sequences
expect /\e\[\??\d+(;\d+)*[A-Za-z]/ do |data, re|
data.gsub re, ''
end

expect /Press any key to continue(\e\[\??\d+(;\d+)*[A-Za-z])*$/ do
send ' '
""
end

expect /Enter switch number/ do
send "\n"
""
end

cmd :all do |cfg|
cfg = cfg.cut_both
cfg = cfg.gsub /^\r/, ''
# Additional filtering for elder switches sending vt100 control chars via telnet
cfg.gsub! /\e\[\??\d+(;\d+)*[A-Za-z]/, ''
# Additional filtering for power usage reporting which obviously changes over time
cfg.gsub! /^(.*AC [0-9]{3}V\/?([0-9]{3}V)?) *([0-9]{1,3}) (.*)/, '\\1 <removed> \\4'
cfg
end

cmd :secret do |cfg|
cfg.gsub! /^(snmp-server community) \S+(.*)/, '\\1 <secret hidden> \\2'
cfg.gsub! /^(snmp-server host \S+) \S+(.*)/, '\\1 <secret hidden> \\2'
cfg.gsub! /^(radius-server host \S+ key) \S+(.*)/, '\\1 <secret hidden> \\2'
cfg.gsub! /^(radius-server key).*/, '\\1 <configuration removed>'
cfg.gsub! /^(tacacs-server host \S+ key) \S+(.*)/, '\\1 <secret hidden> \\2'
cfg.gsub! /^(tacacs-server key).*/, '\\1 <secret hidden>'
cfg
end

cmd 'show version' do |cfg|
comment cfg
end

cmd 'show modules' do |cfg|
comment cfg
end

cmd 'show interfaces transceiver' do |cfg|
comment cfg
end

cmd 'show flash' do |cfg|
comment cfg
end

# not supported on all models
cmd 'show system-information' do |cfg|
cfg = cfg.split("\n")[0..-8].join("\n")
comment cfg
end

# not supported on all models
cmd 'show system information' do |cfg|
cfg = cfg.each_line.reject { |line| line.match /(.*CPU.*)|(.*Up Time.*)|(.*Total.*)|(.*Free.*)|(.*Lowest.*)|(.*Missed.*)/ }
cfg = cfg.join
comment cfg
end

cmd 'show running-config'

cfg :telnet do
username /Username:/
password /Password:/
end

cfg :telnet, :ssh do
# preferred way to handle additional passwords
if vars :enable
  post_login do
    send "enable\n"
    cmd vars(:enable)
  end
end
post_login 'no page'
pre_logout "logout\ny\nn"
end

cfg :ssh do
pty_options(chars_wide: 1000)
end
end

SSH works:


We'd like to keep you up to date about:
* Software feature updates
* New product announcements
* Special events
Please register your products now at:  www.hp.com/networking/register

admin@my_procurve_switch's password: HP J8697A Switch 5406zl Software revision K.15.16.0005

               RESTRICTED RIGHTS LEGEND

Confidential computer software. Valid license from HP required for possession, use or copying. Consistent with FAR 12.211 and 12.212, Commercial Computer Software, Computer Software Documentation, and Technical Data for Commercial Items are licensed to the U.S. Government under vendor's standard commercial license. HEWLETT-PACKARD DEVELOPMENT COMPANY, L.P. 20555 State Highway 249, Houston, TX 77070

Press any key to continue



Any idea?
Thanks for your help.

Best regards

ytti / oxidized

Procurve backup failed - Oxidized 0.28.0 #2665