/bin/sh exit code 127

Discussion of the Co:Z Toolkit Dataset Pipes utilities
Post Reply
sdean4
Posts: 25
Joined: Wed Nov 07, 2012 2:05 pm

/bin/sh exit code 127

Post by sdean4 »

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:
CoZLauncherEì: 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ì cozagentDì: About to execute -/bin/sh -c /bin/sh
env: No such file or directory

What is rc=127?
thanks,
Sandy
dovetail
Site Admin
Posts: 2022
Joined: Thu Jul 29, 2004 12:12 pm

Re: /bin/sh exit code 127

Post by dovetail »

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
sdean4
Posts: 25
Joined: Wed Nov 07, 2012 2:05 pm

Re: /bin/sh exit code 127

Post by sdean4 »

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=&REGSIZE,
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ì CoZLauncherNì: version: 2.3.1 2013-01-23
12:36:39.930976ì CoZLauncherNì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
12:36:39.931001ì CoZLauncherDì: target_user="drpmvs", target_host="dsbdrp2.itg.ti.com", target_port="NULL"
12:36:39.931077ì CoZLauncherDì: sysname=CPU1, user=CJPDSC, uid=0, euid=0, pid=50331752, ppid=1
12:36:39.931109ì CoZLauncherDì: region size requested = 32768K, Actual below/above limit = 10216K / 65536K
07:36:39.944366ì CoZLauncherIì: Agent output WTO is OFF
07:36:39.944423ì CoZLauncherIì: ssh tunnelling is OFF
07:36:39.944442ì CoZLauncherDì: server-path=/usr/local/coz/bin/cozserver
07:36:39.944462ì CoZLauncherDì: server-ports=8040-8048
07:36:39.944478ì CoZLauncherDì: ssh-tunnel=false
07:36:39.944495ì CoZLauncherDì: ssh-le-options=HEAP(8M,1M,,FREE),ENVAR("_CEE_REALLOC_CONTROL=256K,25")
07:36:39.944515ì CoZLauncherDì: server-env-COZ_TRSUB_US-ASCII=ISO8859-1
07:36:39.944534ì CoZLauncherDì: ssh-options=-vvv
07:36:39.944550ì CoZLauncherDì: agent-path=/home/drpmvs/coz/bin/cozagent.sh
07:36:39.944567ì CoZLauncherDì: agent-options=-LD,t
07:36:39.944587ì CoZLauncherDì: target-env-COZ_LOG=D,t
07:36:39.944606ì CoZLauncherDì: server-env-_BPXK_INET_FASTPATH=*
07:36:39.944623ì CoZLauncherDì: server-host=SCMVS4.NSC.COM
07:36:39.945940ì CoZLauncherDì: Set server environment variable:'COZ_TRSUB_US-ASCII'='ISO8859-1'
07:36:39.945995ì CoZLauncherDì: Set server environment variable:'_BPXK_INET_FASTPATH'='*'
07:36:39.947571ì CoZLauncherDì: open(/dev/random) - EDC5157I An internal error has occurred. (errno2=0x05DA05FC)
07:36:39.947599ì CoZLauncherDì: /dev/random (ICSF) not available, using random()
07:36:39.947679ì CoZLauncherDì: Server port range: 8040-8048
07:36:39.947700ì CoZLauncherDì: Attempting to start socket listener on port 8040
07:36:40.434741ì CoZLauncherDì: Attempting to start socket listener on port 8041
07:36:40.435113ì CoZLauncherIì: CoZServer listener socket bound to: 0.0.0.0:8041
07:36:40.435273ì CoZLauncherDì: server_cmd...
/usr/local/coz/bin/cozserver -sockfd 3
07:36:40.442527ì CoZLauncherDì: Started CoZServer process: 33554719
07:36:40.450756ì CoZLauncherDì: arg3ì = '-vvv'
07:36:40.450823ì CoZLauncherDì: arg0ì = '-LD,t'
07:36:40.450840ì CoZLauncherDì: agent_cmd...
/bin/ssh -l drpmvs -vvv dsbdrp2.itg.ti.com /home/drpmvs/coz/bin/cozagent.sh -LD,t
07:36:40.459723ì CoZLauncherDì: Started CoZAgent process: 33555122
07:36:40.461040ì CoZLauncherDì: About to start target command: ''
07:36:40.616943ì CoZLauncherDì: 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

