Timeout attempting to connect socket

Discussion of the Co:Z Co-Processing Toolkit for z/OS
Post Reply
Joe@SF
Posts: 2
Joined: Thu Apr 20, 2017 9:57 am

Timeout attempting to connect socket

Post by Joe@SF » Wed Jan 17, 2018 4:32 pm

Trying to get a BP set up with Co:Z Launcher. I can see that the second connection opens up but when it tries to connect to the socket to send the commands to the remote I get a "Timeout attempting to connect socket" error.

debug2: fd 4 setting O_NONBLOCK
debug2: fd 5 setting O_NONBLOCK
debug2: fd 6 setting O_NONBLOCK
debug1: channel 0: new Ýclient-session¨
debug3: ssh_session2_open: channel_new: 0
debug2: channel 0: send open
debug1: Entering interactive session.
debug2: callback start
debug2: client_session2_setup: id 0
debug1: Sending command: /opt/dovetail/coz/bin/cozagent
debug2: channel 0: request exec confirm 0
debug2: fd 3 setting TCP_NODELAY
debug2: callback done
debug2: channel 0: open confirm rwindow 0 rmax 32768
debug2: channel 0: rcvd adjust 2097152
debug2: channel 0: rcvd ext data 39
cozagentÝN¨: version: 1.3.0 2017-07-24
debug2: channel 0: written 39 to efd 6

debug2: channel 0: rcvd ext data 122

todsn-client(27603)ÝW¨:Timeout attempting to connect socket
todsn-client(27602)ÝW¨: Timeout attempting to connect socket
debug2: channel 0: written 122 to efd 6

debug2: channel 0: rcvd ext data 224

todsn-client(27603)ÝE¨: CoZClient.C(852) - write(3, 0x7ffc28ef2300, 37) - Ý11¨ Resource temporarily unavailable
todsn-client(27602)ÝE¨: CoZClient.C(852) - write(3, 0x7fffa472de80, 37) - Ý11¨ Resource temporarily unavailable
debug2: channel 0: written 224 to efd 6

debug2: channel 0: rcvd ext data 63

fromdsn-client(27601)ÝW¨: Timeout attempting to connect socket
debug2: channel 0: written 63 to efd 6

debug2: channel 0: rcvd ext data 114

debug2: channel 0: rcvd ext data 164

debug1: client_input_channel_req: channel 0 rtype exit-status reply 0

debug1: client_input_channel_req: channel 0 rtype eow@openssh.com reply 0

debug2: channel 0: rcvd eof

debug2: channel 0: output open -> drain

debug2: channel 0: rcvd close
debug2: channel 0: close_read

debug2: channel 0: input open -> closed

debug3: channel 0: will not send data after close

fromdsn-client(27601)ÝE¨: CoZClient.C(852) - write(3, 0x7ffd743547f0, 37) - Ý11¨ Resource temporarily unavailable
cozagentÝE¨: STDIN DD Reader(27601) ended with RC=103
cozagentÝE¨: STDOUT DD Writer(27602) ended with RC=103
cozagentÝE¨: STDERR DD Writer(27603) ended with RC=103
debug2: channel 0: written 278 to efd 6

debug3: channel 0: will not send data after close

debug2: channel 0: obuf empty

debug2: channel 0: close_write

debug2: channel 0: output drain -> closed

debug2: channel 0: almost dead

debug2: channel 0: gc: notify user

debug2: channel 0: gc: user detached

debug2: channel 0: send close

debug2: channel 0: is dead

debug2: channel 0: garbage collecting

debug1: channel 0: free: client-session, nchannels 1

debug3: channel 0: status: The following connections are open:

#0 client-session (t4 r0 i3/0 o3/0 fd -1/-1 cfd -1)

debug3: channel 0: close_fds r -1 w -1 e 6 c -1

debug1: fd 0 clearing O_NONBLOCK

debug1: fd 1 clearing O_NONBLOCK

debug1: fd 2 clearing O_NONBLOCK

debug1: Transferred: stdin 0, stdout 0, stderr 0 bytes in 5.2 seconds

debug1: Bytes per second: stdin 0.0, stdout 0.0, stderr 0.0

debug1: Exit status 103
Ý15:10:54.833825¨ CoZLauncherÝD¨: agentStderrThread completed
Ý15:10:54.834117¨ CoZLauncherÝT¨: <- agentStderrThread()
Ý15:10:54.834297¨ CoZLauncherÝT¨: -> waitStatusAgent()
Ý15:10:54.834302¨ CoZLauncherÝE¨: CoZAgent process (33818350) ended with RC=103
Ý15:10:54.834307¨ CoZLauncherÝE¨: tdsmftp@nc95dhsda10002q.opr.test.statefarm.org target command '<default shell>' ended
with RC=103
Ý15:10:54.834316¨ CoZLauncherÝT¨: <- waitStatusAgent(rc=103)
Ý15:10:54.834319¨ CoZLauncherÝD¨: Killing child process CoZServer (33818354) with signal 15
Ý15:10:54.834339¨ CoZLauncherÝD¨: Waiting for CoZServer
Ý15:10:54.835286¨ CoZLauncherÝD¨: serverStderrThread completed
Ý15:10:54.835293¨ CoZLauncherÝT¨: <- serverStderrThread()
Ý15:10:54.835320¨ CoZLauncherÝT¨: -> waitStatusServer()
Ý15:10:54.835329¨ CoZLauncherÝD¨: CoZServer process (33818354) ended with RC=0
Ý15:10:54.835333¨ CoZLauncherÝT¨: <- waitStatusServer(rc=0)
Ý15:10:54.835336¨ CoZLauncherÝT¨: <- waitForChildren(rc=103)
Ý15:10:54.835338¨ CoZLauncherÝT¨: -> cleanup()
Ý15:10:54.836490¨ CoZLauncherÝT¨: <- agentStdinThread()
Ý15:10:54.869455¨ CoZLauncherÝT¨: <- handleAgentCompletion()
Ý15:10:54.869553¨ CoZLauncherÝT¨: <- agentStdoutThread()
Ý15:10:54.869747¨ CoZLauncherÝT¨: <- cleanup()
Ý15:10:54.869750¨ CoZLauncherÝE¨: CoZLauncher ended with RC=103
Ý15:10:54.869752¨ CoZLauncherÝT¨: <- run()
Ý15:10:54.869754¨ CoZLauncherÝT¨: -> ~CoZLauncher()

dovetail
Site Admin
Posts: 1910
Joined: Thu Jul 29, 2004 12:12 pm

Re: Timeout attempting to connect socket

Post by dovetail » Thu Mar 08, 2018 12:10 pm

This is an error where the remote system cannot open a socket connection back to the z/OS launcher process.

I can't tell what configuration you are using for Co:Z Launcher networking (like especially ssh-tunnel).
If you are using ssh-tunnel=true (the default), then it could be that your remote sshd server does not support reverse port forwarding.
If you are using ssh-runnel=false, then it could be that there is a firewall preventing the remote server from opening a direct (untunneled) socket back into z/OS

I would need to see the rest of the trace prior to what you have posted to diagnose what is going wrong.

Post Reply