Hi,
Im trying to add host to a fresh cluster install (made with
cloudera-manager-installer) on debian wheezy 7.4.
Network is up, ssh auth ok.
However, the wizard failed to remotly copy the "scm_prepare_node" script.
The tmp filename looks quite strange (containing \[0m escape sequence) :
2014-04-17 18:49:10,680 INFO
[NodeConfiguratorThread-1-0:[email protected]] Will request
to exec `scp -t -r '[0m/tmp/scm_prepare_node.NDdw0yjZ'`
Thanks for your help !
Here is the revelant serverlog :
2014-04-17 18:49:00,130 INFO
[[email protected]:[email protected]] Request 1 contains 1 nodes
2014-04-17 18:49:00,131 INFO
[103409[email protected]:[email protected]] Existing scan of node
test-master02 is too old, rescanning
2014-04-17 18:49:00,131 INFO
[1034[email protected]:[email protected]] Finished submitting
request 1
2014-04-17 18:49:00,132 INFO [NodeScannerThread-1:[email protected]]
Beginning scan of node test-master02 and port 22
2014-04-17 18:49:00,132 INFO [NodeScannerThread-1:[email protected]]
Canonical hostname is test-master02
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:[email protected]]
Address is 10.90.66.67
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:[email protected]]
Connecting to remote host
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:[email protected]]
Disconnecting from remote host
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:[email protected]]
Connecting to ssh service on remote host
2014-04-17 18:49:00,134 INFO
[NodeScannerThread-1:[email protected]] Client identity
string: SSH-2.0-SSHJ_0_8
2014-04-17 18:49:00,140 INFO
[NodeScannerThread-1:[email protected]] Server identity
string: SSH-2.0-OpenSSH_6.0p1 Debian-4+deb7u1
2014-04-17 18:49:00,140 INFO
[NodeScannerThread-1:[email protected]] Sending SSH_MSG_KEXINIT
2014-04-17 18:49:00,140 INFO [reader:[email protected]]
Received SSH_MSG_KEXINIT
2014-04-17 18:49:00,169 INFO [reader:[email protected]] Sending
SSH_MSG_KEXDH_INIT
2014-04-17 18:49:00,187 INFO [reader:[email protected]]
Received kex followup data
2014-04-17 18:49:00,187 INFO [reader:[email protected]] Received
SSH_MSG_KEXDH_REPLY
2014-04-17 18:49:00,221 INFO [reader:[email protected]]
Sending SSH_MSG_NEWKEYS
2014-04-17 18:49:00,221 INFO [reader:[email protected]]
Received SSH_MSG_NEWKEYS
2014-04-17 18:49:00,221 INFO
[NodeScannerThread-1:[email protected]] Key exchange took 0.081 seconds
2014-04-17 18:49:00,222 INFO [NodeScannerThread-1:[email protected]]
Disconnecting from ssh service on remote host
2014-04-17 18:49:00,222 INFO [NodeScannerThread-1:[email protected]]
Connected to SSH on node test-master02 with port 22 (latency PT0S)
2014-04-17 18:49:00,222 INFO
[NodeScannerThread-1:[email protected]] Request 1 observed
finished scan of node test-master02
2014-04-17 18:49:00,279 INFO
[1034[email protected]:[email protected]] Request 1 returning
1/1 scans
2014-04-17 18:49:10,495 INFO
[103409[email protected]:[email protected]] Creating request
with id 1
2014-04-17 18:49:10,495 INFO
[[email protected]:[email protected]] Adding
password-based configurator for test-master02
2014-04-17 18:49:10,496 INFO
[[email protected]:[email protected]] Submitted
configurator for test-master02 with id 0
2014-04-17 18:49:10,496 INFO
[NodeConfiguratorThread-1-0:[email protected]]
test-master02: Transitioning from INIT (PT0.001S) to CONNECT
2014-04-17 18:49:10,497 INFO
[NodeConfiguratorThread-1-0:[email protected]] Client identity
string: SSH-2.0-SSHJ_0_8
2014-04-17 18:49:10,503 INFO
[NodeConfiguratorThread-1-0:[email protected]] Server identity
string: SSH-2.0-OpenSSH_6.0p1 Debian-4+deb7u1
2014-04-17 18:49:10,504 INFO
[NodeConfiguratorThread-1-0:[email protected]] Sending
SSH_MSG_KEXINIT
2014-04-17 18:49:10,504 INFO [reader:[email protected]]
Received SSH_MSG_KEXINIT
2014-04-17 18:49:10,533 INFO [reader:[email protected]] Sending
SSH_MSG_KEXDH_INIT
2014-04-17 18:49:10,546 INFO [reader:[email protected]]
Received kex followup data
2014-04-17 18:49:10,546 INFO [reader:[email protected]] Received
SSH_MSG_KEXDH_REPLY
2014-04-17 18:49:10,579 INFO [reader:[email protected]]
Sending SSH_MSG_NEWKEYS
2014-04-17 18:49:10,579 INFO [reader:[email protected]]
Received SSH_MSG_NEWKEYS
2014-04-17 18:49:10,579 INFO
[NodeConfiguratorThread-1-0:[email protected]] Key exchange took
0.075 seconds
2014-04-17 18:49:10,579 INFO
[NodeConfiguratorThread-1-0:[email protected]]
test-master02: Transitioning from CONNECT (PT0.083S) to AUTHENTICATE
2014-04-17 18:49:10,615 INFO
[NodeConfiguratorThread-1-0:[email protected]] Setting active
service to ssh-userauth
2014-04-17 18:49:10,616 INFO
[NodeConfiguratorThread-1-0:[email protected]] Trying `password`
auth...
2014-04-17 18:49:10,616 INFO
[NodeConfiguratorThread-1-0:[email protected]] Requesting password
for [AccountResource] [email protected]
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:[email protected]] `password` auth
successful
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:[email protected]] Setting active
service to ssh-connection
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:[email protected]]
test-master02: Transitioning from AUTHENTICATE (PT0.054S) to MAKE_TEMP_DIR
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:[email protected]] Attaching
`session` channel (#0)
2014-04-17 18:49:10,634 INFO [reader:[email protected]]
Initialized - < session channel: id=0, recipient=0,
localWin=[winSize=2097152], remoteWin=[winSize=0] >
2014-04-17 18:49:10,634 INFO
[NodeConfiguratorThread-1-0:[email protected]] Sending channel
request for `pty-req`
2014-04-17 18:49:10,635 INFO
[NodeConfiguratorThread-1-0:[email protected]] Executing mktemp
-d /tmp/scm_prepare_node.XXXXXXXX on test-master02
2014-04-17 18:49:10,635 INFO
[NodeConfiguratorThread-1-0:[email protected]] Will request to
exec `mktemp -d /tmp/scm_prepare_node.XXXXXXXX`
2014-04-17 18:49:10,636 INFO
[NodeConfiguratorThread-1-0:[email protected]] Sending channel
request for `exec`
2014-04-17 18:49:10,637 INFO [reader:[email protected]]
Received window adjustment for 2097152 bytes
2014-04-17 18:49:10,641 INFO [reader:[email protected]] Got
chan request for `exit-status`
2014-04-17 18:49:10,641 INFO [reader:[email protected]] Got EOF
2014-04-17 18:49:10,641 INFO [reader:[email protected]] Got close
2014-04-17 18:49:10,641 INFO [reader:[email protected]] Sending EOF
2014-04-17 18:49:10,642 INFO [reader:[email protected]] Sending
close
2014-04-17 18:49:10,642 INFO [reader:[email protected]]
Forgetting `session` channel (#0)
2014-04-17 18:49:10,642 INFO
[NodeConfiguratorThread-1-0:[email protected]]
test-master02: Transitioning from MAKE_TEMP_DIR (PT0.009S) to COPY_FILES
2014-04-17 18:49:10,642 INFO
[NodeConfiguratorThread-1-0:[email protected]] Attaching
`session` channel (#1)
2014-04-17 18:49:10,680 INFO [reader:[email protected]]
Initialized - < session channel: id=1, recipient=1,
localWin=[winSize=2097152], remoteWin=[winSize=0] >
2014-04-17 18:49:10,680 INFO
[NodeConfiguratorThread-1-0:[email protected]] Will request to
exec `scp -t -r '[0m/tmp/scm_prepare_node.NDdw0yjZ'`
2014-04-17 18:49:10,680 INFO
[NodeConfiguratorThread-1-0:[email protected]] Sending channel
request for `exec`
2014-04-17 18:49:10,681 INFO [reader:[email protected]]
Received window adjustment for 2097152 bytes
2014-04-17 18:49:10,684 INFO
[NodeConfiguratorThread-1-0:[email protected]] Sending close
2014-04-17 18:49:10,685 INFO [reader:[email protected]] Got
chan request for `exit-signal`
2014-04-17 18:49:10,685 INFO [reader:[email protected]] Got close
2014-04-17 18:49:10,685 INFO [reader:[email protected]]
Forgetting `session` channel (#1)
2014-04-17 18:49:10,686 WARN
[NodeConfiguratorThread-1-0:[email protected]] SCP exit signal: PIPE
2014-04-17 18:49:10,686 WARN
[NodeConfiguratorThread-1-0:[email protected]] Could not copy
scm_prepare_node.sh to test-master02
net.schmizz.sshj.xfer.scp.SCPException: Received unknown response code
at net.schmizz.sshj.xfer.scp.SCPEngine.check(SCPEngine.java:92)
at
net.schmizz.sshj.xfer.scp.SCPUploadClient.startCopy(SCPUploadClient.java:64)
at
net.schmizz.sshj.xfer.scp.SCPUploadClient.copy(SCPUploadClient.java:45)
at
net.schmizz.sshj.xfer.scp.SCPFileTransfer.upload(SCPFileTransfer.java:70)
at
com.cloudera.server.cmf.node.NodeConfigurator.copy(NodeConfigurator.java:440)
at
com.cloudera.server.cmf.node.NodeConfigurator.copy(NodeConfigurator.java:459)
at
com.cloudera.server.cmf.node.NodeConfigurator.copy(NodeConfigurator.java:469)
at
com.cloudera.server.cmf.node.NodeConfigurator.copyFiles(NodeConfigurator.java:478)
at
com.cloudera.server.cmf.node.NodeConfigurator.configure(NodeConfigurator.java:795)
at
com.cloudera.server.cmf.node.NodeConfigurator.run(NodeConfigurator.java:833)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
2014-04-17 18:49:10,686 INFO
[NodeConfiguratorThread-1-0:[email protected]]
test-master02: Setting COPY_FILES as failed and done state