cozagentNì: version: 1.1.0 2012-03-16
14:37:03.363419ì cozagentIì: version: 1.1.0 2012-03-16
14:37:03.363657ì cozagentIì: Copyright (C) Dovetailed Technologies, LLC. 2006. All rights reserved.
14:37:03.363706ì cozagentDì: cozagent dir: /home/drpmvs/coz/bin
14:37:03.364717ì cozagentDì: cwd: /home/drpmvs
14:37:03.364771ì cozagentDì: PATH:
14:37:03.364794ì cozagentDì: /usr/bin
14:37:03.364805ì cozagentDì: /usr/local/bin
14:37:03.364815ì cozagentDì: /usr/sbin
14:37:03.364826ì cozagentDì: /usr/ccs/bin
14:37:03.364837ì cozagentDì: /usr/ucb
14:37:03.364846ì cozagentDì: /etc
14:37:03.364855ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364863ì cozagentDì: /home/drpmvs/coz/bin
14:37:03.364880ì cozagentDì: 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ì cozagentDì: Set environment variable: 'COZ_SERVER_HOST'
14:37:03.384675ì cozagentDì: Set environment variable: 'COZ_SERVER_PORT'
14:37:03.384699ì cozagentDì: Set environment variable: 'COZ_AUTH_TOKEN'
14:37:03.384714ì cozagentDì: Set environment variable: 'COZ_LOG'
14:37:03.384726ì cozagentDì: target_command='NULL'
14:37:03.384898ì cozagentDì: getpwuid(geteuid()) pw=3034c, pw_shell=/bin/sh
14:37:03.386102ì cozagentDì: target_pid = 10218
14:37:03.386942ì cozagentDì: stdin_dd_pid = 10219
14:37:03.388352ì cozagentDì: stdout_dd_pid = 10220
14:37:03.390608ì cozagentDì: 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_arg1ì = -z
14:37:03.399777ì todsn-client(10220)Dì: cmd_arg2ì = //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_arg1ì = //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_arg1ì = -z
14:37:03.403717ì todsn-client(10221)Dì: cmd_arg2ì = //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ì cozagentEì: Target Program(10218) ended with RC=127
14:37:03.568654ì cozagentDì: 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ì cozagentDì: At least one child I/O process still running, waiting again
14:37:03.772203ì cozagentDì: STDOUT DD Writer(10220) ended with RC=0
14:37:03.772249ì cozagentDì: 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ì CoZLauncherDì: agentStderrThread completed
07:36:52.955394ì CoZLauncherDì: CoZAgent: completed with RC=127
07:36:52.956043ì CoZLauncherDì: SSH process times: elapsed=1360931812 secs, user cpu=0.000000 secs, sys cpu=0.000000
secs
07:36:52.956107ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959056ì CoZLauncherDì: serverStderrThread completed
07:36:52.959444ì CoZLauncherEì: drpmvs@dsbdrp2.itg.ti.com target command '<default shell>' ended with RC=127
07:36:52.959488ì CoZLauncherDì: Killing child process CoZServer (33554719) with signal 15
07:36:52.959645ì CoZLauncherDì: kill() failed for child process CoZServer (33554719): 139ì EDC5139I Operation not
permitted. (errno2=0x0D100114)
07:36:52.959681ì CoZLauncherDì: Waiting for CoZServer
07:36:52.959733ì CoZLauncherDì: CoZServer (33554719) ended with RC=0
07:36:52.962181ì CoZLauncherDì: agentStdoutThread completed
07:36:52.968140ì CoZLauncherIì: CoZLauncher ended with RC=127
CoZAgent: drpmvs@dsbdrp2 target program '/bin/sh' PID: 10218
CoZAgent: completed with RC=127
14:37:03.387018ì cozagentDì: About to execute shell -/bin/sh
/bin/env: No such file or directory
dovetail
Site Admin
Posts: 2022
Joined: Thu Jul 29, 2004 12:12 pm

Re: /bin/sh exit code 127

Post by dovetail »

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" ?
sdean4
Posts: 25
Joined: Wed Nov 07, 2012 2:05 pm

Re: /bin/sh exit code 127

Post by sdean4 »

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.
dovetail
Site Admin
Posts: 2022
Joined: Thu Jul 29, 2004 12:12 pm

Re: /bin/sh exit code 127

Post by dovetail »

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ì CoZLauncherDì: 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.
Post Reply