FAQ
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:direct.SessionChannel@120] Will request
     to exec `scp -t -r '/tmp/scm_prepare_node.NDdw0yjZ'`


Thanks for your help !

Here is the revelant serverlog :

2014-04-17 18:49:00,130 INFO
[103409417@scm-web-4:node.NodeScannerService@287] Request 1 contains 1 nodes
2014-04-17 18:49:00,131 INFO
[103409417@scm-web-4:node.NodeScannerService@383] Existing scan of node
test-master02 is too old, rescanning
2014-04-17 18:49:00,131 INFO
[103409417@scm-web-4:node.NodeScannerService@291] Finished submitting
request 1
2014-04-17 18:49:00,132 INFO [NodeScannerThread-1:node.NodeScanner@219]
Beginning scan of node test-master02 and port 22
2014-04-17 18:49:00,132 INFO [NodeScannerThread-1:node.NodeScanner@243]
Canonical hostname is test-master02
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:node.NodeScanner@246]
Address is 10.90.66.67
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:node.NodeScanner@256]
Connecting to remote host
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:node.NodeScanner@277]
Disconnecting from remote host
2014-04-17 18:49:00,133 INFO [NodeScannerThread-1:node.NodeScanner@293]
Connecting to ssh service on remote host
2014-04-17 18:49:00,134 INFO
[NodeScannerThread-1:transport.TransportImpl@152] Client identity
string: SSH-2.0-SSHJ_0_8
2014-04-17 18:49:00,140 INFO
[NodeScannerThread-1:transport.TransportImpl@161] Server identity
string: SSH-2.0-OpenSSH_6.0p1 Debian-4+deb7u1
2014-04-17 18:49:00,140 INFO
[NodeScannerThread-1:transport.KeyExchanger@195] Sending SSH_MSG_KEXINIT
2014-04-17 18:49:00,140 INFO [reader:transport.KeyExchanger@357]
Received SSH_MSG_KEXINIT
2014-04-17 18:49:00,169 INFO [reader:kex.DHG14@110] Sending
SSH_MSG_KEXDH_INIT
2014-04-17 18:49:00,187 INFO [reader:transport.KeyExchanger@370]
Received kex followup data
2014-04-17 18:49:00,187 INFO [reader:kex.DHG14@120] Received
SSH_MSG_KEXDH_REPLY
2014-04-17 18:49:00,221 INFO [reader:transport.KeyExchanger@203]
Sending SSH_MSG_NEWKEYS
2014-04-17 18:49:00,221 INFO [reader:transport.KeyExchanger@385]
Received SSH_MSG_NEWKEYS
2014-04-17 18:49:00,221 INFO
[NodeScannerThread-1:node.CmfSSHClient@686] Key exchange took 0.081 seconds
2014-04-17 18:49:00,222 INFO [NodeScannerThread-1:node.NodeScanner@315]
Disconnecting from ssh service on remote host
2014-04-17 18:49:00,222 INFO [NodeScannerThread-1:node.NodeScanner@208]
Connected to SSH on node test-master02 with port 22 (latency PT0S)
2014-04-17 18:49:00,222 INFO
[NodeScannerThread-1:node.NodeScannerService@175] Request 1 observed
finished scan of node test-master02
2014-04-17 18:49:00,279 INFO
[103409417@scm-web-4:node.NodeScannerService@124] Request 1 returning
1/1 scans
2014-04-17 18:49:10,495 INFO
[103409417@scm-web-4:node.NodeConfiguratorService@294] Creating request
with id 1
2014-04-17 18:49:10,495 INFO
[103409417@scm-web-4:node.NodeConfiguratorService@193] Adding
password-based configurator for test-master02
2014-04-17 18:49:10,496 INFO
[103409417@scm-web-4:node.NodeConfiguratorService@230] Submitted
configurator for test-master02 with id 0
2014-04-17 18:49:10,496 INFO
[NodeConfiguratorThread-1-0:node.NodeConfiguratorProgress@533]
test-master02: Transitioning from INIT (PT0.001S) to CONNECT
2014-04-17 18:49:10,497 INFO
[NodeConfiguratorThread-1-0:transport.TransportImpl@152] Client identity
string: SSH-2.0-SSHJ_0_8
2014-04-17 18:49:10,503 INFO
[NodeConfiguratorThread-1-0:transport.TransportImpl@161] Server identity
string: SSH-2.0-OpenSSH_6.0p1 Debian-4+deb7u1
2014-04-17 18:49:10,504 INFO
[NodeConfiguratorThread-1-0:transport.KeyExchanger@195] Sending
SSH_MSG_KEXINIT
2014-04-17 18:49:10,504 INFO [reader:transport.KeyExchanger@357]
Received SSH_MSG_KEXINIT
2014-04-17 18:49:10,533 INFO [reader:kex.DHG14@110] Sending
SSH_MSG_KEXDH_INIT
2014-04-17 18:49:10,546 INFO [reader:transport.KeyExchanger@370]
Received kex followup data
2014-04-17 18:49:10,546 INFO [reader:kex.DHG14@120] Received
SSH_MSG_KEXDH_REPLY
2014-04-17 18:49:10,579 INFO [reader:transport.KeyExchanger@203]
Sending SSH_MSG_NEWKEYS
2014-04-17 18:49:10,579 INFO [reader:transport.KeyExchanger@385]
Received SSH_MSG_NEWKEYS
2014-04-17 18:49:10,579 INFO
[NodeConfiguratorThread-1-0:node.CmfSSHClient@686] Key exchange took
0.075 seconds
2014-04-17 18:49:10,579 INFO
[NodeConfiguratorThread-1-0:node.NodeConfiguratorProgress@533]
test-master02: Transitioning from CONNECT (PT0.083S) to AUTHENTICATE
2014-04-17 18:49:10,615 INFO
[NodeConfiguratorThread-1-0:transport.TransportImpl@302] Setting active
service to ssh-userauth
2014-04-17 18:49:10,616 INFO
[NodeConfiguratorThread-1-0:userauth.UserAuthImpl@85] Trying `password`
auth...
2014-04-17 18:49:10,616 INFO
[NodeConfiguratorThread-1-0:method.AuthPassword@40] Requesting password
for [AccountResource] root@test-master02
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:userauth.UserAuthImpl@102] `password` auth
successful
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:transport.TransportImpl@302] Setting active
service to ssh-connection
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:node.NodeConfiguratorProgress@533]
test-master02: Transitioning from AUTHENTICATE (PT0.054S) to MAKE_TEMP_DIR
2014-04-17 18:49:10,633 INFO
[NodeConfiguratorThread-1-0:connection.ConnectionImpl@68] Attaching
`session` channel (#0)
2014-04-17 18:49:10,634 INFO [reader:direct.SessionChannel@125]
Initialized - < session channel: id=0, recipient=0,
localWin=[winSize=2097152], remoteWin=[winSize=0] >
2014-04-17 18:49:10,634 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@372] Sending channel
request for `pty-req`
2014-04-17 18:49:10,635 INFO
[NodeConfiguratorThread-1-0:node.NodeConfigurator@602] Executing mktemp
-d /tmp/scm_prepare_node.XXXXXXXX on test-master02
2014-04-17 18:49:10,635 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@120] Will request to
exec `mktemp -d /tmp/scm_prepare_node.XXXXXXXX`
2014-04-17 18:49:10,636 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@372] Sending channel
request for `exec`
2014-04-17 18:49:10,637 INFO [reader:direct.SessionChannel@326]
Received window adjustment for 2097152 bytes
2014-04-17 18:49:10,641 INFO [reader:direct.SessionChannel@314] Got
chan request for `exit-status`
2014-04-17 18:49:10,641 INFO [reader:direct.SessionChannel@408] Got EOF
2014-04-17 18:49:10,641 INFO [reader:direct.SessionChannel@223] Got close
2014-04-17 18:49:10,641 INFO [reader:direct.SessionChannel@425] Sending EOF
2014-04-17 18:49:10,642 INFO [reader:direct.SessionChannel@287] Sending
close
2014-04-17 18:49:10,642 INFO [reader:connection.ConnectionImpl@84]
Forgetting `session` channel (#0)
2014-04-17 18:49:10,642 INFO
[NodeConfiguratorThread-1-0:node.NodeConfiguratorProgress@533]
test-master02: Transitioning from MAKE_TEMP_DIR (PT0.009S) to COPY_FILES
2014-04-17 18:49:10,642 INFO
[NodeConfiguratorThread-1-0:connection.ConnectionImpl@68] Attaching
`session` channel (#1)
2014-04-17 18:49:10,680 INFO [reader:direct.SessionChannel@125]
Initialized - < session channel: id=1, recipient=1,
localWin=[winSize=2097152], remoteWin=[winSize=0] >
2014-04-17 18:49:10,680 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@120] Will request to
exec `scp -t -r '/tmp/scm_prepare_node.NDdw0yjZ'`
2014-04-17 18:49:10,680 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@372] Sending channel
request for `exec`
2014-04-17 18:49:10,681 INFO [reader:direct.SessionChannel@326]
Received window adjustment for 2097152 bytes
2014-04-17 18:49:10,684 INFO
[NodeConfiguratorThread-1-0:direct.SessionChannel@287] Sending close
2014-04-17 18:49:10,685 INFO [reader:direct.SessionChannel@314] Got
chan request for `exit-signal`
2014-04-17 18:49:10,685 INFO [reader:direct.SessionChannel@223] Got close
2014-04-17 18:49:10,685 INFO [reader:connection.ConnectionImpl@84]
Forgetting `session` channel (#1)
2014-04-17 18:49:10,686 WARN
[NodeConfiguratorThread-1-0:scp.SCPEngine@126] SCP exit signal: PIPE
2014-04-17 18:49:10,686 WARN
[NodeConfiguratorThread-1-0:node.NodeConfigurator@443] 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:node.NodeConfiguratorProgress@554]
test-master02: Setting COPY_FILES as failed and done state

Search Discussions

Related Discussions

Discussion Navigation
viewthread | post
Discussion Overview
groupscm-users @
categorieshadoop
postedApr 17, '14 at 5:06p
activeApr 17, '14 at 5:06p
posts1
users1
websitecloudera.com
irc#hadoop

1 user in discussion

Maxime Lemaire: 1 post

People

Translate

site design / logo © 2022 Grokbase