I have the coz launcher set up on one z/os environment, and simple commands are working fine. I am now setting up the coz launcher in a second z/os environment (running z/os 1.9), but the same simple command is not working. Here is what I am running in both environments, except the new environment has the 'server-host' parm):
//RUNCOZK EXEC PROC=COZPROC,
// ARGS='drpmvs@pitcher.itg.ti.com'
//COZCFG DD *
ssh-options=-vvv
ssh-tunnel=false
agent-path=/home/drpmvs/coz/bin/cozagent.sh
target-command = /bin/sh
agent-options=-LD,t
server-env-_BPXK_INET_FASTPATH=*
server-host = SCMVS4.NSC.COM
//STDIN DD *
env
/*
Here is the error the new environment is getting:
CoZLauncherEì: drpmvs@pitcher.itg.ti.com target command '/bin/sh' ended with RC=127
CoZAgent: drpmvs@dsbdrp2 target program '/bin/sh' PID: 24209
CoZAgent: completed with RC=127
08:18:49.104197ì cozagentDì: About to execute -/bin/sh -c /bin/sh
env: No such file or directory
What is rc=127?
thanks,
Sandy
/bin/sh exit code 127
Re: /bin/sh exit code 127
127 is probably the exit code from the target program (-1, mapped into a positive number).
This is probably because you are getting this error:
env: No such file or directory
(the shell can't find the "env" command).
So, the problem seems to be that your target shell hasn't configured the PATH properly.
1) This may not be the problem, but why are you setting target-command to /bin/sh ?
the default is already the user's default shell
Setting it this way will just execute the shell twice. Try commenting out or removing the target-command property
2) change the "env" command to "/bin/env" (or the full path to env on your target system; it might be /usr/bin/env)
this might help to diagnose
3) If the above doesn't help, please get a trace and complete job output to info@dovetail.com
- add: "-LD,t" to ARGS= keyword on PROC
- and add:
//COZCFG DD *
agent-options=-LD,t
target-env-COZ_LOG=D,t
//
for more info on diagnostics, see: http://dovetail.com/docs/coz/problem_de ... d_launcher
This is probably because you are getting this error:
env: No such file or directory
(the shell can't find the "env" command).
So, the problem seems to be that your target shell hasn't configured the PATH properly.
1) This may not be the problem, but why are you setting target-command to /bin/sh ?
the default is already the user's default shell
Setting it this way will just execute the shell twice. Try commenting out or removing the target-command property
2) change the "env" command to "/bin/env" (or the full path to env on your target system; it might be /usr/bin/env)
this might help to diagnose
3) If the above doesn't help, please get a trace and complete job output to info@dovetail.com
- add: "-LD,t" to ARGS= keyword on PROC
- and add:
//COZCFG DD *
agent-options=-LD,t
target-env-COZ_LOG=D,t
//
for more info on diagnostics, see: http://dovetail.com/docs/coz/problem_de ... d_launcher
Re: /bin/sh exit code 127
I made the changes you suggested. Here is the output:
1 J E S 2 J O B L O G -- S Y S T E M C P U 1 -- N O D E N S S C 1
0
12.36.39 J0423504 ---- FRIDAY, 15 FEB 2013 ----
12.36.39 J0423504 $HASP373 CJPDSCZ STARTED - INIT 92 - CLASS A - SYS CPU1
12.36.39 J0423504 ACF9CCCD USERID CJPDSC IS ASSIGNED TO THIS JOB - CJPDSCZ
12.36.39 J0423504 IEF403I CJPDSCZ - STARTED
12.36.53 J0423504 - NSC-SC Z/OS 1.9 JOB SUMMARY STATISTICS ------TIMINGS (SECONDS)------- -- PERFORMANCE -- - PAGING COUNTS -
12.36.53 J0423504 -STEPNAME PROCSTEP PROGRAM RC EXCP CPU SRB CLOCK SERV SRVCLASS PAGE SWAP VIO SWAP
12.36.53 J0423504 -RUNCOZK COZLNCH COZLNCH 127 3350 0 .00 14.22 34000 DEFAULT 0 0 0 0
12.36.54 J0423504 IEF404I CJPDSCZ - ENDED
12.36.54 J0423504 -CJPDSCZ ENDED. NAME-14SYS - YAL TOTAL CPU TIME= .18 TOTAL ELAPSED TIME= 14.23
12.36.54 J0423504 $HASP395 CJPDSCZ ENDED
0------ JES2 JOB STATISTICS ------
- 15 FEB 2013 JOB EXECUTION DATE
- 18 CARDS READ
- 697 SYSOUT PRINT RECORDS
- 0 SYSOUT PUNCH RECORDS
- 29 SYSOUT SPOOL KBYTES
- 0.23 MINUTES EXECUTION TIME
1 //CJPDSCZ JOB (CJPDSC,0003SC),'14SYS - YAL',CLASS=A, J0423504
// MSGCLASS=T,NOTIFY=&SYSUID 00002000
//* $ACFJ219 ACF2 ACTIVE NSSC1 ACF2
IEFC653I SUBSTITUTION JCL - (CJPDSC,0003SC),'14SYS - YAL',CLASS=A,MSGCLASS=T,NOTIFY=CJPDSC
2 //STEPLIB JCLLIB ORDER=('SYS1.COZ.PARMLIB') 00010000
3 //RUNCOZK EXEC PROC=COZPROC, 00020000
// ARGS='-LD,t drpmvs@dsbdrp2.itg.ti.com' 00030006
XX*********************************************************************
XX*
XX* Stored procedure for executing the COZ Launcher
XX*
XX* Tailor the proc your installation:
XX* 1.) Tailor LIBRARY with the PDSE that contains the
XX* COZ load module.
XX* 2.) Tailor COZCFGD= to point to SAMPJCL config member
XX*
XX* Note: in V2.1.0, SYSOUT and SYSPRINT renamed to COZLOG and COZOUT
XX*********************************************************************
4 XXEXCOZ PROC ARGS=, < -L<log_opt>ì
XX LIBRARY='SYS1.COZ.LOADLIB', < STEPLIB FOR COZLNCH
XX COZCFGD='SYS1.COZ.PARMLIB(COZCFGD)', < Installation defaults
XX REGSIZE='32M', < Execution region size
XX LEPARM=''
5 XXCOZLNCH EXEC PGM=COZLNCH,REGION=®SIZE,
XX PARM='MSGFILE(COZLOG),&LEPARM/&ARGS'
IEFC653I SUBSTITUTION JCL - PGM=COZLNCH,REGION=32M,PARM='MSGFILE(COZLOG),/-LD,t drpmvs@dsbdrp2.itg.ti.com'
6 XXSTEPLIB DD DSN=&LIBRARY,DISP=SHR
IEFC653I SUBSTITUTION JCL - DSN=SYS1.COZ.LOADLIB,DISP=SHR
7 XXCOZCONF DD DSN=&COZCFGD,DISP=SHR
IEFC653I SUBSTITUTION JCL - DSN=SYS1.COZ.PARMLIB(COZCFGD),DISP=SHR
8 XX DD DDNAME=COZCFG
9 //COZCFG DD * 00040000
X/COZCFG DD DUMMY < override for addtnl config
10 XXCOZLOG DD SYSOUT=* < System stderr log
11 XXCOZOUT DD SYSOUT=*, < CoZAgent stdout
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
12 //STDIN DD * 00100000
X/STDIN DD DUMMY < Target app stdin
13 XXSTDOUT DD SYSOUT=*, < Target app stdout
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
14 XXSTDERR DD SYSOUT=*, < Target app stderr
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
XX*
15 //ABNLIGNR DD DUMMY 00160000
16 //IDIOFF DD DUMMY 00170000
17 XX PEND
STMT NO. MESSAGE
3 IEFC001I PROCEDURE COZPROC WAS EXPANDED USING PRIVATE LIBRARY SYS1.COZ.PARMLIB
IEF236I ALLOC. FOR CJPDSCZ COZLNCH RUNCOZK
IGD103I SMS ALLOCATED TO DDNAME STEPLIB
IGD103I SMS ALLOCATED TO DDNAME COZCONF
IEF237I JES2 ALLOCATED TO
IEF237I JES2 ALLOCATED TO COZLOG
IEF237I JES2 ALLOCATED TO COZOUT
IEF237I JES2 ALLOCATED TO STDIN
IEF237I JES2 ALLOCATED TO STDOUT
IEF237I JES2 ALLOCATED TO STDERR
IEF237I DMY ALLOCATED TO ABNLIGNR
IEF237I DMY ALLOCATED TO IDIOFF
IEF237I 111A ALLOCATED TO SYS00004
IEF285I TCPIP.TCPIP.DATA KEPT
IEF285I VOL SER NOS= S191M1.
IEF237I 111A ALLOCATED TO SYS00006
IEF285I TCPIP.STANDARD.TCPXLBIN KEPT
IEF285I VOL SER NOS= S191M1.
IEF237I JES2 ALLOCATED TO SYS00007
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000107.? SYSOUT
IEF142I CJPDSCZ COZLNCH RUNCOZK - STEP WAS EXECUTED - COND CODE 0127
IGD104I SYS1.COZ.LOADLIB RETAINED, DDNAME=STEPLIB
IGD104I SYS1.COZ.PARMLIB RETAINED, DDNAME=COZCONF
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000101.? SYSIN
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000103.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000104.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000102.? SYSIN
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000105.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000106.? SYSOUT
****************************************************************************************************************************
* DDNAME UNIT EXCPS BLKSIZE DDNAME UNIT EXCPS BLKSIZE DDNAME UNIT EXCPS BLKSIZE *
* STEPLIB D-067D 65 6144 COZCONF D-111B 2 27920 COZCONF X/JES N/A N/A *
* COZLOG X/JES N/A N/A COZOUT X/JES N/A N/A STDIN X/JES N/A N/A *
* STDOUT X/JES N/A N/A STDERR X/JES N/A N/A ABNLIGNR X/JES N/A N/A *
* IDIOFF X/JES N/A N/A SYS00004 D-111A 3 8000 SYS00006 D-111A 4 256 *
* SYS00007 X/JES N/A N/A *
****************************************************************************************************************************
* TOTAL DISK TAPE VIO OTHER *
* EXCPS 3,350 74 0 0 3,276 *
****************************************************************************************************************************
IEF373I STEP/COZLNCH /START 2013046.1236
IEF374I STEP/COZLNCH /STOP 2013046.1236 CPU 0MIN 00.18SEC SRB 0MIN 00.00SEC VIRT 124K SYS 380K EXT 10792K SYS 12316K
IEF375I JOB/CJPDSCZ /START 2013046.1236
IEF376I JOB/CJPDSCZ /STOP 2013046.1236 CPU 0MIN 00.18SEC SRB 0MIN 00.00SEC
12:36:39.920192ì CoZLauncherNì: version: 2.3.1 2013-01-23
12:36:39.930976ì CoZLauncherNì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
12:36:39.931001ì CoZLauncherDì: target_user="drpmvs", target_host="dsbdrp2.itg.ti.com", target_port="NULL"
12:36:39.931077ì CoZLauncherDì: sysname=CPU1, user=CJPDSC, uid=0, euid=0, pid=50331752, ppid=1
12:36:39.931109ì CoZLauncherDì: region size requested = 32768K, Actual below/above limit = 10216K / 65536K
07:36:39.944366ì CoZLauncherIì: Agent output WTO is OFF
07:36:39.944423ì CoZLauncherIì: ssh tunnelling is OFF
07:36:39.944442ì CoZLauncherDì: server-path=/usr/local/coz/bin/cozserver
07:36:39.944462ì CoZLauncherDì: server-ports=8040-8048
07:36:39.944478ì CoZLauncherDì: ssh-tunnel=false
07:36:39.944495ì CoZLauncherDì: ssh-le-options=HEAP(8M,1M,,FREE),ENVAR("_CEE_REALLOC_CONTROL=256K,25")
07:36:39.944515ì CoZLauncherDì: server-env-COZ_TRSUB_US-ASCII=ISO8859-1
07:36:39.944534ì CoZLauncherDì: ssh-options=-vvv
07:36:39.944550ì CoZLauncherDì: agent-path=/home/drpmvs/coz/bin/cozagent.sh
07:36:39.944567ì CoZLauncherDì: agent-options=-LD,t
07:36:39.944587ì CoZLauncherDì: target-env-COZ_LOG=D,t
07:36:39.944606ì CoZLauncherDì: server-env-_BPXK_INET_FASTPATH=*
07:36:39.944623ì CoZLauncherDì: server-host=SCMVS4.NSC.COM
07:36:39.945940ì CoZLauncherDì: Set server environment variable:'COZ_TRSUB_US-ASCII'='ISO8859-1'
07:36:39.945995ì CoZLauncherDì: Set server environment variable:'_BPXK_INET_FASTPATH'='*'
07:36:39.947571ì CoZLauncherDì: open(/dev/random) - EDC5157I An internal error has occurred. (errno2=0x05DA05FC)
07:36:39.947599ì CoZLauncherDì: /dev/random (ICSF) not available, using random()
07:36:39.947679ì CoZLauncherDì: Server port range: 8040-8048
07:36:39.947700ì CoZLauncherDì: Attempting to start socket listener on port 8040
07:36:40.434741ì CoZLauncherDì: Attempting to start socket listener on port 8041
07:36:40.435113ì CoZLauncherIì: CoZServer listener socket bound to: 0.0.0.0:8041
07:36:40.435273ì CoZLauncherDì: server_cmd...
/usr/local/coz/bin/cozserver -sockfd 3
07:36:40.442527ì CoZLauncherDì: Started CoZServer process: 33554719
07:36:40.450756ì CoZLauncherDì: arg3ì = '-vvv'
07:36:40.450823ì CoZLauncherDì: arg0ì = '-LD,t'
07:36:40.450840ì CoZLauncherDì: agent_cmd...
/bin/ssh -l drpmvs -vvv dsbdrp2.itg.ti.com /home/drpmvs/coz/bin/cozagent.sh -LD,t
07:36:40.459723ì CoZLauncherDì: Started CoZAgent process: 33555122
07:36:40.461040ì CoZLauncherDì: About to start target command: ''
07:36:40.616943ì CoZLauncherDì: First agent message received:
OpenSSH_5.0p1, OpenSSL 0.9.8k 25 Mar 2009
debug1: Reading configuration data /etc/ssh/ssh_config
debug1: Reading configuration data /etc/ssh/zos_ssh_config
debug3: Seeding PRNG from /usr/lib/ssh/ssh-rand-helper
debug1: zsshSmfSetConnSmfStatus: SMF status is 0
debug1: Rhosts Authentication disabled, originating port will not be trusted.
debug2: ssh_connect: needpriv 0
debug1: Connecting to dsbdrp2.itg.ti.com 156.117.197.90ì port 22.
debug1: Connection established.
debug1: cipher_init: none from source OpenSSL
debug1: cipher_init: none from source OpenSSL
debug1: permanently_set_uid: 0/3
debug3: zsshGetpw: passwd name=CJPDSC, uid=0, gid=3, dir=/u/cjpdsc, shell=/bin/sh
debug3: Not a RSA1 key file /u/cjpdsc/.ssh/id_rsa.
debug2: key_type_from_name: unknown key type '-----BEGIN'
debug3: key_read: missing keytype
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug2: key_type_from_name: unknown key type '-----END'
debug3: key_read: missing keytype
debug1: identity file /u/cjpdsc/.ssh/id_rsa type 1
debug3: Not a RSA1 key file /u/cjpdsc/.ssh/id_dsa.
debug2: key_type_from_name: unknown key type '-----BEGIN'
debug3: key_read: missing keytype
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug2: key_type_from_name: unknown key type '-----END'
debug3: key_read: missing keytype
debug1: identity file /u/cjpdsc/.ssh/id_dsa type 2
debug1: Remote protocol version 2.0, remote software version OpenSSH_3.7.1p2-pwexp24
debug1: match: OpenSSH_3.7.1p2-pwexp24 pat OpenSSH_3.*
debug1: Enabling compatibility mode for protocol 2.0
debug1: Local version string SSH-2.0-OpenSSH_5.0
debug2: fd 3 setting O_NONBLOCK
debug3: RNG is ready, skipping seeding
debug1: SSH2_MSG_KEXINIT sent
debug1: SSH2_MSG_KEXINIT received
debug2: kex_parse_kexinit: diffie-hellman-group-exchange-sha256,diffie-hellman-group-exchange-sha1,diffie-hellman-group1
4-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit: ssh-rsa,ssh-dss
debug2: kex_parse_kexinit: aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,aes128-cbc,3des-cbc,blowfish-cbc,cast1
28-cbc,aes192-cbc,aes256-cbc,arcfour,rijndael-cbc@lysator.liu.se
debug2: kex_parse_kexinit: aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,aes128-cbc,3des-cbc,blowfish-cbc,cast1
28-cbc,aes192-cbc,aes256-cbc,arcfour,rijndael-cbc@lysator.liu.se
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,umac-64@openssh.com,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96
,hmac-md5-96
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,umac-64@openssh.com,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96
,hmac-md5-96
debug2: kex_parse_kexinit: none,zlib@openssh.com,zlib
debug2: kex_parse_kexinit: none,zlib@openssh.com,zlib
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug2: kex_parse_kexinit: diffie-hellman-group-exchange-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit: ssh-rsa,ssh-dss
debug2: kex_parse_kexinit: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysat
or.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
debug2: kex_parse_kexinit: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysat
or.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: none,zlib
debug2: kex_parse_kexinit: none,zlib
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug1: mac_setup_by_id: hmac-md5 from source OpenSSL
debug2: mac_setup: found hmac-md5
debug1: kex: server->client aes128-ctr hmac-md5 none
debug1: mac_setup_by_id: hmac-md5 from source OpenSSL
debug2: mac_setup: found hmac-md5
debug1: kex: client->server aes128-ctr hmac-md5 none
debug1: SSH2_MSG_KEX_DH_GEX_REQUEST(1024<1024<8192) sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_GROUP
debug2: dh_gen_key: priv key bits set: 118/256
debug2: bits set: 494/1024
debug1: SSH2_MSG_KEX_DH_GEX_INIT sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_REPLY
debug3: check_host_in_hostfile: filename /u/cjpdsc/.ssh/known_hosts
debug3: check_host_in_hostfile: filename /etc/ssh/ssh_known_hosts
debug3: check_host_in_hostfile: filename /u/cjpdsc/.ssh/known_hosts
debug3: check_host_in_hostfile: match line 3
debug3: __catgets: NLS setup complete (1), using message catalog openssh.cat
Warning: Permanently added 'dsbdrp2.itg.ti.com' (RSA) to the list of known hosts.
debug2: bits set: 529/1024
debug1: ssh_rsa_verify: signature correct
debug2: kex_derive_keys
debug2: set_newkeys: mode 1
debug1: cipher_init: aes128-ctr from source OpenSSL
debug1: SSH2_MSG_NEWKEYS sent
debug1: expecting SSH2_MSG_NEWKEYS
debug2: set_newkeys: mode 0
debug1: cipher_init: aes128-ctr from source OpenSSL
debug1: SSH2_MSG_NEWKEYS received
debug1: SSH2_MSG_SERVICE_REQUEST sent
debug2: service_accept: ssh-userauth
debug1: SSH2_MSG_SERVICE_ACCEPT received
debug2: key: /u/cjpdsc/.ssh/id_rsa (11656B00)
debug2: key: /u/cjpdsc/.ssh/id_dsa (11652640)
debug3: input_userauth_banner
---------------------------------------------------------------------------
-- UNAUTHORIZED USE MAY RESULT IN CIVIL AND/OR CRIMINAL PROSECUTION. --
---------------------------------------------------------------------------
This is a proprietary system of Texas Instruments Incorporated (TI) or its
licensors. This system is for the use of authorized users only. Individuals
using this system are subject to having all of their activities on this
system monitored and recorded in order to verify that they have appropriate
authority and do not use this system for any inappropriate or unlawful
purpose. Anyone using this system expressly consents to such monitoring.
If monitoring reveals unauthorized, inappropriate or possible unlawful
activity, system personnel will provide information derived from such
monitoring to TI management or outside legal authorities, as appropriate.
Misuse of this system may result in revocation or limitation of an
individual's access to this system in addition to any other appropriate
remedies. Misuse of this system by TI employees may result in disciplinary
action, including termination.
---------------------------------------------------------------------------
debug1: Authentications that can continue: publickey,password,keyboard-interactive
debug3: start over, passed a different list publickey,password,keyboard-interactive
debug3: preferred publickey
debug3: authmethod_lookup publickey
debug3: remaining preferred:
debug3: authmethod_is_enabled publickey
debug1: Next authentication method: publickey
debug1: Offering public key: /u/cjpdsc/.ssh/id_rsa
debug3: send_pubkey_test
debug2: we sent a publickey packet, wait for reply
debug1: Server accepts key: pkalg ssh-rsa blen 277
debug2: input_userauth_pk_ok: fp 98:d4:5f:07:eb:f9:71:8d:f8:8d:71:38:a5:72:4b:0b
debug3: sign_and_send_pubkey
debug1: read PEM private key done: type RSA
debug1: Authentication succeeded (publickey).
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: /home/drpmvs/coz/bin/cozagent.sh -LD,t
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 131072
debug2: channel 0: rcvd ext data 39
debug2: channel 0: rcvd ext data 225
debug2: channel 0: rcvd ext data 49
debug2: channel 0: rcvd ext data 125
debug2: channel 0: rcvd ext data 271
debug2: channel 0: rcvd ext data 69
cozagentNì: version: 1.1.0 2012-03-16
14:37:03.363419ì cozagentIì: version: 1.1.0 2012-03-16
14:37:03.363657ì cozagentIì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
14:37:03.363706ì cozagentDì: cozagent dir: /home/drpmvs/coz/bin
14:37:03.364717ì cozagentDì: cwd: /home/drpmvs
14:37:03.364771ì cozagentDì: PATH:
14:37:03.364794ì cozagentDì: /usr/bin
14:37:03.364805ì cozagentDì: /usr/local/bin
14:37:03.364815ì cozagentDì: /usr/sbin
14:37:03.364826ì cozagentDì: /usr/ccs/bin
14:37:03.364837ì cozagentDì: /usr/ucb
14:37:03.364846ì cozagentDì: /etc
14:37:03.364855ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364863ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364880ì cozagentDì: Waiting for configuration commands...
debug2: channel 0: written 778 to efd 6
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 194
debug2: channel 0: rcvd ext data 78
debug2: channel 0: rcvd ext data 50
debug2: channel 0: rcvd ext data 52
debug2: channel 0: rcvd ext data 53
debug2: channel 0: rcvd ext data 53
debug2: channel 0: rcvd ext data 68
debug2: channel 0: rcvd ext data 245
debug2: channel 0: rcvd ext data 70
14:37:03.384550ì cozagentDì: Set environment variable: 'COZ_SERVER_HOST'
14:37:03.384675ì cozagentDì: Set environment variable: 'COZ_SERVER_PORT'
14:37:03.384699ì cozagentDì: Set environment variable: 'COZ_AUTH_TOKEN'
14:37:03.384714ì cozagentDì: Set environment variable: 'COZ_LOG'
14:37:03.384726ì cozagentDì: target_command='NULL'
14:37:03.384898ì cozagentDì: getpwuid(geteuid()) pw=3034c, pw_shell=/bin/sh
14:37:03.386102ì cozagentDì: target_pid = 10218
14:37:03.386942ì cozagentDì: stdin_dd_pid = 10219
14:37:03.388352ì cozagentDì: stdout_dd_pid = 10220
14:37:03.390608ì cozagentDì: stderr_dd_pid = 10221
14:37:03.399410ì todsn-client(10220)Iì: version: 1.1.0 2012-03-16
14:37:03.399756ì todsn-client(10220)Dì: cmd_arg1ì = -z
14:37:03.399777ì todsn-client(10220)Dì: cmd_arg2ì = //DD:STDOUT
14:37:03.399793ì todsn-client(10220)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port 8041
14:37:03.402678ì fromdsn-client(10219)Iì: version: 1.1.0 2012-03-16
debug2: channel 0: written 1013 to efd 6
debug2: channel 0: rcvd ext data 190
debug2: channel 0: rcvd ext data 313
14:37:03.403225ì fromdsn-client(10219)Dì: cmd_arg1ì = //DD:STDIN
14:37:03.403256ì fromdsn-client(10219)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port
8041
14:37:03.403241ì todsn-client(10221)Iì: version: 1.1.0 2012-03-16
14:37:03.403690ì todsn-client(10221)Dì: cmd_arg1ì = -z
14:37:03.403717ì todsn-client(10221)Dì: cmd_arg2ì = //DD:STDERR
14:37:03.403733ì todsn-client(10221)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port 8041
debug2: channel 0: written 503 to efd 6
fromdsn(DD:STDIN)Nì: 1 records/80 bytes read; 81 bytes written in 0 milliseconds.
todsn(DD:STDERR)Nì: 99 bytes read; 2 records/97 bytes written in 0 milliseconds.
todsn(DD:STDOUT)Nì: 0 bytes read; 0 records/0 bytes written in 0 milliseconds.
debug2: channel 0: rcvd ext data 95
debug2: channel 0: rcvd ext data 95
debug2: channel 0: rcvd ext data 97
debug2: channel 0: rcvd ext data 78
debug2: channel 0: rcvd ext data 63
debug2: channel 0: rcvd ext data 132
debug2: channel 0: rcvd ext data 141
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 61
debug2: channel 0: rcvd ext data 130
14:37:03.461129ì todsn-client(10220)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.468911ì todsn-client(10221)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.470880ì fromdsn-client(10219)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.563550ì fromdsn-client(10219)Dì: fromdsn(DD:STDIN): , rc=0, msg=""
14:37:03.563752ì fromdsn-client(10219)Dì: server exit_code=0
14:37:03.564039ì fromdsn-client(10219)Dì: transmitted byte counts agree; server sent/received = 81/0, client
received/sent = 81/0
14:37:03.568572ì cozagentEì: Target Program(10218) ended with RC=127
14:37:03.568654ì cozagentDì: STDIN DD Reader(10219) ended with RC=0
14:37:03.643794ì todsn-client(10221)Dì: todsn(DD:STDERR): , rc=0, msg=""
14:37:03.649727ì todsn-client(10220)Dì: todsn(DD:STDOUT): , rc=0, msg=""
14:37:03.651987ì todsn-client(10221)Dì: server exit_code=0
14:37:03.652236ì todsn-client(10221)Dì: transmitted byte counts agree; server sent/received = 0/99, client
received/sent = 0/99
debug2: channel 0: written 1042 to efd 6
debug2: channel 0: rcvd ext data 61
debug2: channel 0: rcvd ext data 128
14:37:03.654549ì todsn-client(10220)Dì: server exit_code=0
14:37:03.654737ì todsn-client(10220)Dì: transmitted byte counts agree; server sent/received = 0/0, client
received/sent = 0/0
debug2: channel 0: written 189 to efd 6
debug2: channel 0: rcvd ext data 233
debug2: channel 0: rcvd eof
debug2: channel 0: output open -> drain
debug1: client_input_channel_req: channel 0 rtype exit-status reply 0
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
14:37:03.770834ì cozagentDì: At least one child I/O process still running, waiting again
14:37:03.772203ì cozagentDì: STDOUT DD Writer(10220) ended with RC=0
14:37:03.772249ì cozagentDì: STDERR DD Writer(10221) ended with RC=0
debug2: channel 0: written 233 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 0.8 seconds
debug1: Bytes per second: stdin 0.0, stdout 0.0, stderr 0.0
debug1: Exit status 127
07:36:52.955135ì CoZLauncherDì: agentStderrThread completed
07:36:52.955394ì CoZLauncherDì: CoZAgent: completed with RC=127
07:36:52.956043ì CoZLauncherDì: SSH process times: elapsed=1360931812 secs, user cpu=0.000000 secs, sys cpu=0.000000
secs
07:36:52.956107ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959056ì CoZLauncherDì: serverStderrThread completed
07:36:52.959444ì CoZLauncherEì: drpmvs@dsbdrp2.itg.ti.com target command '<default shell>' ended with RC=127
07:36:52.959488ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959645ì CoZLauncherDì: kill() failed for child process CoZServer (33554719): 139ì EDC5139I Operation not
permitted. (errno2=0x0D100114)
07:36:52.959681ì CoZLauncherDì: Waiting for CoZServer
07:36:52.959733ì CoZLauncherDì: CoZServer (33554719) ended with RC=0
07:36:52.962181ì CoZLauncherDì: agentStdoutThread completed
07:36:52.968140ì CoZLauncherIì: CoZLauncher ended with RC=127
CoZAgent: drpmvs@dsbdrp2 target program '/bin/sh' PID: 10218
CoZAgent: completed with RC=127
14:37:03.387018ì cozagentDì: About to execute shell -/bin/sh
/bin/env: No such file or directory
1 J E S 2 J O B L O G -- S Y S T E M C P U 1 -- N O D E N S S C 1
0
12.36.39 J0423504 ---- FRIDAY, 15 FEB 2013 ----
12.36.39 J0423504 $HASP373 CJPDSCZ STARTED - INIT 92 - CLASS A - SYS CPU1
12.36.39 J0423504 ACF9CCCD USERID CJPDSC IS ASSIGNED TO THIS JOB - CJPDSCZ
12.36.39 J0423504 IEF403I CJPDSCZ - STARTED
12.36.53 J0423504 - NSC-SC Z/OS 1.9 JOB SUMMARY STATISTICS ------TIMINGS (SECONDS)------- -- PERFORMANCE -- - PAGING COUNTS -
12.36.53 J0423504 -STEPNAME PROCSTEP PROGRAM RC EXCP CPU SRB CLOCK SERV SRVCLASS PAGE SWAP VIO SWAP
12.36.53 J0423504 -RUNCOZK COZLNCH COZLNCH 127 3350 0 .00 14.22 34000 DEFAULT 0 0 0 0
12.36.54 J0423504 IEF404I CJPDSCZ - ENDED
12.36.54 J0423504 -CJPDSCZ ENDED. NAME-14SYS - YAL TOTAL CPU TIME= .18 TOTAL ELAPSED TIME= 14.23
12.36.54 J0423504 $HASP395 CJPDSCZ ENDED
0------ JES2 JOB STATISTICS ------
- 15 FEB 2013 JOB EXECUTION DATE
- 18 CARDS READ
- 697 SYSOUT PRINT RECORDS
- 0 SYSOUT PUNCH RECORDS
- 29 SYSOUT SPOOL KBYTES
- 0.23 MINUTES EXECUTION TIME
1 //CJPDSCZ JOB (CJPDSC,0003SC),'14SYS - YAL',CLASS=A, J0423504
// MSGCLASS=T,NOTIFY=&SYSUID 00002000
//* $ACFJ219 ACF2 ACTIVE NSSC1 ACF2
IEFC653I SUBSTITUTION JCL - (CJPDSC,0003SC),'14SYS - YAL',CLASS=A,MSGCLASS=T,NOTIFY=CJPDSC
2 //STEPLIB JCLLIB ORDER=('SYS1.COZ.PARMLIB') 00010000
3 //RUNCOZK EXEC PROC=COZPROC, 00020000
// ARGS='-LD,t drpmvs@dsbdrp2.itg.ti.com' 00030006
XX*********************************************************************
XX*
XX* Stored procedure for executing the COZ Launcher
XX*
XX* Tailor the proc your installation:
XX* 1.) Tailor LIBRARY with the PDSE that contains the
XX* COZ load module.
XX* 2.) Tailor COZCFGD= to point to SAMPJCL config member
XX*
XX* Note: in V2.1.0, SYSOUT and SYSPRINT renamed to COZLOG and COZOUT
XX*********************************************************************
4 XXEXCOZ PROC ARGS=, < -L<log_opt>ì
XX LIBRARY='SYS1.COZ.LOADLIB', < STEPLIB FOR COZLNCH
XX COZCFGD='SYS1.COZ.PARMLIB(COZCFGD)', < Installation defaults
XX REGSIZE='32M', < Execution region size
XX LEPARM=''
5 XXCOZLNCH EXEC PGM=COZLNCH,REGION=®SIZE,
XX PARM='MSGFILE(COZLOG),&LEPARM/&ARGS'
IEFC653I SUBSTITUTION JCL - PGM=COZLNCH,REGION=32M,PARM='MSGFILE(COZLOG),/-LD,t drpmvs@dsbdrp2.itg.ti.com'
6 XXSTEPLIB DD DSN=&LIBRARY,DISP=SHR
IEFC653I SUBSTITUTION JCL - DSN=SYS1.COZ.LOADLIB,DISP=SHR
7 XXCOZCONF DD DSN=&COZCFGD,DISP=SHR
IEFC653I SUBSTITUTION JCL - DSN=SYS1.COZ.PARMLIB(COZCFGD),DISP=SHR
8 XX DD DDNAME=COZCFG
9 //COZCFG DD * 00040000
X/COZCFG DD DUMMY < override for addtnl config
10 XXCOZLOG DD SYSOUT=* < System stderr log
11 XXCOZOUT DD SYSOUT=*, < CoZAgent stdout
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
12 //STDIN DD * 00100000
X/STDIN DD DUMMY < Target app stdin
13 XXSTDOUT DD SYSOUT=*, < Target app stdout
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
14 XXSTDERR DD SYSOUT=*, < Target app stderr
XX DCB=(RECFM=VB,LRECL=255,BLKSIZE=10000)
XX*
15 //ABNLIGNR DD DUMMY 00160000
16 //IDIOFF DD DUMMY 00170000
17 XX PEND
STMT NO. MESSAGE
3 IEFC001I PROCEDURE COZPROC WAS EXPANDED USING PRIVATE LIBRARY SYS1.COZ.PARMLIB
IEF236I ALLOC. FOR CJPDSCZ COZLNCH RUNCOZK
IGD103I SMS ALLOCATED TO DDNAME STEPLIB
IGD103I SMS ALLOCATED TO DDNAME COZCONF
IEF237I JES2 ALLOCATED TO
IEF237I JES2 ALLOCATED TO COZLOG
IEF237I JES2 ALLOCATED TO COZOUT
IEF237I JES2 ALLOCATED TO STDIN
IEF237I JES2 ALLOCATED TO STDOUT
IEF237I JES2 ALLOCATED TO STDERR
IEF237I DMY ALLOCATED TO ABNLIGNR
IEF237I DMY ALLOCATED TO IDIOFF
IEF237I 111A ALLOCATED TO SYS00004
IEF285I TCPIP.TCPIP.DATA KEPT
IEF285I VOL SER NOS= S191M1.
IEF237I 111A ALLOCATED TO SYS00006
IEF285I TCPIP.STANDARD.TCPXLBIN KEPT
IEF285I VOL SER NOS= S191M1.
IEF237I JES2 ALLOCATED TO SYS00007
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000107.? SYSOUT
IEF142I CJPDSCZ COZLNCH RUNCOZK - STEP WAS EXECUTED - COND CODE 0127
IGD104I SYS1.COZ.LOADLIB RETAINED, DDNAME=STEPLIB
IGD104I SYS1.COZ.PARMLIB RETAINED, DDNAME=COZCONF
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000101.? SYSIN
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000103.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000104.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000102.? SYSIN
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000105.? SYSOUT
IEF285I CJPDSC.CJPDSCZ.J0423504.D0000106.? SYSOUT
****************************************************************************************************************************
* DDNAME UNIT EXCPS BLKSIZE DDNAME UNIT EXCPS BLKSIZE DDNAME UNIT EXCPS BLKSIZE *
* STEPLIB D-067D 65 6144 COZCONF D-111B 2 27920 COZCONF X/JES N/A N/A *
* COZLOG X/JES N/A N/A COZOUT X/JES N/A N/A STDIN X/JES N/A N/A *
* STDOUT X/JES N/A N/A STDERR X/JES N/A N/A ABNLIGNR X/JES N/A N/A *
* IDIOFF X/JES N/A N/A SYS00004 D-111A 3 8000 SYS00006 D-111A 4 256 *
* SYS00007 X/JES N/A N/A *
****************************************************************************************************************************
* TOTAL DISK TAPE VIO OTHER *
* EXCPS 3,350 74 0 0 3,276 *
****************************************************************************************************************************
IEF373I STEP/COZLNCH /START 2013046.1236
IEF374I STEP/COZLNCH /STOP 2013046.1236 CPU 0MIN 00.18SEC SRB 0MIN 00.00SEC VIRT 124K SYS 380K EXT 10792K SYS 12316K
IEF375I JOB/CJPDSCZ /START 2013046.1236
IEF376I JOB/CJPDSCZ /STOP 2013046.1236 CPU 0MIN 00.18SEC SRB 0MIN 00.00SEC
12:36:39.920192ì CoZLauncherNì: version: 2.3.1 2013-01-23
12:36:39.930976ì CoZLauncherNì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
12:36:39.931001ì CoZLauncherDì: target_user="drpmvs", target_host="dsbdrp2.itg.ti.com", target_port="NULL"
12:36:39.931077ì CoZLauncherDì: sysname=CPU1, user=CJPDSC, uid=0, euid=0, pid=50331752, ppid=1
12:36:39.931109ì CoZLauncherDì: region size requested = 32768K, Actual below/above limit = 10216K / 65536K
07:36:39.944366ì CoZLauncherIì: Agent output WTO is OFF
07:36:39.944423ì CoZLauncherIì: ssh tunnelling is OFF
07:36:39.944442ì CoZLauncherDì: server-path=/usr/local/coz/bin/cozserver
07:36:39.944462ì CoZLauncherDì: server-ports=8040-8048
07:36:39.944478ì CoZLauncherDì: ssh-tunnel=false
07:36:39.944495ì CoZLauncherDì: ssh-le-options=HEAP(8M,1M,,FREE),ENVAR("_CEE_REALLOC_CONTROL=256K,25")
07:36:39.944515ì CoZLauncherDì: server-env-COZ_TRSUB_US-ASCII=ISO8859-1
07:36:39.944534ì CoZLauncherDì: ssh-options=-vvv
07:36:39.944550ì CoZLauncherDì: agent-path=/home/drpmvs/coz/bin/cozagent.sh
07:36:39.944567ì CoZLauncherDì: agent-options=-LD,t
07:36:39.944587ì CoZLauncherDì: target-env-COZ_LOG=D,t
07:36:39.944606ì CoZLauncherDì: server-env-_BPXK_INET_FASTPATH=*
07:36:39.944623ì CoZLauncherDì: server-host=SCMVS4.NSC.COM
07:36:39.945940ì CoZLauncherDì: Set server environment variable:'COZ_TRSUB_US-ASCII'='ISO8859-1'
07:36:39.945995ì CoZLauncherDì: Set server environment variable:'_BPXK_INET_FASTPATH'='*'
07:36:39.947571ì CoZLauncherDì: open(/dev/random) - EDC5157I An internal error has occurred. (errno2=0x05DA05FC)
07:36:39.947599ì CoZLauncherDì: /dev/random (ICSF) not available, using random()
07:36:39.947679ì CoZLauncherDì: Server port range: 8040-8048
07:36:39.947700ì CoZLauncherDì: Attempting to start socket listener on port 8040
07:36:40.434741ì CoZLauncherDì: Attempting to start socket listener on port 8041
07:36:40.435113ì CoZLauncherIì: CoZServer listener socket bound to: 0.0.0.0:8041
07:36:40.435273ì CoZLauncherDì: server_cmd...
/usr/local/coz/bin/cozserver -sockfd 3
07:36:40.442527ì CoZLauncherDì: Started CoZServer process: 33554719
07:36:40.450756ì CoZLauncherDì: arg3ì = '-vvv'
07:36:40.450823ì CoZLauncherDì: arg0ì = '-LD,t'
07:36:40.450840ì CoZLauncherDì: agent_cmd...
/bin/ssh -l drpmvs -vvv dsbdrp2.itg.ti.com /home/drpmvs/coz/bin/cozagent.sh -LD,t
07:36:40.459723ì CoZLauncherDì: Started CoZAgent process: 33555122
07:36:40.461040ì CoZLauncherDì: About to start target command: ''
07:36:40.616943ì CoZLauncherDì: First agent message received:
OpenSSH_5.0p1, OpenSSL 0.9.8k 25 Mar 2009
debug1: Reading configuration data /etc/ssh/ssh_config
debug1: Reading configuration data /etc/ssh/zos_ssh_config
debug3: Seeding PRNG from /usr/lib/ssh/ssh-rand-helper
debug1: zsshSmfSetConnSmfStatus: SMF status is 0
debug1: Rhosts Authentication disabled, originating port will not be trusted.
debug2: ssh_connect: needpriv 0
debug1: Connecting to dsbdrp2.itg.ti.com 156.117.197.90ì port 22.
debug1: Connection established.
debug1: cipher_init: none from source OpenSSL
debug1: cipher_init: none from source OpenSSL
debug1: permanently_set_uid: 0/3
debug3: zsshGetpw: passwd name=CJPDSC, uid=0, gid=3, dir=/u/cjpdsc, shell=/bin/sh
debug3: Not a RSA1 key file /u/cjpdsc/.ssh/id_rsa.
debug2: key_type_from_name: unknown key type '-----BEGIN'
debug3: key_read: missing keytype
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug2: key_type_from_name: unknown key type '-----END'
debug3: key_read: missing keytype
debug1: identity file /u/cjpdsc/.ssh/id_rsa type 1
debug3: Not a RSA1 key file /u/cjpdsc/.ssh/id_dsa.
debug2: key_type_from_name: unknown key type '-----BEGIN'
debug3: key_read: missing keytype
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug3: key_read: missing whitespace
debug2: key_type_from_name: unknown key type '-----END'
debug3: key_read: missing keytype
debug1: identity file /u/cjpdsc/.ssh/id_dsa type 2
debug1: Remote protocol version 2.0, remote software version OpenSSH_3.7.1p2-pwexp24
debug1: match: OpenSSH_3.7.1p2-pwexp24 pat OpenSSH_3.*
debug1: Enabling compatibility mode for protocol 2.0
debug1: Local version string SSH-2.0-OpenSSH_5.0
debug2: fd 3 setting O_NONBLOCK
debug3: RNG is ready, skipping seeding
debug1: SSH2_MSG_KEXINIT sent
debug1: SSH2_MSG_KEXINIT received
debug2: kex_parse_kexinit: diffie-hellman-group-exchange-sha256,diffie-hellman-group-exchange-sha1,diffie-hellman-group1
4-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit: ssh-rsa,ssh-dss
debug2: kex_parse_kexinit: aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,aes128-cbc,3des-cbc,blowfish-cbc,cast1
28-cbc,aes192-cbc,aes256-cbc,arcfour,rijndael-cbc@lysator.liu.se
debug2: kex_parse_kexinit: aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,aes128-cbc,3des-cbc,blowfish-cbc,cast1
28-cbc,aes192-cbc,aes256-cbc,arcfour,rijndael-cbc@lysator.liu.se
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,umac-64@openssh.com,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96
,hmac-md5-96
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,umac-64@openssh.com,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96
,hmac-md5-96
debug2: kex_parse_kexinit: none,zlib@openssh.com,zlib
debug2: kex_parse_kexinit: none,zlib@openssh.com,zlib
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug2: kex_parse_kexinit: diffie-hellman-group-exchange-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit: ssh-rsa,ssh-dss
debug2: kex_parse_kexinit: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysat
or.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
debug2: kex_parse_kexinit: aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,arcfour,aes192-cbc,aes256-cbc,rijndael-cbc@lysat
or.liu.se,aes128-ctr,aes192-ctr,aes256-ctr
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: hmac-md5,hmac-sha1,hmac-ripemd160,hmac-ripemd160@openssh.com,hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: none,zlib
debug2: kex_parse_kexinit: none,zlib
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug1: mac_setup_by_id: hmac-md5 from source OpenSSL
debug2: mac_setup: found hmac-md5
debug1: kex: server->client aes128-ctr hmac-md5 none
debug1: mac_setup_by_id: hmac-md5 from source OpenSSL
debug2: mac_setup: found hmac-md5
debug1: kex: client->server aes128-ctr hmac-md5 none
debug1: SSH2_MSG_KEX_DH_GEX_REQUEST(1024<1024<8192) sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_GROUP
debug2: dh_gen_key: priv key bits set: 118/256
debug2: bits set: 494/1024
debug1: SSH2_MSG_KEX_DH_GEX_INIT sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_REPLY
debug3: check_host_in_hostfile: filename /u/cjpdsc/.ssh/known_hosts
debug3: check_host_in_hostfile: filename /etc/ssh/ssh_known_hosts
debug3: check_host_in_hostfile: filename /u/cjpdsc/.ssh/known_hosts
debug3: check_host_in_hostfile: match line 3
debug3: __catgets: NLS setup complete (1), using message catalog openssh.cat
Warning: Permanently added 'dsbdrp2.itg.ti.com' (RSA) to the list of known hosts.
debug2: bits set: 529/1024
debug1: ssh_rsa_verify: signature correct
debug2: kex_derive_keys
debug2: set_newkeys: mode 1
debug1: cipher_init: aes128-ctr from source OpenSSL
debug1: SSH2_MSG_NEWKEYS sent
debug1: expecting SSH2_MSG_NEWKEYS
debug2: set_newkeys: mode 0
debug1: cipher_init: aes128-ctr from source OpenSSL
debug1: SSH2_MSG_NEWKEYS received
debug1: SSH2_MSG_SERVICE_REQUEST sent
debug2: service_accept: ssh-userauth
debug1: SSH2_MSG_SERVICE_ACCEPT received
debug2: key: /u/cjpdsc/.ssh/id_rsa (11656B00)
debug2: key: /u/cjpdsc/.ssh/id_dsa (11652640)
debug3: input_userauth_banner
---------------------------------------------------------------------------
-- UNAUTHORIZED USE MAY RESULT IN CIVIL AND/OR CRIMINAL PROSECUTION. --
---------------------------------------------------------------------------
This is a proprietary system of Texas Instruments Incorporated (TI) or its
licensors. This system is for the use of authorized users only. Individuals
using this system are subject to having all of their activities on this
system monitored and recorded in order to verify that they have appropriate
authority and do not use this system for any inappropriate or unlawful
purpose. Anyone using this system expressly consents to such monitoring.
If monitoring reveals unauthorized, inappropriate or possible unlawful
activity, system personnel will provide information derived from such
monitoring to TI management or outside legal authorities, as appropriate.
Misuse of this system may result in revocation or limitation of an
individual's access to this system in addition to any other appropriate
remedies. Misuse of this system by TI employees may result in disciplinary
action, including termination.
---------------------------------------------------------------------------
debug1: Authentications that can continue: publickey,password,keyboard-interactive
debug3: start over, passed a different list publickey,password,keyboard-interactive
debug3: preferred publickey
debug3: authmethod_lookup publickey
debug3: remaining preferred:
debug3: authmethod_is_enabled publickey
debug1: Next authentication method: publickey
debug1: Offering public key: /u/cjpdsc/.ssh/id_rsa
debug3: send_pubkey_test
debug2: we sent a publickey packet, wait for reply
debug1: Server accepts key: pkalg ssh-rsa blen 277
debug2: input_userauth_pk_ok: fp 98:d4:5f:07:eb:f9:71:8d:f8:8d:71:38:a5:72:4b:0b
debug3: sign_and_send_pubkey
debug1: read PEM private key done: type RSA
debug1: Authentication succeeded (publickey).
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: /home/drpmvs/coz/bin/cozagent.sh -LD,t
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 131072
debug2: channel 0: rcvd ext data 39
debug2: channel 0: rcvd ext data 225
debug2: channel 0: rcvd ext data 49
debug2: channel 0: rcvd ext data 125
debug2: channel 0: rcvd ext data 271
debug2: channel 0: rcvd ext data 69
cozagentNì: version: 1.1.0 2012-03-16
14:37:03.363419ì cozagentIì: version: 1.1.0 2012-03-16
14:37:03.363657ì cozagentIì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
14:37:03.363706ì cozagentDì: cozagent dir: /home/drpmvs/coz/bin
14:37:03.364717ì cozagentDì: cwd: /home/drpmvs
14:37:03.364771ì cozagentDì: PATH:
14:37:03.364794ì cozagentDì: /usr/bin
14:37:03.364805ì cozagentDì: /usr/local/bin
14:37:03.364815ì cozagentDì: /usr/sbin
14:37:03.364826ì cozagentDì: /usr/ccs/bin
14:37:03.364837ì cozagentDì: /usr/ucb
14:37:03.364846ì cozagentDì: /etc
14:37:03.364855ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364863ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364880ì cozagentDì: Waiting for configuration commands...
debug2: channel 0: written 778 to efd 6
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 194
debug2: channel 0: rcvd ext data 78
debug2: channel 0: rcvd ext data 50
debug2: channel 0: rcvd ext data 52
debug2: channel 0: rcvd ext data 53
debug2: channel 0: rcvd ext data 53
debug2: channel 0: rcvd ext data 68
debug2: channel 0: rcvd ext data 245
debug2: channel 0: rcvd ext data 70
14:37:03.384550ì cozagentDì: Set environment variable: 'COZ_SERVER_HOST'
14:37:03.384675ì cozagentDì: Set environment variable: 'COZ_SERVER_PORT'
14:37:03.384699ì cozagentDì: Set environment variable: 'COZ_AUTH_TOKEN'
14:37:03.384714ì cozagentDì: Set environment variable: 'COZ_LOG'
14:37:03.384726ì cozagentDì: target_command='NULL'
14:37:03.384898ì cozagentDì: getpwuid(geteuid()) pw=3034c, pw_shell=/bin/sh
14:37:03.386102ì cozagentDì: target_pid = 10218
14:37:03.386942ì cozagentDì: stdin_dd_pid = 10219
14:37:03.388352ì cozagentDì: stdout_dd_pid = 10220
14:37:03.390608ì cozagentDì: stderr_dd_pid = 10221
14:37:03.399410ì todsn-client(10220)Iì: version: 1.1.0 2012-03-16
14:37:03.399756ì todsn-client(10220)Dì: cmd_arg1ì = -z
14:37:03.399777ì todsn-client(10220)Dì: cmd_arg2ì = //DD:STDOUT
14:37:03.399793ì todsn-client(10220)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port 8041
14:37:03.402678ì fromdsn-client(10219)Iì: version: 1.1.0 2012-03-16
debug2: channel 0: written 1013 to efd 6
debug2: channel 0: rcvd ext data 190
debug2: channel 0: rcvd ext data 313
14:37:03.403225ì fromdsn-client(10219)Dì: cmd_arg1ì = //DD:STDIN
14:37:03.403256ì fromdsn-client(10219)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port
8041
14:37:03.403241ì todsn-client(10221)Iì: version: 1.1.0 2012-03-16
14:37:03.403690ì todsn-client(10221)Dì: cmd_arg1ì = -z
14:37:03.403717ì todsn-client(10221)Dì: cmd_arg2ì = //DD:STDERR
14:37:03.403733ì todsn-client(10221)Dì: Using getaddrinfo() to start connection to server SCMVS4.NSC.COM at port 8041
debug2: channel 0: written 503 to efd 6
fromdsn(DD:STDIN)Nì: 1 records/80 bytes read; 81 bytes written in 0 milliseconds.
todsn(DD:STDERR)Nì: 99 bytes read; 2 records/97 bytes written in 0 milliseconds.
todsn(DD:STDOUT)Nì: 0 bytes read; 0 records/0 bytes written in 0 milliseconds.
debug2: channel 0: rcvd ext data 95
debug2: channel 0: rcvd ext data 95
debug2: channel 0: rcvd ext data 97
debug2: channel 0: rcvd ext data 78
debug2: channel 0: rcvd ext data 63
debug2: channel 0: rcvd ext data 132
debug2: channel 0: rcvd ext data 141
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 75
debug2: channel 0: rcvd ext data 61
debug2: channel 0: rcvd ext data 130
14:37:03.461129ì todsn-client(10220)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.468911ì todsn-client(10221)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.470880ì fromdsn-client(10219)Dì: clientCodePage 'ISO8859-1' (via COZ_CLIENT_CODEPAGE)
14:37:03.563550ì fromdsn-client(10219)Dì: fromdsn(DD:STDIN): , rc=0, msg=""
14:37:03.563752ì fromdsn-client(10219)Dì: server exit_code=0
14:37:03.564039ì fromdsn-client(10219)Dì: transmitted byte counts agree; server sent/received = 81/0, client
received/sent = 81/0
14:37:03.568572ì cozagentEì: Target Program(10218) ended with RC=127
14:37:03.568654ì cozagentDì: STDIN DD Reader(10219) ended with RC=0
14:37:03.643794ì todsn-client(10221)Dì: todsn(DD:STDERR): , rc=0, msg=""
14:37:03.649727ì todsn-client(10220)Dì: todsn(DD:STDOUT): , rc=0, msg=""
14:37:03.651987ì todsn-client(10221)Dì: server exit_code=0
14:37:03.652236ì todsn-client(10221)Dì: transmitted byte counts agree; server sent/received = 0/99, client
received/sent = 0/99
debug2: channel 0: written 1042 to efd 6
debug2: channel 0: rcvd ext data 61
debug2: channel 0: rcvd ext data 128
14:37:03.654549ì todsn-client(10220)Dì: server exit_code=0
14:37:03.654737ì todsn-client(10220)Dì: transmitted byte counts agree; server sent/received = 0/0, client
received/sent = 0/0
debug2: channel 0: written 189 to efd 6
debug2: channel 0: rcvd ext data 233
debug2: channel 0: rcvd eof
debug2: channel 0: output open -> drain
debug1: client_input_channel_req: channel 0 rtype exit-status reply 0
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
14:37:03.770834ì cozagentDì: At least one child I/O process still running, waiting again
14:37:03.772203ì cozagentDì: STDOUT DD Writer(10220) ended with RC=0
14:37:03.772249ì cozagentDì: STDERR DD Writer(10221) ended with RC=0
debug2: channel 0: written 233 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 0.8 seconds
debug1: Bytes per second: stdin 0.0, stdout 0.0, stderr 0.0
debug1: Exit status 127
07:36:52.955135ì CoZLauncherDì: agentStderrThread completed
07:36:52.955394ì CoZLauncherDì: CoZAgent: completed with RC=127
07:36:52.956043ì CoZLauncherDì: SSH process times: elapsed=1360931812 secs, user cpu=0.000000 secs, sys cpu=0.000000
secs
07:36:52.956107ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959056ì CoZLauncherDì: serverStderrThread completed
07:36:52.959444ì CoZLauncherEì: drpmvs@dsbdrp2.itg.ti.com target command '<default shell>' ended with RC=127
07:36:52.959488ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959645ì CoZLauncherDì: kill() failed for child process CoZServer (33554719): 139ì EDC5139I Operation not
permitted. (errno2=0x0D100114)
07:36:52.959681ì CoZLauncherDì: Waiting for CoZServer
07:36:52.959733ì CoZLauncherDì: CoZServer (33554719) ended with RC=0
07:36:52.962181ì CoZLauncherDì: agentStdoutThread completed
07:36:52.968140ì CoZLauncherIì: CoZLauncher ended with RC=127
CoZAgent: drpmvs@dsbdrp2 target program '/bin/sh' PID: 10218
CoZAgent: completed with RC=127
14:37:03.387018ì cozagentDì: About to execute shell -/bin/sh
/bin/env: No such file or directory
Re: /bin/sh exit code 127
You are getting a RC=127 (exitcode=-1) because:
/bin/env: No such file or directory
I don't know where the env command is on this system. Maybe /usr/bin/env ?
As I said before, the unprefixed "env" command was not found in your original run, leading me to think that the shell profile is not set up on this account/server to set PATH properly.
If you can get "/usr/bin/env" (or wherever it lives) to run, you will get output to prove it.
Can you login with ssh to this account and server? When you do is the PATH setup properly? When you do, is the default shell "/bin/sh" ?
/bin/env: No such file or directory
I don't know where the env command is on this system. Maybe /usr/bin/env ?
As I said before, the unprefixed "env" command was not found in your original run, leading me to think that the shell profile is not set up on this account/server to set PATH properly.
If you can get "/usr/bin/env" (or wherever it lives) to run, you will get output to prove it.
Can you login with ssh to this account and server? When you do is the PATH setup properly? When you do, is the default shell "/bin/sh" ?
Re: /bin/sh exit code 127
As I mentioned previously, I am submitting the same jobstream from 2 different z/os systems, and one of them works and the other doesn't. /bin/env is the correct location, and /bin/sh is the default shell. Both jobstreams use the same login id. I know I am doing something wrong, but I just don't know what it is yet. I will keep struggling with it.
Re: /bin/sh exit code 127
Just to check - you are running jobs from two different LPARs to the same target server and the same target server userid - and from one LPAR it works and the other it does not?
If so, this is really curious. The problem that you are having looks to me to be at problem with the shell on the target server - it doesn't seem to have its PATH configured properly. This could be affected if the shell profile script(s) (again on the target system) was not setup correctly. But I don't see how the origin LPAR would affect this.
I don't think that it is related, but I do see this problem:
07:36:52.959645ì CoZLauncherDì: kill() failed for child process CoZServer (33554719): 139ì EDC5139I Operation not
permitted. (errno2=0x0D100114)
this is a problem on the z/OS side, and usually indicates that your z/OS userid doesn't have its own OMVS segment - rather it is using the "default OMVS segment". Using a userid that points to the "default OMVS segment" is not supported, since there are APIs that don't work (like the ability to kill() your own process). So, you may want to correct this problem to see if it has any effect on the odd results that you are seeing.
If so, this is really curious. The problem that you are having looks to me to be at problem with the shell on the target server - it doesn't seem to have its PATH configured properly. This could be affected if the shell profile script(s) (again on the target system) was not setup correctly. But I don't see how the origin LPAR would affect this.
I don't think that it is related, but I do see this problem:
07:36:52.959645ì CoZLauncherDì: kill() failed for child process CoZServer (33554719): 139ì EDC5139I Operation not
permitted. (errno2=0x0D100114)
this is a problem on the z/OS side, and usually indicates that your z/OS userid doesn't have its own OMVS segment - rather it is using the "default OMVS segment". Using a userid that points to the "default OMVS segment" is not supported, since there are APIs that don't work (like the ability to kill() your own process). So, you may want to correct this problem to see if it has any effect on the odd results that you are seeing.