OS환경 : Oracle Linux 6.8 (64bit)
DB 환경 : Oracle Database 11.2.0.4
방법 : 오라클 11g R2 리스너 접속 기록 확인 방법
오라클 리스너로 접속한 기록을 확인하는 방법에 대해 설명함
또는 패스워드를 자주 틀려서 계정을 lock 상태로 만드는 클라이언트를 찾는 방법을 설명함
방법1. 기본 리스너 로그 확인
방법2. 리스너 트레이스 로그 확인
방법3. audit OS 로그 확인
접속 정보는 아래와 같음
DB서버(11gR2 DB / 192.168.10.0.30 / hostname : ORACLE11)
클라이언트(12cR2 Client / 192.168.0.40 / hostname : ORACLE12)
사전설정
테스트 유저 생성 및 권한부여
|
1
2
3
4
5
6
7
|
SQL> create user imsi identified by imsi account unlock quota unlimited on users;
User created.
SQL> grant resource, connect, dba to imsi;
Grant succeeded.
|
방법1. 기본 리스너 로그 확인
DB서버 listener.ora 파일 설정
|
1
2
3
4
5
6
7
8
|
$ vi $ORACLE_HOME/network/admin/listener.ora
LISTENER =
(DESCRIPTION_LIST =
(DESCRIPTION =
(ADDRESS = (PROTOCOL = TCP)(HOST = ORACLE11)(PORT = 1521))
(ADDRESS = (PROTOCOL = IPC)(KEY = EXTPROC1521))
)
)
|
DB서버 리스너 기동
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
|
$ lsnrctl start
LSNRCTL for Linux: Version 11.2.0.4.0 - Production on 22-APR-2021 06:19:56
Copyright (c) 1991, 2013, Oracle. All rights reserved.
Starting /oracle/app/oracle/product/11.2.0/db_1/bin/tnslsnr: please wait...
TNSLSNR for Linux: Version 11.2.0.4.0 - Production
System parameter file is /oracle/app/oracle/product/11.2.0/db_1/network/admin/listener.ora
Log messages written to /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/alert/log.xml
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=ORACLE11)(PORT=1521)))
Listening on: (DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ORACLE11)(PORT=1521)))
STATUS of the LISTENER
------------------------
Alias LISTENER
Version TNSLSNR for Linux: Version 11.2.0.4.0 - Production
Start Date 22-APR-2021 06:19:56
Uptime 0 days 0 hr. 0 min. 0 sec
Trace Level off
Security ON: Local OS Authentication
SNMP OFF
Listener Parameter File /oracle/app/oracle/product/11.2.0/db_1/network/admin/listener.ora
Listener Log File /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/alert/log.xml
Listening Endpoints Summary...
(DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=ORACLE11)(PORT=1521)))
(DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
The listener supports no services
The command completed successfully
|
리스너 로그 경로는 /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/trace 임
클라이언트 tnsnaems.ora 파일 설정
|
1
2
3
4
5
6
7
8
9
|
$ vi $ORACLE_HOME/network/admin/tnsnames.ora
ORCL11 =
(DESCRIPTION =
(ADDRESS = (PROTOCOL = TCP)(HOST = 192.168.0.30)(PORT = 1521))
(CONNECT_DATA =
(SERVER = DEDICATED)
(SERVICE_NAME = ORCL11)
)
)
|
DB서버에서 리스너 로그 tail로 확인
|
1
2
3
|
$ cd /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/trace/
$ tail -f listener.log
대기
|
클라이언트에서 tnsping 테스트
|
1
2
3
4
5
6
7
8
9
10
11
12
|
$ tnsping orcl11
TNS Ping Utility for Linux: Version 12.2.0.1.0 - Production on 21-APR-2021 21:21:14
Copyright (c) 1997, 2016, Oracle. All rights reserved.
Used parameter files:
Used TNSNAMES adapter to resolve the alias
Attempting to contact (DESCRIPTION = (ADDRESS = (PROTOCOL = TCP)(HOST = 192.168.0.30)(PORT = 1521)) (CONNECT_DATA = (SERVER = DEDICATED) (SERVICE_NAME = ORCL11)))
OK (0 msec)
|
DB서버에서 리스너 로그 확인(계속 tail 유지)
|
1
2
3
|
$ cd /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/trace/
$ tail -f listener.log
22-APR-2021 06:25:19 * ping * 0
|
tnsping 시 리스너 로그에 * ping * 0 으로 기록이 남음
클라이언트에서 접속성공 테스트
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
|
$ sqlplus imsi/imsi@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 21:26:21 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to:
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
SQL> select instance_name from v$instance;
INSTANCE_NAME
----------------
ORCL11
|
DB서버에서 리스너 로그 확인(계속 tail 유지)
|
1
2
3
4
5
|
$ cd /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/trace/
$ tail -f listener.log
22-APR-2021 06:30:26 * (CONNECT_DATA=(SERVER=DEDICATED)(SERVICE_NAME=ORCL11)(CID=(PROGRAM=sqlplus)(HOST=ORACLE12)(USER=oracle)))
* (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=21148)) * establish * ORCL11 * 0
22-APR-2021 06:30:26 * service_update * ORCL11 * 0
|
현재 DB서버의 SERVICE_NAME인 ORCL11에
클라이언트 IP가 192.168.0.40이고 HOSTNAME이 ORACLE12인 oracle(OS유저)가 sqlplus로 접속한 기록이 남음
클라이언트에서 접속실패 테스트(패스워드를 틀리는 경우)
|
1
2
3
4
5
6
7
8
9
10
11
|
$ sqlplus imsi/imsi1@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 21:32:27 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
ERROR:
ORA-01017: invalid username/password; logon denied
Enter user-name:
|
DB서버에서 리스너 로그 확인
|
1
2
3
4
|
$ cd /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/trace/
$ tail -f listener.log
22-APR-2021 06:36:31 * (CONNECT_DATA=(SERVER=DEDICATED)(SERVICE_NAME=ORCL11)(CID=(PROGRAM=sqlplus)(HOST=ORACLE12)(USER=oracle)))
* (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=21198)) * establish * ORCL11 * 0
|
현재 DB서버의 SERVICE_NAME인 ORCL11에
클라이언트 IP가 192.168.0.40이고 HOSTNAME이 ORACLE12인 oracle(OS유저)가 sqlplus로 접속한 기록이 남음
접속을 성공한 경우와 실패한 경우 로그 비교
|
1
2
3
4
5
6
|
접속 성공
22-APR-2021 06:30:26 * (CONNECT_DATA=(SERVER=DEDICATED)(SERVICE_NAME=ORCL11)(CID=(PROGRAM=sqlplus)(HOST=ORACLE12)(USER=oracle)))
* (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=21148)) * establish * ORCL11 * 0
접속 실패
22-APR-2021 06:36:31 * (CONNECT_DATA=(SERVER=DEDICATED)(SERVICE_NAME=ORCL11)(CID=(PROGRAM=sqlplus)(HOST=ORACLE12)(USER=oracle)))
* (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=21198)) * establish * ORCL11 * 0
|
접속 성공유무를 알수없고 모두 동일한 로그가 발생함
방법2. 리스너 트레이스 로그 확인
리스너 로그용 폴더 생성
|
1
|
$ mkdir -p /home/oracle/lsnr/log
|
listener.ora 파일 수정
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
|
$ vi $ORACLE_HOME/network/admin/listener.ora
LISTENER =
(DESCRIPTION_LIST =
(DESCRIPTION =
(ADDRESS = (PROTOCOL = TCP)(HOST = ORACLE11)(PORT = 1521))
(ADDRESS = (PROTOCOL = IPC)(KEY = EXTPROC1521))
)
)
DIAG_ADR_ENABLED_LISTENER = OFF
TRACE_LEVEL_LISTENER = 16
TRACE_FILE_LISTENER = listener_trace
TRACE_DIRECTORY_LISTENER = /home/oracle/lsnr/log
TRACE_TIMESTAMP_LISTENER = ON
TRACE_FILELEN_LISTENER = 10240 #10MB
TRACE_FILENO_LISTENER = 10
|
옵션 설명
DIAG_ADR_ENABLED_LISTENER : ADR DIAG 저장소 미사용
TRACE_LEVEL_LISTENER : 트레이스 레벨 지정
TRACE_FILE_LISTENER : 트레이스 파일 이름
TRACE_DIRECTORY_LISTENER : 트레이스 파일 경로
TRACE_TIMESTAMP_LISTENER = 트레이스파일 시간기록 설정
TRACE_FILELEN_LISTENER : 트레이스 파일당 최대크기 설정(KB)
TRACE_FILENO_LISTENER = 트레이스 파일 최대갯수 설정
최대 갯수 10개로 설정 후 파일이 모두 10MB가 차면 더이상 로그가 발생하지않음
리스너 reload 및 상태 확인
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
|
리스너 reload
$ lsnrctl reload LISTENER
LSNRCTL for Linux: Version 11.2.0.4.0 - Production on 22-APR-2021 06:43:54
Copyright (c) 1991, 2013, Oracle. All rights reserved.
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ORACLE11)(PORT=1521)))
The command completed successfully
상태 조회
$ lsnrctl status
LSNRCTL for Linux: Version 11.2.0.4.0 - Production on 22-APR-2021 06:43:59
Copyright (c) 1991, 2013, Oracle. All rights reserved.
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ORACLE11)(PORT=1521)))
STATUS of the LISTENER
------------------------
Alias LISTENER
Version TNSLSNR for Linux: Version 11.2.0.4.0 - Production
Start Date 22-APR-2021 06:19:56
Uptime 0 days 0 hr. 24 min. 2 sec
Trace Level support
Security ON: Local OS Authentication
SNMP OFF
Listener Parameter File /oracle/app/oracle/product/11.2.0/db_1/network/admin/listener.ora
Listener Log File /oracle/app/oracle/product/11.2.0/db_1/network/log/listener.log
Listener Trace File /home/oracle/lsnr/log/listener_trace1.trc
Listening Endpoints Summary...
(DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=ORACLE11)(PORT=1521)))
(DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
Services Summary...
Service "ORCL11" has 1 instance(s).
Instance "ORCL11", status READY, has 1 handler(s) for this service...
The command completed successfully
|
Listener Log File 위치는 10g 이하 버전의 기본 경로($ORACLE_HOME/network/log)로 변경되고
Listener Trace File 이 생기며 listener.ora 파일에 TRACE_DIRECTORY_LISTENER에 설정한 경로에 로그가 생성됨
DB서버에서 트레이스 파일 경로 확인
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
|
$ cd /home/oracle/lsnr/log/
$ ls -al
total 152
drwxr-xr-x 2 oracle dba 4096 Apr 22 06:43 .
drwxr-xr-x 3 oracle dba 4096 Apr 22 01:43 ..
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace10.trc
-rw-r----- 1 oracle dba 147436 Apr 22 06:43 listener_trace1.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace2.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace3.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace4.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace5.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace6.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace7.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace8.trc
-rw-r----- 1 oracle dba 0 Apr 22 06:43 listener_trace9.trc
|
파일이 처음부터 10개가 생성되어있음
DB서버에서 리스너 트레이스 로그 tail 설정
|
1
2
3
4
|
$ cd /home/oracle/lsnr/log/
$ tail -f listener_trace1.trc
================ <- 구분을 위해 ========입력
|
클라이언트에서 tnsping 테스트
|
1
2
3
4
5
6
7
8
9
10
11
12
|
$ tnsping orcl11
TNS Ping Utility for Linux: Version 12.2.0.1.0 - Production on 21-APR-2021 21:50:12
Copyright (c) 1997, 2016, Oracle. All rights reserved.
Used parameter files:
Used TNSNAMES adapter to resolve the alias
Attempting to contact (DESCRIPTION = (ADDRESS = (PROTOCOL = TCP)(HOST = 192.168.0.30)(PORT = 1521)) (CONNECT_DATA = (SERVER = DEDICATED) (SERVICE_NAME = ORCL11)))
OK (10 msec)
|
DB서버에서 리스너 트레이스 로그 확인(계속 tail 유지)
200줄이 넘어서 몇줄만 가져옴
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
|
$ cd /home/oracle/lsnr/log/
$ tail -f listener_trace1.trc
================ <- 구분을 위해 ========입력
[000001 22-APR-2021 06:54:17:114] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 06:54:17:114] nsevfnt: cxd: 0x1b330f0 stage 0: NT events set:
CONNECTION REQUEST
[000001 22-APR-2021 06:54:17:114] nsevfnt: cxd: 0x1b330f0 stage 0: NS events set:
INCOMING CALL
.
.
[000001 22-APR-2021 06:54:17:115] snlinGetNameInfo: entry
[000001 22-APR-2021 06:54:17:115] snlinGetNameInfo: exit
[000001 22-APR-2021 06:54:17:115] nttcnr: connected on ipaddr 192.168.0.30
[000001 22-APR-2021 06:54:17:115] nttvlser: entry
[000001 22-APR-2021 06:54:17:115] snlinGetNameInfo: entry
[000001 22-APR-2021 06:54:17:115] snlinGetNameInfo: exit
[000001 22-APR-2021 06:54:17:115] nttvlser: valid node check on incoming node 192.168.0.40
[000001 22-APR-2021 06:54:17:115] nttvlser: Accepted Entry: 192.168.0.40
[000001 22-APR-2021 06:54:17:115] nttcnr: exit
[000001 22-APR-2021 06:54:17:115] nttcon: NT layer TCP/IP connection has been established.
[000001 22-APR-2021 06:54:17:115] nttcon: set TCP_NODELAY on 25
[000001 22-APR-2021 06:54:17:115] nttcon: exit
[000001 22-APR-2021 06:54:17:115] nsopen: transport is open
.
.
[000001 22-APR-2021 06:54:17:122] nsglhe: entry
[000001 22-APR-2021 06:54:17:122] nsglhe: Event on cxd 0x1b59550.
[000001 22-APR-2021 06:54:17:122] nsglfc: command = ping
[000001 22-APR-2021 06:54:17:122] nsglauthorized: entry
[000001 22-APR-2021 06:54:17:122] nsglauthorized: Determining auth method...
[000001 22-APR-2021 06:54:17:122] nsglauthorized: No authorization needed.
.
.
[000001 22-APR-2021 06:54:17:129] nsevwait: 4 registered connection(s)
[000001 22-APR-2021 06:54:17:129] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 06:54:17:129] nsevwait: waiting for transport event (1 thru 5)...
|
많은 정보가 있지만 모두 해석하지 못하기에 몇가지만 찾아봄
17번째 줄에 incoming node 뒤에 클라이언트의 IP가 기록됨
28번째 줄에 command 가 ping이라는 것을 확인할 수 있음
*서버의 ntp 시간이 달라서 시간이 다르게보임
클라이언트에서 접속성공 테스트
|
1
2
3
4
5
6
7
8
9
10
11
12
|
$ sqlplus imsi/imsi@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 23:03:32 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to:
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
SQL>
|
DB서버에서 리스너 트레이스 로그 확인(계속 tail 유지)
더보기
성공
[000001 22-APR-2021 08:07:37:441] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:442] nsevfnt: cxd: 0x1b330f0 stage 0: NT events set:
CONNECTION REQUEST
[000001 22-APR-2021 08:07:37:442] nsevfnt: cxd: 0x1b330f0 stage 0: NS events set:
INCOMING CALL
[000001 22-APR-2021 08:07:37:442] nsevrec: event is 0x1, on 1
[000001 22-APR-2021 08:07:37:442] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:07:37:442] nsevwait: exit (0)
[000001 22-APR-2021 08:07:37:442] nsglhe: entry
[000001 22-APR-2021 08:07:37:442] nsglhe: Event on cxd 0x1b330f0.
[000001 22-APR-2021 08:07:37:442] nsglhc: Allocating cxd 0x1b59550
[000001 22-APR-2021 08:07:37:442] nsanswer: entry
[000001 22-APR-2021 08:07:37:442] nsopen: entry
[000001 22-APR-2021 08:07:37:442] nsmal: entry
[000001 22-APR-2021 08:07:37:442] nsmal: 1576 bytes at 0x1b6c260
[000001 22-APR-2021 08:07:37:442] nsmal: normal exit
[000001 22-APR-2021 08:07:37:442] nsopenmplx: entry
[000001 22-APR-2021 08:07:37:442] nsmal: entry
[000001 22-APR-2021 08:07:37:442] nsmal: 2760 bytes at 0x1b6a790
[000001 22-APR-2021 08:07:37:442] nsmal: normal exit
[000001 22-APR-2021 08:07:37:442] nsiorini: entry
[000001 22-APR-2021 08:07:37:442] nsbal: entry
[000001 22-APR-2021 08:07:37:442] nsbgetfl: entry
[000001 22-APR-2021 08:07:37:442] nsbgetfl: normal exit
[000001 22-APR-2021 08:07:37:442] nsbal: normal exit
[000001 22-APR-2021 08:07:37:442] nsiorini: exit (0)
[000001 22-APR-2021 08:07:37:442] nscpxget: entry
[000001 22-APR-2021 08:07:37:442] nscpxget: normal exit
[000001 22-APR-2021 08:07:37:442] nsopenalloc_nsntx: nlhthput on mplx_ht_nsgbu:ctx=1b6c260, nsntx=1b6a790
[000001 22-APR-2021 08:07:37:442] nsopenmplx: normal exit
[000001 22-APR-2021 08:07:37:443] nstoSetupTimeout: entry
[000001 22-APR-2021 08:07:37:443] nstoSetupTimeout: ATO enabled for ctx=0x0x1b6c260, val=60000(millisecs)
[000001 22-APR-2021 08:07:37:443] nstoUpdateActive: entry
[000001 22-APR-2021 08:07:37:443] nstoUpdateActive: Active timeout is 0 (see nstotyp)
[000001 22-APR-2021 08:07:37:443] nsopen: opening transport...
[000001 22-APR-2021 08:07:37:443] nttcon: entry
[000001 22-APR-2021 08:07:37:443] nttcon: toc = 3
[000001 22-APR-2021 08:07:37:443] nttcnp: entry
[000001 22-APR-2021 08:07:37:443] nttcnp: getting sockname
[000001 22-APR-2021 08:07:37:443] nttcnp: getting peername
[000001 22-APR-2021 08:07:37:443] nttcnp: exit
[000001 22-APR-2021 08:07:37:443] nttcnr: entry
[000001 22-APR-2021 08:07:37:443] nttcnr: waiting to accept a connection.
[000001 22-APR-2021 08:07:37:444] nttcnr: getting sockname
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:444] nttcnr: connected on ipaddr 192.168.0.30
[000001 22-APR-2021 08:07:37:444] nttvlser: entry
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:444] nttvlser: valid node check on incoming node 192.168.0.40
[000001 22-APR-2021 08:07:37:444] nttvlser: Accepted Entry: 192.168.0.40
[000001 22-APR-2021 08:07:37:444] nttcnr: exit
[000001 22-APR-2021 08:07:37:444] nttcon: NT layer TCP/IP connection has been established.
[000001 22-APR-2021 08:07:37:444] nttcon: set TCP_NODELAY on 25
[000001 22-APR-2021 08:07:37:444] nttcon: exit
[000001 22-APR-2021 08:07:37:444] nsopen: transport is open
[000001 22-APR-2021 08:07:37:444] nstoPostNTConn: entry
[000001 22-APR-2021 08:07:37:444] nstoArmEventATO: entry
[000001 22-APR-2021 08:07:37:445] nstoArmEventATO: exit (0)
[000001 22-APR-2021 08:07:37:445] nstoPostNTConn: exit (0)
[000001 22-APR-2021 08:07:37:445] nsnainit: entry
[000001 22-APR-2021 08:07:37:445] nsnainit: answer
[000001 22-APR-2021 08:07:37:445] nsnadct: entry
[000001 22-APR-2021 08:07:37:445] nsnadct: normal exit
[000001 22-APR-2021 08:07:37:445] nsnasvnainfo: entry
[000001 22-APR-2021 08:07:37:445] nsnasvnainfo: NA disabled for this connection
[000001 22-APR-2021 08:07:37:445] nsnasvnainfo: normal exit
[000001 22-APR-2021 08:07:37:445] nainit: entry
[000001 22-APR-2021 08:07:37:445] nagblini: entry
[000001 22-APR-2021 08:07:37:445] nau_gin: entry
[000001 22-APR-2021 08:07:37:446] nau_gparams: entry
[000001 22-APR-2021 08:07:37:446] nam_gbp: Reading parameter "sqlnet.authentication_required" from parameter file
[000001 22-APR-2021 08:07:37:446] nam_gbp: Parameter not found
[000001 22-APR-2021 08:07:37:446] nau_gparams: Using default value "FALSE"
[000001 22-APR-2021 08:07:37:446] nau_gslf: entry
[000001 22-APR-2021 08:07:37:446] nam_gic: entry
[000001 22-APR-2021 08:07:37:446] nam_gic: Counting # of items in "sqlnet.authentication_services" parameter
[000001 22-APR-2021 08:07:37:446] nam_gic: Parameter not found
[000001 22-APR-2021 08:07:37:446] nam_gic: Found 0 items
[000001 22-APR-2021 08:07:37:447] nam_gic: exit
[000001 22-APR-2021 08:07:37:447] nau_gslf: Using default value "all available adapters"
[000001 22-APR-2021 08:07:37:447] nauss_set_state: entry
[000001 22-APR-2021 08:07:37:447] nauss_set_state: exit
[000001 22-APR-2021 08:07:37:447] nau_gslf: exit
[000001 22-APR-2021 08:07:37:447] nau_gparams: exit
[000001 22-APR-2021 08:07:37:447] nau_gin: exit
[000001 22-APR-2021 08:07:37:447] nagblini: exit
[000001 22-APR-2021 08:07:37:448] na_saveprot: entry
[000001 22-APR-2021 08:07:37:448] na_saveprot: exit
[000001 22-APR-2021 08:07:37:448] nacomin: entry
[000001 22-APR-2021 08:07:37:448] nas_init: entry
[000001 22-APR-2021 08:07:37:448] nas_init: exit
[000001 22-APR-2021 08:07:37:448] nau_ini: entry
[000001 22-APR-2021 08:07:37:448] naugcp_get_connect_parameters: entry
[000001 22-APR-2021 08:07:37:448] nauss_set_state: entry
[000001 22-APR-2021 08:07:37:448] nauss_set_state: exit
[000001 22-APR-2021 08:07:37:448] naugcp_get_connect_parameters: exit
[000001 22-APR-2021 08:07:37:449] nau_gfauth: entry
[000001 22-APR-2021 08:07:37:449] nam_gbp: Reading parameter "sqlnet.fallback_authentication" from parameter file
[000001 22-APR-2021 08:07:37:449] nam_gbp: Parameter not found
[000001 22-APR-2021 08:07:37:449] nau_gfauth: Using default value "FALSE"
[000001 22-APR-2021 08:07:37:449] nau_gfauth: exit
[000001 22-APR-2021 08:07:37:449] nau_gettab: entry
[000001 22-APR-2021 08:07:37:449] nau_gettab: using authentication adapter table "nautab"
[000001 22-APR-2021 08:07:37:449] nau_gettab: nautab contains the following services:
[000001 22-APR-2021 08:07:37:450] nau_gettab: KERBEROS5
[000001 22-APR-2021 08:07:37:450] nau_gettab: RADIUS
[000001 22-APR-2021 08:07:37:450] nau_gettab: exit
[000001 22-APR-2021 08:07:37:450] nau_sini: entry
[000001 22-APR-2021 08:07:37:450] nau_sini: exit
[000001 22-APR-2021 08:07:37:450] nau_ini: connection type: "standard"
[000001 22-APR-2021 08:07:37:450] nau_ini: exit
[000001 22-APR-2021 08:07:37:450] naeeinit: entry
[000001 22-APR-2021 08:07:37:451] nam_gbp: Reading parameter "SQLNET.FIPS_140" from parameter file
[000001 22-APR-2021 08:07:37:451] nam_gbp: Parameter not found
[000001 22-APR-2021 08:07:37:451] nam_gnsp: Reading parameter "SQLNET.ENCRYPTION_SERVER" from parameter file
[000001 22-APR-2021 08:07:37:451] nam_gnsp: Parameter not found
[000001 22-APR-2021 08:07:37:451] naequad: Using default value "ACCEPTED"
[000001 22-APR-2021 08:07:37:451] nam_gbp: Reading parameter "SQLNET._ENHANCED_LOGON_PROTECTION" from parameter file
[000001 22-APR-2021 08:07:37:451] nam_gbp: Parameter not found
[000001 22-APR-2021 08:07:37:451] nam_gic: entry
[000001 22-APR-2021 08:07:37:452] nam_gic: Counting # of items in "SQLNET.ENCRYPTION_TYPES_SERVER" parameter
[000001 22-APR-2021 08:07:37:452] nam_gic: Parameter not found
[000001 22-APR-2021 08:07:37:452] nam_gic: exit
[000001 22-APR-2021 08:07:37:452] naesno: Using default value "all available algorithms"
[000001 22-APR-2021 08:07:37:452] naeshow: entry
[000001 22-APR-2021 08:07:37:452] naeshow: These are the encryption algorithms that the server will accept, in decreasing order of preference:
[000001 22-APR-2021 08:07:37:452] naeshow: Choice 0: no algorithm; encryption inactive
[000001 22-APR-2021 08:07:37:452] naeshow: Choice 1: 'AES256' (ID 17)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 2: 'RC4_256' (ID 6)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 3: 'AES192' (ID 16)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 4: '3DES168' (ID 12)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 5: 'AES128' (ID 15)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 6: 'RC4_128' (ID 10)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 7: '3DES112' (ID 11)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 8: 'RC4_56' (ID 8)
[000001 22-APR-2021 08:07:37:453] naeshow: Choice 9: 'DES' (ID 2)
[000001 22-APR-2021 08:07:37:454] naeshow: Choice 10: 'RC4_40' (ID 1)
[000001 22-APR-2021 08:07:37:454] naeshow: Choice 11: 'DES40' (ID 3)
[000001 22-APR-2021 08:07:37:454] naeshow: exit
[000001 22-APR-2021 08:07:37:454] naeeinit: exit
[000001 22-APR-2021 08:07:37:454] naecinit: entry
[000001 22-APR-2021 08:07:37:454] nam_gnsp: Reading parameter "SQLNET.CRYPTO_CHECKSUM_SERVER" from parameter file
[000001 22-APR-2021 08:07:37:454] nam_gnsp: Parameter not found
[000001 22-APR-2021 08:07:37:454] naequad: Using default value "ACCEPTED"
[000001 22-APR-2021 08:07:37:455] nam_gic: entry
[000001 22-APR-2021 08:07:37:455] nam_gic: Counting # of items in "SQLNET.CRYPTO_CHECKSUM_TYPES_SERVER" parameter
[000001 22-APR-2021 08:07:37:455] nam_gic: Parameter not found
[000001 22-APR-2021 08:07:37:455] nam_gic: exit
[000001 22-APR-2021 08:07:37:455] naesno: Using default value "all available algorithms"
[000001 22-APR-2021 08:07:37:455] naeshow: entry
[000001 22-APR-2021 08:07:37:455] naeshow: These are the checksumming algorithms that the server will accept, in decreasing order of preference:
[000001 22-APR-2021 08:07:37:455] naeshow: Choice 0: no algorithm; checksumming inactive
[000001 22-APR-2021 08:07:37:455] naeshow: Choice 1: 'SHA1' (ID 3)
[000001 22-APR-2021 08:07:37:456] naeshow: Choice 2: 'MD5' (ID 1)
[000001 22-APR-2021 08:07:37:456] naeshow: exit
[000001 22-APR-2021 08:07:37:456] naecinit: exit
[000001 22-APR-2021 08:07:37:456] nainit: native services disabled - disconnecting
[000001 22-APR-2021 08:07:37:456] nadisc: entry
[000001 22-APR-2021 08:07:37:456] nacomtm: entry
[000001 22-APR-2021 08:07:37:456] nacompd: entry
[000001 22-APR-2021 08:07:37:456] nacompd: exit
[000001 22-APR-2021 08:07:37:457] nacompd: entry
[000001 22-APR-2021 08:07:37:457] nacompd: exit
[000001 22-APR-2021 08:07:37:457] nacomtm: exit
[000001 22-APR-2021 08:07:37:457] nas_dis: entry
[000001 22-APR-2021 08:07:37:457] nas_dis: exit
[000001 22-APR-2021 08:07:37:457] nau_dis: entry
[000001 22-APR-2021 08:07:37:457] nau_dis: exit
[000001 22-APR-2021 08:07:37:457] naeetrm: entry
[000001 22-APR-2021 08:07:37:457] naeetrm: exit
[000001 22-APR-2021 08:07:37:458] naectrm: entry
[000001 22-APR-2021 08:07:37:458] naectrm: exit
[000001 22-APR-2021 08:07:37:458] nagbltrm: entry
[000001 22-APR-2021 08:07:37:458] nau_gtm: entry
[000001 22-APR-2021 08:07:37:458] nau_gtm: exit
[000001 22-APR-2021 08:07:37:458] nagbltrm: exit
[000001 22-APR-2021 08:07:37:458] nadisc: exit
[000001 22-APR-2021 08:07:37:458] nainit: exit
[000001 22-APR-2021 08:07:37:458] nsnainit: NS Connection version: 314
[000001 22-APR-2021 08:07:37:459] nsnainit: inf->nsinfflg[0]: 0xd inf->nsinfflg[1]: 0xd
[000001 22-APR-2021 08:07:37:459] nsnainit: "or" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
[000001 22-APR-2021 08:07:37:459] nsnainit: "or" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
"and" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
[000001 22-APR-2021 08:07:37:459] nsnainit: normal exit
[000001 22-APR-2021 08:07:37:459] nsopen: global context check-in (to slot 6) complete
[000001 22-APR-2021 08:07:37:459] nsopen: lcl[0]=0xf4ffe9ff, lcl[1]=0x12003, gbl[0]=0x7ebf, gbl[1]=0x2001, tdu=65535, sdu=8192
[000001 22-APR-2021 08:07:37:460] nsfull_opn: entry
[000001 22-APR-2021 08:07:37:460] nsfull_opn: cid=6, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x0
[000001 22-APR-2021 08:07:37:460] nsfull_opn: nsctx: state=7, flg=0x4000, mvd=0
[000001 22-APR-2021 08:07:37:460] nsbal: entry
[000001 22-APR-2021 08:07:37:460] nsbgetfl: entry
[000001 22-APR-2021 08:07:37:460] nsbgetfl: normal exit
[000001 22-APR-2021 08:07:37:460] nsbal: normal exit
[000001 22-APR-2021 08:07:37:461] nsbal: entry
[000001 22-APR-2021 08:07:37:461] nsbgetfl: entry
[000001 22-APR-2021 08:07:37:461] nsbgetfl: normal exit
[000001 22-APR-2021 08:07:37:461] nsbal: normal exit
[000001 22-APR-2021 08:07:37:461] nsfull_opn: normal exit
[000001 22-APR-2021 08:07:37:461] nsopen: normal exit
[000001 22-APR-2021 08:07:37:461] nsanswer: deferring connect attempt; at stage 5
[000001 22-APR-2021 08:07:37:461] nsanswer: normal exit
[000001 22-APR-2021 08:07:37:462] nsevreg: entry
[000001 22-APR-2021 08:07:37:462] nsevreg: begin registration process for 6
[000001 22-APR-2021 08:07:37:462] nsevregPrePost: entry
[000001 22-APR-2021 08:07:37:462] nsevregPrePost: normal exit
[000001 22-APR-2021 08:07:37:462] nsevreg: sgt=0, evn=1, evt[2]=0x0
[000001 22-APR-2021 08:07:37:462] nsevreg: begin notification process for 6
[000001 22-APR-2021 08:07:37:462] nsevregAffectNotif: entry
[000001 22-APR-2021 08:07:37:462] nsevregAffectNotif: exit (0)
[000001 22-APR-2021 08:07:37:462] nsevreg: rdm=0, sgt=0, evt[0]=0x20, [1]=0x20, [2]=0x0, nrg=0
[000001 22-APR-2021 08:07:37:463] nsevreg: registering for 0x20
[000001 22-APR-2021 08:07:37:463] nsevreg: normal exit
[000001 22-APR-2021 08:07:37:463] nsglhe: exit
[000001 22-APR-2021 08:07:37:463] nsevwait: entry
[000001 22-APR-2021 08:07:37:463] nsevwait: 5 registered connection(s)
[000001 22-APR-2021 08:07:37:463] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:07:37:463] nsevwait: waiting for transport event (1 thru 6)...
[000001 22-APR-2021 08:07:37:464] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:464] nsevfnt: cxd: 0x1b59550 stage 5: NT events set:
READ
[000001 22-APR-2021 08:07:37:464] nsevfnt: cxd: 0x1b59550 stage 5: NS events set:
OUTGOING CALL COMPLETE
[000001 22-APR-2021 08:07:37:464] nsevdansw: entry
[000001 22-APR-2021 08:07:37:464] nsevdansw: at STAGE 5
[000001 22-APR-2021 08:07:37:464] nsdo: entry
[000001 22-APR-2021 08:07:37:464] nsdo: cid=6, opcode=68, *bl=2040, *what=8, uflgs=0x0, cflgs=0x3
[000001 22-APR-2021 08:07:37:464] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:07:37:465] nsdo: nsctx: state=14, flg=0x20004004, mvd=0
[000001 22-APR-2021 08:07:37:465] nsdo: gtn=10, gtc=10, ptn=10, ptc=8155
[000001 22-APR-2021 08:07:37:465] nscon: entry
[000001 22-APR-2021 08:07:37:465] nscon: doing connect handshake...
[000001 22-APR-2021 08:07:37:465] nscon: recving a packet
[000001 22-APR-2021 08:07:37:465] nsprecv: entry
[000001 22-APR-2021 08:07:37:465] nsprecv: reading from transport...
[000001 22-APR-2021 08:07:37:465] nttrd: entry
[000001 22-APR-2021 08:07:37:466] nttrd: socket 25 had bytes read=243
[000001 22-APR-2021 08:07:37:466] nttrd: exit
[000001 22-APR-2021 08:07:37:466] nsprecv: 243 bytes from transport
[000001 22-APR-2021 08:07:37:466] nsprecv: tlen=243, plen=243, type=1
[000001 22-APR-2021 08:07:37:466] nsprecv: packet dump
[000001 22-APR-2021 08:07:37:466] nsprecv: 00 F3 00 00 01 00 00 00 |........|
[000001 22-APR-2021 08:07:37:466] nsprecv: 01 3C 01 2C 0C 41 20 00 |.<.,.A..|
[000001 22-APR-2021 08:07:37:466] nsprecv: FF FF 7F 08 00 00 01 00 |........|
[000001 22-APR-2021 08:07:37:467] nsprecv: 00 AD 00 46 00 00 14 00 |...F....|
[000001 22-APR-2021 08:07:37:467] nsprecv: 41 41 B5 B7 00 00 00 00 |AA......|
[000001 22-APR-2021 08:07:37:467] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:467] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:467] nsprecv: 00 00 00 00 20 00 00 20 |........|
[000001 22-APR-2021 08:07:37:467] nsprecv: 00 00 00 00 00 00 28 44 |......(D|
[000001 22-APR-2021 08:07:37:467] nsprecv: 45 53 43 52 49 50 54 49 |ESCRIPTI|
[000001 22-APR-2021 08:07:37:467] nsprecv: 4F 4E 3D 28 43 4F 4E 4E |ON=(CONN|
[000001 22-APR-2021 08:07:37:467] nsprecv: 45 43 54 5F 44 41 54 41 |ECT_DATA|
[000001 22-APR-2021 08:07:37:467] nsprecv: 3D 28 53 45 52 56 45 52 |=(SERVER|
[000001 22-APR-2021 08:07:37:467] nsprecv: 3D 44 45 44 49 43 41 54 |=DEDICAT|
[000001 22-APR-2021 08:07:37:467] nsprecv: 45 44 29 28 53 45 52 56 |ED)(SERV|
[000001 22-APR-2021 08:07:37:467] nsprecv: 49 43 45 5F 4E 41 4D 45 |ICE_NAME|
[000001 22-APR-2021 08:07:37:468] nsprecv: 3D 4F 52 43 4C 31 31 29 |=ORCL11)|
[000001 22-APR-2021 08:07:37:468] nsprecv: 28 43 49 44 3D 28 50 52 |(CID=(PR|
[000001 22-APR-2021 08:07:37:468] nsprecv: 4F 47 52 41 4D 3D 73 71 |OGRAM=sq|
[000001 22-APR-2021 08:07:37:468] nsprecv: 6C 70 6C 75 73 29 28 48 |lplus)(H|
[000001 22-APR-2021 08:07:37:468] nsprecv: 4F 53 54 3D 4F 52 41 43 |OST=ORAC|
[000001 22-APR-2021 08:07:37:468] nsprecv: 4C 45 31 32 29 28 55 53 |LE12)(US|
[000001 22-APR-2021 08:07:37:468] nsprecv: 45 52 3D 6F 72 61 63 6C |ER=oracl|
[000001 22-APR-2021 08:07:37:468] nsprecv: 65 29 29 29 28 41 44 44 |e)))(ADD|
[000001 22-APR-2021 08:07:37:468] nsprecv: 52 45 53 53 3D 28 50 52 |RESS=(PR|
[000001 22-APR-2021 08:07:37:468] nsprecv: 4F 54 4F 43 4F 4C 3D 54 |OTOCOL=T|
[000001 22-APR-2021 08:07:37:468] nsprecv: 43 50 29 28 48 4F 53 54 |CP)(HOST|
[000001 22-APR-2021 08:07:37:469] nsprecv: 3D 31 39 32 2E 31 36 38 |=192.168|
[000001 22-APR-2021 08:07:37:469] nsprecv: 2E 30 2E 33 30 29 28 50 |.0.30)(P|
[000001 22-APR-2021 08:07:37:469] nsprecv: 4F 52 54 3D 31 35 32 31 |ORT=1521|
[000001 22-APR-2021 08:07:37:469] nsprecv: 29 29 29 |))) |
[000001 22-APR-2021 08:07:37:469] nsprecv: normal exit
[000001 22-APR-2021 08:07:37:469] nscon: got NSPTCN packet
[000001 22-APR-2021 08:07:37:470] nsconneg: entry
[000001 22-APR-2021 08:07:37:470] nsconneg: vsn=316, lov=300, opt=0xc41, sdu=8192, tdu=65535, ntc=0x7f08
[000001 22-APR-2021 08:07:37:470] nsbralc: entry
[000001 22-APR-2021 08:07:37:470] nsbralc: entry
[000001 22-APR-2021 08:07:37:470] nsbralc: entry
[000001 22-APR-2021 08:07:37:470] nsconneg: vsn=314, gbl=0xc01, sdu=8192, tdu=65535
[000001 22-APR-2021 08:07:37:470] nsconneg: normal exit
[000001 22-APR-2021 08:07:37:470] nscon: got 173 bytes connect data
[000001 22-APR-2021 08:07:37:470] nscon: exit (0)
[000001 22-APR-2021 08:07:37:471] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:07:37:471] nsdo: normal exit
[000001 22-APR-2021 08:07:37:471] nsevdrcvreq: entry
[000001 22-APR-2021 08:07:37:471] nsevdansw: exit
[000001 22-APR-2021 08:07:37:471] nttctl: entry
[000001 22-APR-2021 08:07:37:471] nttctl: Clearing non-blocking mode
[000001 22-APR-2021 08:07:37:471] nsevrec: event is 0x20, on 6
[000001 22-APR-2021 08:07:37:471] nstoToqWalk: entry
[000001 22-APR-2021 08:07:37:471] nstoToqWalk: exit (0)
[000001 22-APR-2021 08:07:37:471] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:07:37:472] nsevwait: exit (0)
[000001 22-APR-2021 08:07:37:472] nsglhe: entry
[000001 22-APR-2021 08:07:37:472] nsglhe: Event on cxd 0x1b59550.
[000001 22-APR-2021 08:07:37:472] nsglfc: Assume establishing a connection...
[000001 22-APR-2021 08:07:37:472] nsglfc: command = establish
[000001 22-APR-2021 08:07:37:472] nsglauthorized: entry
[000001 22-APR-2021 08:07:37:472] nsglauthorized: Determining auth method...
[000001 22-APR-2021 08:07:37:472] nsglauthorized: No authorization needed.
[000001 22-APR-2021 08:07:37:473] nsglecmd: entry
[000001 22-APR-2021 08:07:37:473] nscontrol: entry
[000001 22-APR-2021 08:07:37:473] nstoControlATO: entry
[000001 22-APR-2021 08:07:37:473] nstoClearTimeout: entry
[000001 22-APR-2021 08:07:37:473] nstoClearTimeout: ATO disabled for ctx=0x0x1b6c260
[000001 22-APR-2021 08:07:37:473] nstoUpdateActive: entry
[000001 22-APR-2021 08:07:37:473] nstoUpdateActive: Active timeout is -1 (see nstotyp)
[000001 22-APR-2021 08:07:37:473] nstoControlATO: ATO disabled for ctx=0x0x1b6c260
[000001 22-APR-2021 08:07:37:473] nstoControlATO: exit (0)
[000001 22-APR-2021 08:07:37:473] nscontrol: cmd=26, lcl=0x0
[000001 22-APR-2021 08:07:37:474] nscontrol: normal exit
[000001 22-APR-2021 08:07:37:474] nttaddr2bnd: entry
[000001 22-APR-2021 08:07:37:474] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:474] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:474] nttaddr2bnd: Resolved to 192.168.0.40
[000001 22-APR-2021 08:07:37:474] nttaddr2bnd: exit
[000001 22-APR-2021 08:07:37:474] nsglbgetRSPidx: entry
[000001 22-APR-2021 08:07:37:475] nsglbgetRSPidx: returning ecode=0
[000001 22-APR-2021 08:07:37:475] nsglbgetRSPidx: exit
[000001 22-APR-2021 08:07:37:475] nsgettrans_bycxdwattr: entry
[000001 22-APR-2021 08:07:37:475] ntgettrans: entry
[000001 22-APR-2021 08:07:37:475] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:475] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:475] snlinGetAddrInfo: entry
[000001 22-APR-2021 08:07:37:476] snlinGetAddrInfo: exit
[000001 22-APR-2021 08:07:37:476] snlinFreeAddrInfo: entry
[000001 22-APR-2021 08:07:37:476] snlinFreeAddrInfo: exit
[000001 22-APR-2021 08:07:37:476] ntgettrans: exit
[000001 22-APR-2021 08:07:37:476] nsgettrans_bycxdwattr: exit
[000001 22-APR-2021 08:07:37:476] nsglbgetSdPidx: secondary protocol=4
[000001 22-APR-2021 08:07:37:476] nsglb: entry
[000001 22-APR-2021 08:07:37:476] nsglb: instance:ORCL11 new lbscore:1
[000001 22-APR-2021 08:07:37:477] nsglb: exit
[000001 22-APR-2021 08:07:37:477] nsbequeath: entry
[000001 22-APR-2021 08:07:37:477] nsc2addr: entry
[000001 22-APR-2021 08:07:37:477] nlpcaini: entry
[000001 22-APR-2021 08:07:37:477] nlpcaini: prg = /oracle/app/oracle/product/11.2.0/db_1/bin/oracle
[000001 22-APR-2021 08:07:37:477] nlpcaini: arg[0] = oracleORCL11
[000001 22-APR-2021 08:07:37:478] nlpcaini: arg[1] = (LOCAL=NO)
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[0] = HOSTNAME=ORACLE11
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[1] = SHELL=/bin/bash
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[2] = TERM=xterm
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[3] = HISTSIZE=1000
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[4] = TMPDIR=/tmp
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[5] = QTDIR=/usr/lib64/qt-3.3
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[6] = QTINC=/usr/lib64/qt-3.3/include
[000001 22-APR-2021 08:07:37:478] nlpcaini: env[7] = USER=oracle
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[8] = LD_LIBRARY_PATH=/oracle/app/oracle/product/11.2.0/db_1/lib:/lib:/usr/lib
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[9] = LS_COLORS=rs=0:di=01;34:ln=01;36:mh=00:pi=40;33:so=01;35:do=01;35:bd=40;33;01:cd=40;33;01:or=40;31;01:mi=01;05;37;41:su=37;41:sg=30;43:ca=30;41:tw=30;42:ow=34;42:st=37;44:ex=01;32:*.tar=01;31:*.tgz=01;31:*.arj=01;31:*.taz=01;31:*.lzh=01;31:*.lzma=01;31:*.tlz=01;31:*.txz=01;31:*.zip=01;31:*.z=01;31:*.Z=01;31:*.dz=01;31:*.gz=01;31:*.lz=01;31:*.xz=01;31:*.bz2=01;31:*.tbz=01;31:*.tbz2=01;31:*.bz=01;31:*.tz=01;31:*.deb=01;31:*.rpm=01;31:*.jar=01;31:*.rar=01;31:*.ace=01;31:*.zoo=01;31:*.cpio=01;31:*.7z=01;31:*.rz=01;31:*.jpg=01;35:*.jpeg=01;35:*.gif=01;35:*.bmp=01;35:*.pbm=01;35:*.pgm=01;35:*.ppm=01;35:*.tga=01;35:*.xbm=01;35:*.xpm=01;35:*.tif=01;35:*.tiff=01;35:*.png=01;35:*.svg=01;35:*.svgz=01;35:*.mng=01;35:*.pcx=01;35:*.mov=01;35:*.mpg=01;35:*.mpeg=01;35:*.m2v=01;35:*.mkv=01;35:*.ogm=01;35:*.mp4=01;35:*.m4v=01;35:*.mp4v=01;35:*.vob=01;35:*.qt=01;35:*.nuv=01;35:*.wmv=01;35:*.asf=01;35:*.rm=01;35:*.rmvb=01;35:*.flc=01;35:*.avi=01;35:*.fli=01;35:*.flv=01;35:*.gl=01;35:*.dl=01;35:*.xcf=01;35:*.xwd=01;35:*.yuv=01;35:*.cgm=01;35:*.emf=01;35:*.axv=01;35:*.anx=01;35:*.ogv=01;35:*.ogx=01;35:*.aac=01;36:*.au=01;36:*.flac=01;36:*.mid=01;36:*.midi=01;36:*.mka=01;36:*.mp3=01;36:*.mpc=01;36:*.ogg=01;36:*.ra=01;36:*.wav=01;36:*.axa=01;36:*.oga=01;36:*.spx=01;36:*.xspf=01;36:
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[10] = ORACLE_SID=ORCL11
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[11] = ORACLE_BASE=/oracle/app/oracle
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[12] = MAIL=/var/spool/mail/oracle
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[13] = PATH=
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[14] = PWD=/home/oracle
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[15] = LANG=en_US.UTF-8
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[16] = HISTCONTROL=ignoredups
[000001 22-APR-2021 08:07:37:479] nlpcaini: env[17] = SHLVL=1
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[18] = HOME=/home/oracle
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[19] = TMP=/tmp
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[20] = LOGNAME=oracle
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[21] = QTLIB=/usr/lib64/qt-3.3/lib
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[22] = CVS_RSH=ssh
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[23] = CLASSPATH=/oracle/app/oracle/product/11.2.0/db_1/jlib:/oracle/app/oracle/product/11.2.0/db_1/rdbms/jlib
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[24] = LESSOPEN=||/usr/bin/lesspipe.sh %s
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[25] = ORACLE_HOME=/oracle/app/oracle/product/11.2.0/db_1
[000001 22-APR-2021 08:07:37:480] nlpcaini: env[26] = G_BROKEN_FILENAMES=1
[000001 22-APR-2021 08:07:37:481] nlpcaini: env[27] = _=/oracle/app/oracle/product/11.2.0/db_1/bin/sqlplus
[000001 22-APR-2021 08:07:37:481] nlpcaini: env[28] = ORA_NET2_DESC=9,12
[000001 22-APR-2021 08:07:37:481] nlpcaini: env[29] = ORACLE_SPAWNED_PROCESS=1
[000001 22-APR-2021 08:07:37:481] nlpcaini: exit
[000001 22-APR-2021 08:07:37:481] nsc2addr: normal exit
[000001 22-APR-2021 08:07:37:481] nsbeqaddr: entry
[000001 22-APR-2021 08:07:37:481] nsbeqaddr: connecting...
[000001 22-APR-2021 08:07:37:481] nsopen: entry
[000001 22-APR-2021 08:07:37:482] nsmal: entry
[000001 22-APR-2021 08:07:37:482] nsmal: 1576 bytes at 0x1b79120
[000001 22-APR-2021 08:07:37:482] nsmal: normal exit
[000001 22-APR-2021 08:07:37:482] nsopenmplx: entry
[000001 22-APR-2021 08:07:37:482] nsmal: entry
[000001 22-APR-2021 08:07:37:482] nsmal: 2760 bytes at 0x1b7bcc0
[000001 22-APR-2021 08:07:37:482] nsmal: normal exit
[000001 22-APR-2021 08:07:37:482] nsiorini: entry
[000001 22-APR-2021 08:07:37:482] nsbal: entry
[000001 22-APR-2021 08:07:37:483] nsbgetfl: entry
[000001 22-APR-2021 08:07:37:483] nsbgetfl: normal exit
[000001 22-APR-2021 08:07:37:483] nsbal: normal exit
[000001 22-APR-2021 08:07:37:483] nsiorini: exit (0)
[000001 22-APR-2021 08:07:37:483] nscpxget: entry
[000001 22-APR-2021 08:07:37:483] nscpxget: normal exit
[000001 22-APR-2021 08:07:37:483] nsopenalloc_nsntx: nlhthput on mplx_ht_nsgbu:ctx=1b79120, nsntx=1b7bcc0
[000001 22-APR-2021 08:07:37:483] nsopenmplx: normal exit
[000001 22-APR-2021 08:07:37:483] ntpcon: entry
[000001 22-APR-2021 08:07:37:484] ntpcon: toc = 6
[000001 22-APR-2021 08:07:37:484] ntpcon: exit
[000001 22-APR-2021 08:07:37:484] nsopen: opening transport...
[000001 22-APR-2021 08:07:37:484] ntpcon: entry
[000001 22-APR-2021 08:07:37:484] ntpcon: toc = 1
[000001 22-APR-2021 08:07:37:484] sntpcall: entry
[000001 22-APR-2021 08:07:37:487] sntpcall: detaching from parent with additional fork
[000001 22-APR-2021 08:07:37:490] sntpcall: hdl[IR]=28, hdl[IW]=27
[000001 22-APR-2021 08:07:37:490] ntpcon: exit
[000001 22-APR-2021 08:07:37:490] nserror: entry
[000001 22-APR-2021 08:07:37:490] nsoptions: entry
[000001 22-APR-2021 08:07:37:490] nsoptions: lcl[0]=0x0, lcl[1]=0x2006, gbl[0]=0x0, gbl[1]=0x0, cha=0x0
[000001 22-APR-2021 08:07:37:490] nsoptions: Vectored IO not supported.
[000001 22-APR-2021 08:07:37:490] nsoptions: lcl[0]=0xf4ffe9ff, lcl[1]=0x6016, gbl[0]=0xe881, gbl[1]=0x0
[000001 22-APR-2021 08:07:37:490] nsoptions: normal exit
[000001 22-APR-2021 08:07:37:490] nsnainit: entry
[000001 22-APR-2021 08:07:37:490] nsnainit: normal exit
[000001 22-APR-2021 08:07:37:490] nsopen: global context check-in (to slot 7) complete
[000001 22-APR-2021 08:07:37:490] nsopen: lcl[0]=0xf4ffe9ff, lcl[1]=0x6016, gbl[0]=0xe881, gbl[1]=0x0, tdu=4096, sdu=8192
[000001 22-APR-2021 08:07:37:490] nsfull_opn: entry
[000001 22-APR-2021 08:07:37:490] nsfull_opn: cid=7, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x0
[000001 22-APR-2021 08:07:37:490] nsfull_opn: nsctx: state=7, flg=0x4001, mvd=0
[000001 22-APR-2021 08:07:37:490] nsfull_opn: normal exit
[000001 22-APR-2021 08:07:37:490] nsopen: normal exit
[000001 22-APR-2021 08:07:37:490] nsevreg: entry
[000001 22-APR-2021 08:07:37:490] nsevreg: begin registration process for 7
[000001 22-APR-2021 08:07:37:490] nsevregPrePost: entry
[000001 22-APR-2021 08:07:37:490] nsevregPrePost: normal exit
[000001 22-APR-2021 08:07:37:490] nsevreg: sgt=0, evn=1, evt[2]=0x0
[000001 22-APR-2021 08:07:37:490] nsevreg: begin notification process for 7
[000001 22-APR-2021 08:07:37:490] nsevregAffectNotif: entry
[000001 22-APR-2021 08:07:37:490] nsevregAffectNotif: exit (0)
[000001 22-APR-2021 08:07:37:490] nsevreg: rdm=0, sgt=0, evt[0]=0x800, [1]=0x800, [2]=0x0, nrg=0
[000001 22-APR-2021 08:07:37:490] nsevreg: registering for 0x800
[000001 22-APR-2021 08:07:37:490] ntpctl: entry
[000001 22-APR-2021 08:07:37:490] ntpctl: exit
[000001 22-APR-2021 08:07:37:490] nsevreg: normal exit
[000001 22-APR-2021 08:07:37:490] nsbeqaddr: error exit
[000001 22-APR-2021 08:07:37:490] nsbequeath: error exit
[000001 22-APR-2021 08:07:37:490] nsglhe: exit
[000001 22-APR-2021 08:07:37:490] nsevwait: entry
[000001 22-APR-2021 08:07:37:490] nsevwait: 6 registered connection(s)
[000001 22-APR-2021 08:07:37:491] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:07:37:491] nsevwait: waiting for transport event (1 thru 7)...
[000001 22-APR-2021 08:07:37:536] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:536] nsevfnt: cxd: 0x1b6c278 stage 0: NT events set:
READ
[000001 22-APR-2021 08:07:37:536] nsevfnt: cxd: 0x1b6c278 stage 0: NS events set:
[000001 22-APR-2021 08:07:37:536] ntpctl: entry
[000001 22-APR-2021 08:07:37:536] sntpcall: result string is NTP0 12950
[000001 22-APR-2021 08:07:37:536] sntpcall: exit
[000001 22-APR-2021 08:07:37:536] ntpctl: exit
[000001 22-APR-2021 08:07:37:536] nttaddr2bnd: entry
[000001 22-APR-2021 08:07:37:536] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:536] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:536] nttaddr2bnd: Resolved to 192.168.0.30
[000001 22-APR-2021 08:07:37:536] nttaddr2bnd: exit
[000001 22-APR-2021 08:07:37:536] nsbequeath_stg2: doing connect handshake...
[000001 22-APR-2021 08:07:37:536] nsbequeath: doing connect handshake...
[000001 22-APR-2021 08:07:37:536] ntpwr: entry
[000001 22-APR-2021 08:07:37:536] ntpwr: exit
[000001 22-APR-2021 08:07:37:536] ntpwr: entry
[000001 22-APR-2021 08:07:37:537] ntpwr: exit
[000001 22-APR-2021 08:07:37:537] ntpwr: entry
[000001 22-APR-2021 08:07:37:537] ntpwr: exit
[000001 22-APR-2021 08:07:37:537] ntprd: entry
[000001 22-APR-2021 08:07:37:537] ntprd: exit
[000001 22-APR-2021 08:07:37:537] ntprd: entry
[000001 22-APR-2021 08:07:37:538] ntprd: exit
[000001 22-APR-2021 08:07:37:538] nsbequeath: NSE=12586
[000001 22-APR-2021 08:07:37:538] nsbequeath: error reading REDIR/NSE msg
[000001 22-APR-2021 08:07:37:538] nserror: entry
[000001 22-APR-2021 08:07:37:538] nserror: nsres: id=6, op=72, ns=12586, ns2=0; nt[0]=0, nt[1]=0, nt[2]=0; ora[0]=0, ora[1]=0, ora[2]=0
[000001 22-APR-2021 08:07:37:538] nsdo: entry
[000001 22-APR-2021 08:07:37:538] nsdo: cid=6, opcode=67, *bl=0, *what=13, uflgs=0x0, cflgs=0x3
[000001 22-APR-2021 08:07:37:538] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:07:37:538] nsdo: nsctx: state=2, flg=0xa0004004, mvd=0
[000001 22-APR-2021 08:07:37:538] nsdo: gtn=243, gtc=243, ptn=10, ptc=8155
[000001 22-APR-2021 08:07:37:538] nscon: entry
[000001 22-APR-2021 08:07:37:538] nscon: sending NSPTRS packet
[000001 22-APR-2021 08:07:37:538] nspsend: entry
[000001 22-APR-2021 08:07:37:538] nspsend: plen=8, type=11
[000001 22-APR-2021 08:07:37:538] nttwr: entry
[000001 22-APR-2021 08:07:37:538] nttwr: socket 25 had bytes written=8
[000001 22-APR-2021 08:07:37:538] nttwr: exit
[000001 22-APR-2021 08:07:37:538] nspsend: packet dump
[000001 22-APR-2021 08:07:37:538] nspsend: 00 08 00 00 0B 00 00 00 |........|
[000001 22-APR-2021 08:07:37:538] nspsend: 8 bytes to transport
[000001 22-APR-2021 08:07:37:538] nspsend: normal exit
[000001 22-APR-2021 08:07:37:538] nscon: exit (0)
[000001 22-APR-2021 08:07:37:538] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:07:37:538] nsdo: normal exit
[000001 22-APR-2021 08:07:37:538] nsclose: entry
[000001 22-APR-2021 08:07:37:538] nsvntx_dei: entry
[000001 22-APR-2021 08:07:37:538] nsvntx_dei: exit
[000001 22-APR-2021 08:07:37:538] nstimarmed: entry
[000001 22-APR-2021 08:07:37:538] nstimarmed: no timer allocated
[000001 22-APR-2021 08:07:37:538] nstimarmed: normal exit
[000001 22-APR-2021 08:07:37:538] nstoClearTimeout: entry
[000001 22-APR-2021 08:07:37:538] nstoClearTimeout: ATO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:07:37:538] nstoClearTimeout: STO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:07:37:538] nstoClearTimeout: RTO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:07:37:538] nstoClearTimeout: PITO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:07:37:538] nstoUpdateActive: entry
[000001 22-APR-2021 08:07:37:538] nstoUpdateActive: Active timeout is -1 (see nstotyp)
[000001 22-APR-2021 08:07:37:538] ntpctl: entry
[000001 22-APR-2021 08:07:37:538] ntpctl: exit
[000001 22-APR-2021 08:07:37:538] ntpctl: entry
[000001 22-APR-2021 08:07:37:539] ntpctl: exit
[000001 22-APR-2021 08:07:37:539] nsfull_cls: entry
[000001 22-APR-2021 08:07:37:539] nsfull_cls: cid=7, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x40
[000001 22-APR-2021 08:07:37:539] nsfull_cls: nsctx: state=8, flg=0x20004001, mvd=0
[000001 22-APR-2021 08:07:37:539] nsevunreg: entry
[000001 22-APR-2021 08:07:37:539] nsevunreg: cid=7, sgt=0, rdm=0
[000001 22-APR-2021 08:07:37:539] nsevunreg: 5 registered connection(s)
[000001 22-APR-2021 08:07:37:539] nsevunreg: exit (0)
[000001 22-APR-2021 08:07:37:539] nsfull_cls: normal exit
[000001 22-APR-2021 08:07:37:539] nsiocancel: entry
[000001 22-APR-2021 08:07:37:539] nsiofrrg: entry
[000001 22-APR-2021 08:07:37:539] nsiofrrg: cur = 1b798c8
[000001 22-APR-2021 08:07:37:539] nsbfr: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: normal exit
[000001 22-APR-2021 08:07:37:539] nsbfr: normal exit
[000001 22-APR-2021 08:07:37:539] nsiofrrg: exit
[000001 22-APR-2021 08:07:37:539] nsiocancel: exit
[000001 22-APR-2021 08:07:37:539] nsclose: closing transport
[000001 22-APR-2021 08:07:37:539] ntpdisc: entry
[000001 22-APR-2021 08:07:37:539] ntpdisc: exit
[000001 22-APR-2021 08:07:37:539] nsclose: global context check-out (from slot 7) complete
[000001 22-APR-2021 08:07:37:539] nsnadisc: entry
[000001 22-APR-2021 08:07:37:539] nsnadisc: no native services in use - returning
[000001 22-APR-2021 08:07:37:539] nsvntx_dei: entry
[000001 22-APR-2021 08:07:37:539] nsvntx_dei: exit
[000001 22-APR-2021 08:07:37:539] nsopenfree_nsntx: nlhthdel from mplx_ht_nsgbu, ctx=1b79120 nsntx=1b7bcc0
[000001 22-APR-2021 08:07:37:539] nsiocancel: entry
[000001 22-APR-2021 08:07:37:539] nsiofrrg: entry
[000001 22-APR-2021 08:07:37:539] nsiofrrg: exit
[000001 22-APR-2021 08:07:37:539] nsiocancel: exit
[000001 22-APR-2021 08:07:37:539] nsmfr: entry
[000001 22-APR-2021 08:07:37:539] nsmfr: 2760 bytes at 0x1b7bcc0
[000001 22-APR-2021 08:07:37:539] nsmfr: normal exit
[000001 22-APR-2021 08:07:37:539] nsmfr: entry
[000001 22-APR-2021 08:07:37:539] nsmfr: 1576 bytes at 0x1b79120
[000001 22-APR-2021 08:07:37:539] nsmfr: normal exit
[000001 22-APR-2021 08:07:37:539] nsclose: normal exit
[000001 22-APR-2021 08:07:37:539] nsclose: entry
[000001 22-APR-2021 08:07:37:539] nsvntx_dei: entry
[000001 22-APR-2021 08:07:37:539] nsvntx_dei: exit
[000001 22-APR-2021 08:07:37:539] nstimarmed: entry
[000001 22-APR-2021 08:07:37:539] nstimarmed: no timer allocated
[000001 22-APR-2021 08:07:37:539] nstimarmed: normal exit
[000001 22-APR-2021 08:07:37:539] nsfull_cls: entry
[000001 22-APR-2021 08:07:37:539] nsfull_cls: cid=6, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x40
[000001 22-APR-2021 08:07:37:539] nsfull_cls: nsctx: state=2, flg=0xa0004000, mvd=0
[000001 22-APR-2021 08:07:37:539] nsevunreg: entry
[000001 22-APR-2021 08:07:37:539] nsevunreg: cid=6, sgt=0, rdm=0
[000001 22-APR-2021 08:07:37:539] nsevunreg: 4 registered connection(s)
[000001 22-APR-2021 08:07:37:539] nsevunreg: exit (0)
[000001 22-APR-2021 08:07:37:539] nsbfr: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: normal exit
[000001 22-APR-2021 08:07:37:539] nsbfr: normal exit
[000001 22-APR-2021 08:07:37:539] nsbfr: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: entry
[000001 22-APR-2021 08:07:37:539] nsbaddfl: normal exit
[000001 22-APR-2021 08:07:37:540] nsbfr: normal exit
[000001 22-APR-2021 08:07:37:540] nsfull_cls: normal exit
[000001 22-APR-2021 08:07:37:540] nsiocancel: entry
[000001 22-APR-2021 08:07:37:540] nsiofrrg: entry
[000001 22-APR-2021 08:07:37:540] nsiofrrg: cur = 1b574f8
[000001 22-APR-2021 08:07:37:540] nsbfr: entry
[000001 22-APR-2021 08:07:37:540] nsbaddfl: entry
[000001 22-APR-2021 08:07:37:540] nsbaddfl: normal exit
[000001 22-APR-2021 08:07:37:540] nsbfr: normal exit
[000001 22-APR-2021 08:07:37:540] nsiofrrg: exit
[000001 22-APR-2021 08:07:37:540] nsiocancel: exit
[000001 22-APR-2021 08:07:37:540] nsclose: closing transport
[000001 22-APR-2021 08:07:37:540] nttdisc: entry
[000001 22-APR-2021 08:07:37:540] nttdisc: Closed socket 25
[000001 22-APR-2021 08:07:37:540] nttdisc: exit
[000001 22-APR-2021 08:07:37:540] nsclose: global context check-out (from slot 6) complete
[000001 22-APR-2021 08:07:37:540] nsnadisc: entry
[000001 22-APR-2021 08:07:37:540] nsnadisc: no native services in use - returning
[000001 22-APR-2021 08:07:37:540] nsvntx_dei: entry
[000001 22-APR-2021 08:07:37:540] nsvntx_dei: exit
[000001 22-APR-2021 08:07:37:540] nsopenfree_nsntx: nlhthdel from mplx_ht_nsgbu, ctx=1b6c260 nsntx=1b6a790
[000001 22-APR-2021 08:07:37:540] nsiocancel: entry
[000001 22-APR-2021 08:07:37:540] nsiofrrg: entry
[000001 22-APR-2021 08:07:37:540] nsiofrrg: exit
[000001 22-APR-2021 08:07:37:540] nsiocancel: exit
[000001 22-APR-2021 08:07:37:541] nsmfr: entry
[000001 22-APR-2021 08:07:37:541] nsmfr: 2760 bytes at 0x1b6a790
[000001 22-APR-2021 08:07:37:541] nsmfr: normal exit
[000001 22-APR-2021 08:07:37:541] nsmfr: entry
[000001 22-APR-2021 08:07:37:541] nsmfr: 1576 bytes at 0x1b6c260
[000001 22-APR-2021 08:07:37:542] nsmfr: normal exit
[000001 22-APR-2021 08:07:37:542] nsclose: normal exit
[000001 22-APR-2021 08:07:37:542] nsevrec: event is 0x20, on -1
[000001 22-APR-2021 08:07:37:542] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:07:37:542] nsevwait: exit (0)
[000001 22-APR-2021 08:07:37:543] nsglhe: entry
[000001 22-APR-2021 08:07:37:543] nsglhe: Event on cxd 0x1b59550.
[000001 22-APR-2021 08:07:37:543] nsgldissolve: entry
[000001 22-APR-2021 08:07:37:543] nsdisc: entry
[000001 22-APR-2021 08:07:37:543] nsclose: entry
[000001 22-APR-2021 08:07:37:544] nsclose: normal exit
[000001 22-APR-2021 08:07:37:544] nsdisc: exit (0)
[000001 22-APR-2021 08:07:37:544] nsgldissolve: Deallocating cxd 0x1b59550.
[000001 22-APR-2021 08:07:37:544] nsgldissolve: exit
[000001 22-APR-2021 08:07:37:545] nsglhe: exit
[000001 22-APR-2021 08:07:37:545] nsevwait: entry
[000001 22-APR-2021 08:07:37:546] nsevwait: 4 registered connection(s)
[000001 22-APR-2021 08:07:37:546] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:07:37:546] nsevwait: waiting for transport event (1 thru 5)...
[000001 22-APR-2021 08:07:37:777] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:777] nsevfnt: cxd: 0x1b60eb0 stage 0: NT events set:
READ
[000001 22-APR-2021 08:07:37:777] nsevfnt: cxd: 0x1b60eb0 stage 0: NS events set:
INCOMING SEND
[000001 22-APR-2021 08:07:37:777] nsevrec: event is 0x2, on 5
[000001 22-APR-2021 08:07:37:777] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:07:37:777] nsevwait: exit (0)
[000001 22-APR-2021 08:07:37:777] nsglhe: entry
[000001 22-APR-2021 08:07:37:777] nsglhe: Event on cxd 0x1b60eb0.
[000001 22-APR-2021 08:07:37:777] nsglrohe: entry
[000001 22-APR-2021 08:07:37:777] nsdo: entry
[000001 22-APR-2021 08:07:37:777] nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3
[000001 22-APR-2021 08:07:37:777] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:07:37:777] nsdo: nsctx: state=8, flg=0x2000400c, mvd=0
[000001 22-APR-2021 08:07:37:777] nsdo: gtn=342, gtc=342, ptn=10, ptc=8155
[000001 22-APR-2021 08:07:37:777] nsrdr: entry
[000001 22-APR-2021 08:07:37:777] nsrdr: recving a packet
[000001 22-APR-2021 08:07:37:777] nsprecv: entry
[000001 22-APR-2021 08:07:37:777] nsprecv: reading from transport...
[000001 22-APR-2021 08:07:37:777] nttmrd: entry
[000001 22-APR-2021 08:07:37:777] nttmrd: socket 14 had bytes read=446
[000001 22-APR-2021 08:07:37:777] nttmrd: exit
[000001 22-APR-2021 08:07:37:777] nsprecv: 446 bytes from transport
[000001 22-APR-2021 08:07:37:777] nsprecv: tlen=446, plen=446, type=6
[000001 22-APR-2021 08:07:37:777] nsprecv: packet dump
[000001 22-APR-2021 08:07:37:777] nsprecv: 01 BE 00 00 06 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 01 B4 48 00 |......H.|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 80 02 00 00 00 00 04 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 90 D0 F5 0D 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 90 00 23 00 00 00 |....#...|
[000001 22-APR-2021 08:07:37:778] nsprecv: 42 45 43 37 36 43 32 43 |BEC76C2C|
[000001 22-APR-2021 08:07:37:778] nsprecv: 43 31 33 36 2D 35 46 39 |C136-5F9|
[000001 22-APR-2021 08:07:37:778] nsprecv: 46 2D 45 30 33 34 2D 30 |F-E034-0|
[000001 22-APR-2021 08:07:37:778] nsprecv: 30 30 33 42 41 31 33 37 |003BA137|
[000001 22-APR-2021 08:07:37:778] nsprecv: 34 42 33 03 00 65 00 01 |4B3..e..|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 01 00 00 00 00 00 36 |.......6|
[000001 22-APR-2021 08:07:37:778] nsprecv: 2D 35 60 01 00 80 05 00 |-5`.....|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 04 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 02 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 10 00 00 00 02 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 A8 D5 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: F4 0D 00 00 00 00 01 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 F0 1D |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: F6 0D 00 00 00 00 00 DD |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: F4 0D 00 00 00 00 BF B8 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 17 A8 C7 AC 31 BB E0 53 |....1..S|
[000001 22-APR-2021 08:07:37:778] nsprecv: 1E 00 A8 C0 EA FC 08 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 01 00 00 00 01 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 02 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 07 00 00 00 01 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 78 65 |......xe|
[000001 22-APR-2021 08:07:37:778] nsprecv: A9 DE 00 00 00 00 02 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 C0 1D |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: F6 0D 00 00 00 00 90 DD |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: F4 0D 00 00 00 00 4F 52 |......OR|
[000001 22-APR-2021 08:07:37:778] nsprecv: 43 4C 31 31 00 04 00 00 |CL11....|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 01 00 00 00 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 60 1E F6 |.....`..|
[000001 22-APR-2021 08:07:37:778] nsprecv: 0D 00 00 00 00 02 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 10 00 00 00 02 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 B8 D7 F4 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 0D 00 00 00 00 04 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 50 27 F6 |.....P'.|
[000001 22-APR-2021 08:07:37:778] nsprecv: 0D 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 BF B8 17 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: A8 C7 AD 31 BB E0 53 1E |...1..S.|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 A8 C0 EA FC 02 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 01 00 00 00 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 02 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 01 00 00 00 1A 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nsprecv: 00 00 00 00 00 02 |...... |
[000001 22-APR-2021 08:07:37:778] nsprecv: normal exit
[000001 22-APR-2021 08:07:37:778] nsrdr: got NSPTDA packet
[000001 22-APR-2021 08:07:37:778] nsrdr: NSPTDA flags: 0x0
[000001 22-APR-2021 08:07:37:778] nsrdr: normal exit
[000001 22-APR-2021 08:07:37:778] nsdo: *what=1, *bl=8196
[000001 22-APR-2021 08:07:37:778] nsdo: 436 bytes from NS buffer
[000001 22-APR-2021 08:07:37:778] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:07:37:778] nsdo: normal exit
[000001 22-APR-2021 08:07:37:778] nsglgrDoRegister: inst loads: ld1:0 mld1:5120 ld2:1 mld2:772
[000001 22-APR-2021 08:07:37:778] nsglgrDoRegister: service:ORCL11 what:4 value:1
[000001 22-APR-2021 08:07:37:778] nsglgrDoRegister: service:ORCL11 what:2 value:1
[000001 22-APR-2021 08:07:37:778] nsglgrDoRegister: exit
[000001 22-APR-2021 08:07:37:778] nsdo: entry
[000001 22-APR-2021 08:07:37:778] nsdo: cid=5, opcode=67, *bl=232, *what=1, uflgs=0x2, cflgs=0x3
[000001 22-APR-2021 08:07:37:778] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:07:37:778] nsdo: nsctx: state=8, flg=0x2000400c, mvd=0
[000001 22-APR-2021 08:07:37:778] nsdo: gtn=446, gtc=446, ptn=10, ptc=8155
[000001 22-APR-2021 08:07:37:778] nsdo: 232 bytes to NS buffer
[000001 22-APR-2021 08:07:37:778] nsdoacts: entry
[000001 22-APR-2021 08:07:37:778] nsdofls: entry
[000001 22-APR-2021 08:07:37:778] nsdofls: DATA flags: 0x0
[000001 22-APR-2021 08:07:37:778] nsdofls: sending NSPTDA packet
[000001 22-APR-2021 08:07:37:778] nspsend: entry
[000001 22-APR-2021 08:07:37:778] nspsend: plen=242, type=6
[000001 22-APR-2021 08:07:37:778] nttmwr: entry
[000001 22-APR-2021 08:07:37:778] nttmwr: socket 14 had bytes written=242
[000001 22-APR-2021 08:07:37:778] nttmwr: exit
[000001 22-APR-2021 08:07:37:778] nspsend: packet dump
[000001 22-APR-2021 08:07:37:778] nspsend: 00 F2 00 00 06 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 E8 E0 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 80 07 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 05 00 00 00 10 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 02 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 C3 B4 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 05 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 E0 F5 B5 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 BF B8 17 A8 C7 AC |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 31 BB E0 53 1E 00 A8 C0 |1..S....|
[000001 22-APR-2021 08:07:37:778] nspsend: EA FC 05 00 00 00 07 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 01 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 10 04 AD 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 06 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 C0 08 B7 01 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 4F 52 43 4C 31 31 |..ORCL11|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 05 00 00 00 10 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 02 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 F0 03 AD 01 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 08 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:778] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:779] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:779] nspsend: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:07:37:779] nspsend: 00 BF B8 17 A8 C7 AD 31 |.......1|
[000001 22-APR-2021 08:07:37:779] nspsend: BB E0 53 1E 00 A8 C0 EA |..S.....|
[000001 22-APR-2021 08:07:37:779] nspsend: FC 00 |.. |
[000001 22-APR-2021 08:07:37:779] nspsend: 242 bytes to transport
[000001 22-APR-2021 08:07:37:779] nspsend: normal exit
[000001 22-APR-2021 08:07:37:779] nsdofls: exit (0)
[000001 22-APR-2021 08:07:37:779] nsdoacts: flushing transport
[000001 22-APR-2021 08:07:37:779] nttctl: entry
[000001 22-APR-2021 08:07:37:779] nsdoacts: normal exit
[000001 22-APR-2021 08:07:37:779] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:07:37:779] nsdo: normal exit
[000001 22-APR-2021 08:07:37:779] nsglroHandleError: exit
[000001 22-APR-2021 08:07:37:779] nsglrohe: exit
[000001 22-APR-2021 08:07:37:779] nsglhe: exit
[000001 22-APR-2021 08:07:37:779] nsevwait: entry
[000001 22-APR-2021 08:07:37:779] nsevwait: 4 registered connection(s)
[000001 22-APR-2021 08:07:37:779] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:07:37:779] nsevwait: waiting for transport event (1 thru 5)...
[000001 22-APR-2021 08:07:37:779] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:779] nsevfnt: cxd: 0x1b60eb0 stage 0: NT events set:
WRITE
[000001 22-APR-2021 08:07:37:779] nsevfnt: cxd: 0x1b60eb0 stage 0: NS events set:
READY FOR SEND
[000001 22-APR-2021 08:07:37:779] nsevrec: event is 0x10, on 5
[000001 22-APR-2021 08:07:37:779] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:07:37:779] nsevwait: exit (0)
[000001 22-APR-2021 08:07:37:779] nsglhe: entry
[000001 22-APR-2021 08:07:37:779] nsglhe: Event on cxd 0x1b60eb0.
[000001 22-APR-2021 08:07:37:779] nsglrohe: entry
[000001 22-APR-2021 08:07:37:779] nsevmute: entry
[000001 22-APR-2021 08:07:37:779] nsevmute: cid=5
[000001 22-APR-2021 08:07:37:779] nsevmute: normal exit
[000001 22-APR-2021 08:07:37:779] nsglrohe: exit
[000001 22-APR-2021 08:07:37:779] nsglhe: exit
[000001 22-APR-2021 08:07:37:779] nsevwait: entry
[000001 22-APR-2021 08:07:37:779] nsevwait: 4 registered connection(s)
[000001 22-APR-2021 08:07:37:779] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:07:37:779] nsevwait: waiting for transport event (1 thru 5)...797줄이 마지막줄임
클라이언트에서 접속실패 테스트
|
1
2
3
4
5
6
7
8
9
10
11
|
$ sqlplus imsi/imsi1@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 23:04:18 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
ERROR:
ORA-01017: invalid username/password; logon denied
Enter user-name:
|
DB서버에서 리스너 트레이스 로그 확인(계속 tail 유지)
더보기
실패
[000001 22-APR-2021 08:08:22:904] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:08:22:904] nsevfnt: cxd: 0x1b330f0 stage 0: NT events set:
CONNECTION REQUEST
[000001 22-APR-2021 08:08:22:904] nsevfnt: cxd: 0x1b330f0 stage 0: NS events set:
INCOMING CALL
[000001 22-APR-2021 08:08:22:904] nsevrec: event is 0x1, on 1
[000001 22-APR-2021 08:08:22:904] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:08:22:904] nsevwait: exit (0)
[000001 22-APR-2021 08:08:22:904] nsglhe: entry
[000001 22-APR-2021 08:08:22:904] nsglhe: Event on cxd 0x1b330f0.
[000001 22-APR-2021 08:08:22:904] nsglhc: Allocating cxd 0x1b59550
[000001 22-APR-2021 08:08:22:904] nsanswer: entry
[000001 22-APR-2021 08:08:22:904] nsopen: entry
[000001 22-APR-2021 08:08:22:904] nsmal: entry
[000001 22-APR-2021 08:08:22:904] nsmal: 1576 bytes at 0x1b6c260
[000001 22-APR-2021 08:08:22:904] nsmal: normal exit
[000001 22-APR-2021 08:08:22:904] nsopenmplx: entry
[000001 22-APR-2021 08:08:22:904] nsmal: entry
[000001 22-APR-2021 08:08:22:904] nsmal: 2760 bytes at 0x1b6a790
[000001 22-APR-2021 08:08:22:904] nsmal: normal exit
[000001 22-APR-2021 08:08:22:904] nsiorini: entry
[000001 22-APR-2021 08:08:22:904] nsbal: entry
[000001 22-APR-2021 08:08:22:904] nsbgetfl: entry
[000001 22-APR-2021 08:08:22:904] nsbgetfl: normal exit
[000001 22-APR-2021 08:08:22:904] nsbal: normal exit
[000001 22-APR-2021 08:08:22:904] nsiorini: exit (0)
[000001 22-APR-2021 08:08:22:904] nscpxget: entry
[000001 22-APR-2021 08:08:22:904] nscpxget: normal exit
[000001 22-APR-2021 08:08:22:904] nsopenalloc_nsntx: nlhthput on mplx_ht_nsgbu:ctx=1b6c260, nsntx=1b6a790
[000001 22-APR-2021 08:08:22:904] nsopenmplx: normal exit
[000001 22-APR-2021 08:08:22:904] nstoSetupTimeout: entry
[000001 22-APR-2021 08:08:22:904] nstoSetupTimeout: ATO enabled for ctx=0x0x1b6c260, val=60000(millisecs)
[000001 22-APR-2021 08:08:22:904] nstoUpdateActive: entry
[000001 22-APR-2021 08:08:22:904] nstoUpdateActive: Active timeout is 0 (see nstotyp)
[000001 22-APR-2021 08:08:22:904] nsopen: opening transport...
[000001 22-APR-2021 08:08:22:904] nttcon: entry
[000001 22-APR-2021 08:08:22:904] nttcon: toc = 3
[000001 22-APR-2021 08:08:22:904] nttcnp: entry
[000001 22-APR-2021 08:08:22:904] nttcnp: getting sockname
[000001 22-APR-2021 08:08:22:904] nttcnp: getting peername
[000001 22-APR-2021 08:08:22:904] nttcnp: exit
[000001 22-APR-2021 08:08:22:904] nttcnr: entry
[000001 22-APR-2021 08:08:22:904] nttcnr: waiting to accept a connection.
[000001 22-APR-2021 08:08:22:904] nttcnr: getting sockname
[000001 22-APR-2021 08:08:22:904] snlinGetNameInfo: entry
[000001 22-APR-2021 08:08:22:904] snlinGetNameInfo: exit
[000001 22-APR-2021 08:08:22:904] nttcnr: connected on ipaddr 192.168.0.30
[000001 22-APR-2021 08:08:22:904] nttvlser: entry
[000001 22-APR-2021 08:08:22:904] snlinGetNameInfo: entry
[000001 22-APR-2021 08:08:22:904] snlinGetNameInfo: exit
[000001 22-APR-2021 08:08:22:904] nttvlser: valid node check on incoming node 192.168.0.40
[000001 22-APR-2021 08:08:22:904] nttvlser: Accepted Entry: 192.168.0.40
[000001 22-APR-2021 08:08:22:904] nttcnr: exit
[000001 22-APR-2021 08:08:22:904] nttcon: NT layer TCP/IP connection has been established.
[000001 22-APR-2021 08:08:22:904] nttcon: set TCP_NODELAY on 25
[000001 22-APR-2021 08:08:22:904] nttcon: exit
[000001 22-APR-2021 08:08:22:904] nsopen: transport is open
[000001 22-APR-2021 08:08:22:905] nstoPostNTConn: entry
[000001 22-APR-2021 08:08:22:905] nstoArmEventATO: entry
[000001 22-APR-2021 08:08:22:905] nstoArmEventATO: exit (0)
[000001 22-APR-2021 08:08:22:905] nstoPostNTConn: exit (0)
[000001 22-APR-2021 08:08:22:905] nsnainit: entry
[000001 22-APR-2021 08:08:22:905] nsnainit: answer
[000001 22-APR-2021 08:08:22:905] nsnadct: entry
[000001 22-APR-2021 08:08:22:905] nsnadct: normal exit
[000001 22-APR-2021 08:08:22:905] nsnasvnainfo: entry
[000001 22-APR-2021 08:08:22:905] nsnasvnainfo: NA disabled for this connection
[000001 22-APR-2021 08:08:22:905] nsnasvnainfo: normal exit
[000001 22-APR-2021 08:08:22:905] nainit: entry
[000001 22-APR-2021 08:08:22:905] nagblini: entry
[000001 22-APR-2021 08:08:22:905] nau_gin: entry
[000001 22-APR-2021 08:08:22:905] nau_gparams: entry
[000001 22-APR-2021 08:08:22:905] nam_gbp: Reading parameter "sqlnet.authentication_required" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gbp: Parameter not found
[000001 22-APR-2021 08:08:22:905] nau_gparams: Using default value "FALSE"
[000001 22-APR-2021 08:08:22:905] nau_gslf: entry
[000001 22-APR-2021 08:08:22:905] nam_gic: entry
[000001 22-APR-2021 08:08:22:905] nam_gic: Counting # of items in "sqlnet.authentication_services" parameter
[000001 22-APR-2021 08:08:22:905] nam_gic: Parameter not found
[000001 22-APR-2021 08:08:22:905] nam_gic: Found 0 items
[000001 22-APR-2021 08:08:22:905] nam_gic: exit
[000001 22-APR-2021 08:08:22:905] nau_gslf: Using default value "all available adapters"
[000001 22-APR-2021 08:08:22:905] nauss_set_state: entry
[000001 22-APR-2021 08:08:22:905] nauss_set_state: exit
[000001 22-APR-2021 08:08:22:905] nau_gslf: exit
[000001 22-APR-2021 08:08:22:905] nau_gparams: exit
[000001 22-APR-2021 08:08:22:905] nau_gin: exit
[000001 22-APR-2021 08:08:22:905] nagblini: exit
[000001 22-APR-2021 08:08:22:905] na_saveprot: entry
[000001 22-APR-2021 08:08:22:905] na_saveprot: exit
[000001 22-APR-2021 08:08:22:905] nacomin: entry
[000001 22-APR-2021 08:08:22:905] nas_init: entry
[000001 22-APR-2021 08:08:22:905] nas_init: exit
[000001 22-APR-2021 08:08:22:905] nau_ini: entry
[000001 22-APR-2021 08:08:22:905] naugcp_get_connect_parameters: entry
[000001 22-APR-2021 08:08:22:905] nauss_set_state: entry
[000001 22-APR-2021 08:08:22:905] nauss_set_state: exit
[000001 22-APR-2021 08:08:22:905] naugcp_get_connect_parameters: exit
[000001 22-APR-2021 08:08:22:905] nau_gfauth: entry
[000001 22-APR-2021 08:08:22:905] nam_gbp: Reading parameter "sqlnet.fallback_authentication" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gbp: Parameter not found
[000001 22-APR-2021 08:08:22:905] nau_gfauth: Using default value "FALSE"
[000001 22-APR-2021 08:08:22:905] nau_gfauth: exit
[000001 22-APR-2021 08:08:22:905] nau_gettab: entry
[000001 22-APR-2021 08:08:22:905] nau_gettab: using authentication adapter table "nautab"
[000001 22-APR-2021 08:08:22:905] nau_gettab: nautab contains the following services:
[000001 22-APR-2021 08:08:22:905] nau_gettab: KERBEROS5
[000001 22-APR-2021 08:08:22:905] nau_gettab: RADIUS
[000001 22-APR-2021 08:08:22:905] nau_gettab: exit
[000001 22-APR-2021 08:08:22:905] nau_sini: entry
[000001 22-APR-2021 08:08:22:905] nau_sini: exit
[000001 22-APR-2021 08:08:22:905] nau_ini: connection type: "standard"
[000001 22-APR-2021 08:08:22:905] nau_ini: exit
[000001 22-APR-2021 08:08:22:905] naeeinit: entry
[000001 22-APR-2021 08:08:22:905] nam_gbp: Reading parameter "SQLNET.FIPS_140" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gbp: Parameter not found
[000001 22-APR-2021 08:08:22:905] nam_gnsp: Reading parameter "SQLNET.ENCRYPTION_SERVER" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gnsp: Parameter not found
[000001 22-APR-2021 08:08:22:905] naequad: Using default value "ACCEPTED"
[000001 22-APR-2021 08:08:22:905] nam_gbp: Reading parameter "SQLNET._ENHANCED_LOGON_PROTECTION" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gbp: Parameter not found
[000001 22-APR-2021 08:08:22:905] nam_gic: entry
[000001 22-APR-2021 08:08:22:905] nam_gic: Counting # of items in "SQLNET.ENCRYPTION_TYPES_SERVER" parameter
[000001 22-APR-2021 08:08:22:905] nam_gic: Parameter not found
[000001 22-APR-2021 08:08:22:905] nam_gic: exit
[000001 22-APR-2021 08:08:22:905] naesno: Using default value "all available algorithms"
[000001 22-APR-2021 08:08:22:905] naeshow: entry
[000001 22-APR-2021 08:08:22:905] naeshow: These are the encryption algorithms that the server will accept, in decreasing order of preference:
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 0: no algorithm; encryption inactive
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 1: 'AES256' (ID 17)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 2: 'RC4_256' (ID 6)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 3: 'AES192' (ID 16)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 4: '3DES168' (ID 12)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 5: 'AES128' (ID 15)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 6: 'RC4_128' (ID 10)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 7: '3DES112' (ID 11)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 8: 'RC4_56' (ID 8)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 9: 'DES' (ID 2)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 10: 'RC4_40' (ID 1)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 11: 'DES40' (ID 3)
[000001 22-APR-2021 08:08:22:905] naeshow: exit
[000001 22-APR-2021 08:08:22:905] naeeinit: exit
[000001 22-APR-2021 08:08:22:905] naecinit: entry
[000001 22-APR-2021 08:08:22:905] nam_gnsp: Reading parameter "SQLNET.CRYPTO_CHECKSUM_SERVER" from parameter file
[000001 22-APR-2021 08:08:22:905] nam_gnsp: Parameter not found
[000001 22-APR-2021 08:08:22:905] naequad: Using default value "ACCEPTED"
[000001 22-APR-2021 08:08:22:905] nam_gic: entry
[000001 22-APR-2021 08:08:22:905] nam_gic: Counting # of items in "SQLNET.CRYPTO_CHECKSUM_TYPES_SERVER" parameter
[000001 22-APR-2021 08:08:22:905] nam_gic: Parameter not found
[000001 22-APR-2021 08:08:22:905] nam_gic: exit
[000001 22-APR-2021 08:08:22:905] naesno: Using default value "all available algorithms"
[000001 22-APR-2021 08:08:22:905] naeshow: entry
[000001 22-APR-2021 08:08:22:905] naeshow: These are the checksumming algorithms that the server will accept, in decreasing order of preference:
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 0: no algorithm; checksumming inactive
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 1: 'SHA1' (ID 3)
[000001 22-APR-2021 08:08:22:905] naeshow: Choice 2: 'MD5' (ID 1)
[000001 22-APR-2021 08:08:22:905] naeshow: exit
[000001 22-APR-2021 08:08:22:905] naecinit: exit
[000001 22-APR-2021 08:08:22:905] nainit: native services disabled - disconnecting
[000001 22-APR-2021 08:08:22:905] nadisc: entry
[000001 22-APR-2021 08:08:22:906] nacomtm: entry
[000001 22-APR-2021 08:08:22:906] nacompd: entry
[000001 22-APR-2021 08:08:22:906] nacompd: exit
[000001 22-APR-2021 08:08:22:906] nacompd: entry
[000001 22-APR-2021 08:08:22:906] nacompd: exit
[000001 22-APR-2021 08:08:22:906] nacomtm: exit
[000001 22-APR-2021 08:08:22:906] nas_dis: entry
[000001 22-APR-2021 08:08:22:906] nas_dis: exit
[000001 22-APR-2021 08:08:22:906] nau_dis: entry
[000001 22-APR-2021 08:08:22:906] nau_dis: exit
[000001 22-APR-2021 08:08:22:906] naeetrm: entry
[000001 22-APR-2021 08:08:22:907] naeetrm: exit
[000001 22-APR-2021 08:08:22:907] naectrm: entry
[000001 22-APR-2021 08:08:22:907] naectrm: exit
[000001 22-APR-2021 08:08:22:907] nagbltrm: entry
[000001 22-APR-2021 08:08:22:907] nau_gtm: entry
[000001 22-APR-2021 08:08:22:907] nau_gtm: exit
[000001 22-APR-2021 08:08:22:907] nagbltrm: exit
[000001 22-APR-2021 08:08:22:907] nadisc: exit
[000001 22-APR-2021 08:08:22:907] nainit: exit
[000001 22-APR-2021 08:08:22:907] nsnainit: NS Connection version: 314
[000001 22-APR-2021 08:08:22:907] nsnainit: inf->nsinfflg[0]: 0xd inf->nsinfflg[1]: 0xd
[000001 22-APR-2021 08:08:22:907] nsnainit: "or" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
[000001 22-APR-2021 08:08:22:907] nsnainit: "or" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
"and" info flags: 0xd Translations follow:
native service(s) is (are) wanted
NA disabled remotely for this connection
NA services unavailable on both processes - negotiation not needed
[000001 22-APR-2021 08:08:22:907] nsnainit: normal exit
[000001 22-APR-2021 08:08:22:907] nsopen: global context check-in (to slot 6) complete
[000001 22-APR-2021 08:08:22:907] nsopen: lcl[0]=0xf4ffe9ff, lcl[1]=0x12003, gbl[0]=0x7ebf, gbl[1]=0x2001, tdu=65535, sdu=8192
[000001 22-APR-2021 08:08:22:907] nsfull_opn: entry
[000001 22-APR-2021 08:08:22:907] nsfull_opn: cid=6, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x0
[000001 22-APR-2021 08:08:22:907] nsfull_opn: nsctx: state=7, flg=0x4000, mvd=0
[000001 22-APR-2021 08:08:22:907] nsbal: entry
[000001 22-APR-2021 08:08:22:907] nsbgetfl: entry
[000001 22-APR-2021 08:08:22:907] nsbgetfl: normal exit
[000001 22-APR-2021 08:08:22:907] nsbal: normal exit
[000001 22-APR-2021 08:08:22:907] nsbal: entry
[000001 22-APR-2021 08:08:22:907] nsbgetfl: entry
[000001 22-APR-2021 08:08:22:907] nsbgetfl: normal exit
[000001 22-APR-2021 08:08:22:907] nsbal: normal exit
[000001 22-APR-2021 08:08:22:907] nsfull_opn: normal exit
[000001 22-APR-2021 08:08:22:907] nsopen: normal exit
[000001 22-APR-2021 08:08:22:907] nsanswer: deferring connect attempt; at stage 5
[000001 22-APR-2021 08:08:22:907] nsanswer: normal exit
[000001 22-APR-2021 08:08:22:907] nsevreg: entry
[000001 22-APR-2021 08:08:22:907] nsevreg: begin registration process for 6
[000001 22-APR-2021 08:08:22:907] nsevregPrePost: entry
[000001 22-APR-2021 08:08:22:907] nsevregPrePost: normal exit
[000001 22-APR-2021 08:08:22:907] nsevreg: sgt=0, evn=1, evt[2]=0x0
[000001 22-APR-2021 08:08:22:907] nsevreg: begin notification process for 6
[000001 22-APR-2021 08:08:22:907] nsevregAffectNotif: entry
[000001 22-APR-2021 08:08:22:907] nsevregAffectNotif: exit (0)
[000001 22-APR-2021 08:08:22:907] nsevreg: rdm=0, sgt=0, evt[0]=0x20, [1]=0x20, [2]=0x0, nrg=0
[000001 22-APR-2021 08:08:22:907] nsevreg: registering for 0x20
[000001 22-APR-2021 08:08:22:907] nsevreg: normal exit
[000001 22-APR-2021 08:08:22:907] nsglhe: exit
[000001 22-APR-2021 08:08:22:907] nsevwait: entry
[000001 22-APR-2021 08:08:22:907] nsevwait: 5 registered connection(s)
[000001 22-APR-2021 08:08:22:907] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:08:22:907] nsevwait: waiting for transport event (1 thru 6)...
[000001 22-APR-2021 08:08:22:907] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:08:22:907] nsevfnt: cxd: 0x1b59550 stage 5: NT events set:
READ
[000001 22-APR-2021 08:08:22:907] nsevfnt: cxd: 0x1b59550 stage 5: NS events set:
OUTGOING CALL COMPLETE
[000001 22-APR-2021 08:08:22:907] nsevdansw: entry
[000001 22-APR-2021 08:08:22:907] nsevdansw: at STAGE 5
[000001 22-APR-2021 08:08:22:907] nsdo: entry
[000001 22-APR-2021 08:08:22:907] nsdo: cid=6, opcode=68, *bl=2040, *what=8, uflgs=0x0, cflgs=0x3
[000001 22-APR-2021 08:08:22:907] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:08:22:907] nsdo: nsctx: state=14, flg=0x20004004, mvd=0
[000001 22-APR-2021 08:08:22:907] nsdo: gtn=10, gtc=10, ptn=10, ptc=8155
[000001 22-APR-2021 08:08:22:907] nscon: entry
[000001 22-APR-2021 08:08:22:907] nscon: doing connect handshake...
[000001 22-APR-2021 08:08:22:907] nscon: recving a packet
[000001 22-APR-2021 08:08:22:907] nsprecv: entry
[000001 22-APR-2021 08:08:22:907] nsprecv: reading from transport...
[000001 22-APR-2021 08:08:22:907] nttrd: entry
[000001 22-APR-2021 08:08:22:907] nttrd: socket 25 had bytes read=243
[000001 22-APR-2021 08:08:22:907] nttrd: exit
[000001 22-APR-2021 08:08:22:907] nsprecv: 243 bytes from transport
[000001 22-APR-2021 08:08:22:907] nsprecv: tlen=243, plen=243, type=1
[000001 22-APR-2021 08:08:22:907] nsprecv: packet dump
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 F3 00 00 01 00 00 00 |........|
[000001 22-APR-2021 08:08:22:907] nsprecv: 01 3C 01 2C 0C 41 20 00 |.<.,.A..|
[000001 22-APR-2021 08:08:22:907] nsprecv: FF FF 7F 08 00 00 01 00 |........|
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 AD 00 46 00 00 14 00 |...F....|
[000001 22-APR-2021 08:08:22:907] nsprecv: 41 41 7A B2 00 00 00 00 |AAz.....|
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 00 00 00 00 00 00 00 |........|
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 00 00 00 20 00 00 20 |........|
[000001 22-APR-2021 08:08:22:907] nsprecv: 00 00 00 00 00 00 28 44 |......(D|
[000001 22-APR-2021 08:08:22:907] nsprecv: 45 53 43 52 49 50 54 49 |ESCRIPTI|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4F 4E 3D 28 43 4F 4E 4E |ON=(CONN|
[000001 22-APR-2021 08:08:22:907] nsprecv: 45 43 54 5F 44 41 54 41 |ECT_DATA|
[000001 22-APR-2021 08:08:22:907] nsprecv: 3D 28 53 45 52 56 45 52 |=(SERVER|
[000001 22-APR-2021 08:08:22:907] nsprecv: 3D 44 45 44 49 43 41 54 |=DEDICAT|
[000001 22-APR-2021 08:08:22:907] nsprecv: 45 44 29 28 53 45 52 56 |ED)(SERV|
[000001 22-APR-2021 08:08:22:907] nsprecv: 49 43 45 5F 4E 41 4D 45 |ICE_NAME|
[000001 22-APR-2021 08:08:22:907] nsprecv: 3D 4F 52 43 4C 31 31 29 |=ORCL11)|
[000001 22-APR-2021 08:08:22:907] nsprecv: 28 43 49 44 3D 28 50 52 |(CID=(PR|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4F 47 52 41 4D 3D 73 71 |OGRAM=sq|
[000001 22-APR-2021 08:08:22:907] nsprecv: 6C 70 6C 75 73 29 28 48 |lplus)(H|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4F 53 54 3D 4F 52 41 43 |OST=ORAC|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4C 45 31 32 29 28 55 53 |LE12)(US|
[000001 22-APR-2021 08:08:22:907] nsprecv: 45 52 3D 6F 72 61 63 6C |ER=oracl|
[000001 22-APR-2021 08:08:22:907] nsprecv: 65 29 29 29 28 41 44 44 |e)))(ADD|
[000001 22-APR-2021 08:08:22:907] nsprecv: 52 45 53 53 3D 28 50 52 |RESS=(PR|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4F 54 4F 43 4F 4C 3D 54 |OTOCOL=T|
[000001 22-APR-2021 08:08:22:907] nsprecv: 43 50 29 28 48 4F 53 54 |CP)(HOST|
[000001 22-APR-2021 08:08:22:907] nsprecv: 3D 31 39 32 2E 31 36 38 |=192.168|
[000001 22-APR-2021 08:08:22:907] nsprecv: 2E 30 2E 33 30 29 28 50 |.0.30)(P|
[000001 22-APR-2021 08:08:22:907] nsprecv: 4F 52 54 3D 31 35 32 31 |ORT=1521|
[000001 22-APR-2021 08:08:22:907] nsprecv: 29 29 29 |))) |
[000001 22-APR-2021 08:08:22:907] nsprecv: normal exit
[000001 22-APR-2021 08:08:22:907] nscon: got NSPTCN packet
[000001 22-APR-2021 08:08:22:907] nsconneg: entry
[000001 22-APR-2021 08:08:22:907] nsconneg: vsn=316, lov=300, opt=0xc41, sdu=8192, tdu=65535, ntc=0x7f08
[000001 22-APR-2021 08:08:22:907] nsbralc: entry
[000001 22-APR-2021 08:08:22:908] nsbralc: entry
[000001 22-APR-2021 08:08:22:908] nsbralc: entry
[000001 22-APR-2021 08:08:22:908] nsconneg: vsn=314, gbl=0xc01, sdu=8192, tdu=65535
[000001 22-APR-2021 08:08:22:908] nsconneg: normal exit
[000001 22-APR-2021 08:08:22:908] nscon: got 173 bytes connect data
[000001 22-APR-2021 08:08:22:908] nscon: exit (0)
[000001 22-APR-2021 08:08:22:908] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:08:22:908] nsdo: normal exit
[000001 22-APR-2021 08:08:22:908] nsevdrcvreq: entry
[000001 22-APR-2021 08:08:22:908] nsevdansw: exit
[000001 22-APR-2021 08:08:22:908] nttctl: entry
[000001 22-APR-2021 08:08:22:908] nttctl: Clearing non-blocking mode
[000001 22-APR-2021 08:08:22:908] nsevrec: event is 0x20, on 6
[000001 22-APR-2021 08:08:22:908] nstoToqWalk: entry
[000001 22-APR-2021 08:08:22:909] nstoToqWalk: exit (0)
[000001 22-APR-2021 08:08:22:909] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:08:22:909] nsevwait: exit (0)
[000001 22-APR-2021 08:08:22:909] nsglhe: entry
[000001 22-APR-2021 08:08:22:909] nsglhe: Event on cxd 0x1b59550.
[000001 22-APR-2021 08:08:22:910] nsglfc: Assume establishing a connection...
[000001 22-APR-2021 08:08:22:910] nsglfc: command = establish
[000001 22-APR-2021 08:08:22:910] nsglauthorized: entry
[000001 22-APR-2021 08:08:22:910] nsglauthorized: Determining auth method...
[000001 22-APR-2021 08:08:22:910] nsglauthorized: No authorization needed.
[000001 22-APR-2021 08:08:22:910] nsglecmd: entry
[000001 22-APR-2021 08:08:22:910] nscontrol: entry
[000001 22-APR-2021 08:08:22:910] nstoControlATO: entry
[000001 22-APR-2021 08:08:22:910] nstoClearTimeout: entry
[000001 22-APR-2021 08:08:22:910] nstoClearTimeout: ATO disabled for ctx=0x0x1b6c260
[000001 22-APR-2021 08:08:22:910] nstoUpdateActive: entry
[000001 22-APR-2021 08:08:22:910] nstoUpdateActive: Active timeout is -1 (see nstotyp)
[000001 22-APR-2021 08:08:22:910] nstoControlATO: ATO disabled for ctx=0x0x1b6c260
[000001 22-APR-2021 08:08:22:910] nstoControlATO: exit (0)
[000001 22-APR-2021 08:08:22:910] nscontrol: cmd=26, lcl=0x0
[000001 22-APR-2021 08:08:22:910] nscontrol: normal exit
[000001 22-APR-2021 08:08:22:910] nttaddr2bnd: entry
[000001 22-APR-2021 08:08:22:910] snlinGetNameInfo: entry
[000001 22-APR-2021 08:08:22:910] snlinGetNameInfo: exit
[000001 22-APR-2021 08:08:22:910] nttaddr2bnd: Resolved to 192.168.0.40
[000001 22-APR-2021 08:08:22:910] nttaddr2bnd: exit
[000001 22-APR-2021 08:08:22:910] nsglbgetRSPidx: entry
[000001 22-APR-2021 08:08:22:910] nsglbgetRSPidx: returning ecode=0
[000001 22-APR-2021 08:08:22:910] nsglbgetRSPidx: exit
[000001 22-APR-2021 08:08:22:910] nsgettrans_bycxdwattr: entry
[000001 22-APR-2021 08:08:22:910] ntgettrans: entry
[000001 22-APR-2021 08:08:22:910] snlinGetNameInfo: entry
[000001 22-APR-2021 08:08:22:910] snlinGetNameInfo: exit
[000001 22-APR-2021 08:08:22:910] snlinGetAddrInfo: entry
[000001 22-APR-2021 08:08:22:910] snlinGetAddrInfo: exit
[000001 22-APR-2021 08:08:22:910] snlinFreeAddrInfo: entry
[000001 22-APR-2021 08:08:22:910] snlinFreeAddrInfo: exit
[000001 22-APR-2021 08:08:22:910] ntgettrans: exit
[000001 22-APR-2021 08:08:22:910] nsgettrans_bycxdwattr: exit
[000001 22-APR-2021 08:08:22:910] nsglbgetSdPidx: secondary protocol=4
[000001 22-APR-2021 08:08:22:910] nsglb: entry
[000001 22-APR-2021 08:08:22:910] nsglb: instance:ORCL11 new lbscore:1
[000001 22-APR-2021 08:08:22:910] nsglb: exit
[000001 22-APR-2021 08:08:22:910] nsbequeath: entry
[000001 22-APR-2021 08:08:22:910] nsc2addr: entry
[000001 22-APR-2021 08:08:22:910] nlpcaini: entry
[000001 22-APR-2021 08:08:22:910] nlpcaini: prg = /oracle/app/oracle/product/11.2.0/db_1/bin/oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: arg[0] = oracleORCL11
[000001 22-APR-2021 08:08:22:910] nlpcaini: arg[1] = (LOCAL=NO)
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[0] = HOSTNAME=ORACLE11
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[1] = SHELL=/bin/bash
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[2] = TERM=xterm
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[3] = HISTSIZE=1000
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[4] = TMPDIR=/tmp
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[5] = QTDIR=/usr/lib64/qt-3.3
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[6] = QTINC=/usr/lib64/qt-3.3/include
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[7] = USER=oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[8] = LD_LIBRARY_PATH=/oracle/app/oracle/product/11.2.0/db_1/lib:/lib:/usr/lib
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[9] = LS_COLORS=rs=0:di=01;34:ln=01;36:mh=00:pi=40;33:so=01;35:do=01;35:bd=40;33;01:cd=40;33;01:or=40;31;01:mi=01;05;37;41:su=37;41:sg=30;43:ca=30;41:tw=30;42:ow=34;42:st=37;44:ex=01;32:*.tar=01;31:*.tgz=01;31:*.arj=01;31:*.taz=01;31:*.lzh=01;31:*.lzma=01;31:*.tlz=01;31:*.txz=01;31:*.zip=01;31:*.z=01;31:*.Z=01;31:*.dz=01;31:*.gz=01;31:*.lz=01;31:*.xz=01;31:*.bz2=01;31:*.tbz=01;31:*.tbz2=01;31:*.bz=01;31:*.tz=01;31:*.deb=01;31:*.rpm=01;31:*.jar=01;31:*.rar=01;31:*.ace=01;31:*.zoo=01;31:*.cpio=01;31:*.7z=01;31:*.rz=01;31:*.jpg=01;35:*.jpeg=01;35:*.gif=01;35:*.bmp=01;35:*.pbm=01;35:*.pgm=01;35:*.ppm=01;35:*.tga=01;35:*.xbm=01;35:*.xpm=01;35:*.tif=01;35:*.tiff=01;35:*.png=01;35:*.svg=01;35:*.svgz=01;35:*.mng=01;35:*.pcx=01;35:*.mov=01;35:*.mpg=01;35:*.mpeg=01;35:*.m2v=01;35:*.mkv=01;35:*.ogm=01;35:*.mp4=01;35:*.m4v=01;35:*.mp4v=01;35:*.vob=01;35:*.qt=01;35:*.nuv=01;35:*.wmv=01;35:*.asf=01;35:*.rm=01;35:*.rmvb=01;35:*.flc=01;35:*.avi=01;35:*.fli=01;35:*.flv=01;35:*.gl=01;35:*.dl=01;35:*.xcf=01;35:*.xwd=01;35:*.yuv=01;35:*.cgm=01;35:*.emf=01;35:*.axv=01;35:*.anx=01;35:*.ogv=01;35:*.ogx=01;35:*.aac=01;36:*.au=01;36:*.flac=01;36:*.mid=01;36:*.midi=01;36:*.mka=01;36:*.mp3=01;36:*.mpc=01;36:*.ogg=01;36:*.ra=01;36:*.wav=01;36:*.axa=01;36:*.oga=01;36:*.spx=01;36:*.xspf=01;36:
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[10] = ORACLE_SID=ORCL11
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[11] = ORACLE_BASE=/oracle/app/oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[12] = MAIL=/var/spool/mail/oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[13] = PATH=
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[14] = PWD=/home/oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[15] = LANG=en_US.UTF-8
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[16] = HISTCONTROL=ignoredups
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[17] = SHLVL=1
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[18] = HOME=/home/oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[19] = TMP=/tmp
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[20] = LOGNAME=oracle
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[21] = QTLIB=/usr/lib64/qt-3.3/lib
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[22] = CVS_RSH=ssh
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[23] = CLASSPATH=/oracle/app/oracle/product/11.2.0/db_1/jlib:/oracle/app/oracle/product/11.2.0/db_1/rdbms/jlib
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[24] = LESSOPEN=||/usr/bin/lesspipe.sh %s
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[25] = ORACLE_HOME=/oracle/app/oracle/product/11.2.0/db_1
[000001 22-APR-2021 08:08:22:910] nlpcaini: env[26] = G_BROKEN_FILENAMES=1
[000001 22-APR-2021 08:08:22:911] nlpcaini: env[27] = _=/oracle/app/oracle/product/11.2.0/db_1/bin/sqlplus
[000001 22-APR-2021 08:08:22:911] nlpcaini: env[28] = ORA_NET2_DESC=9,12
[000001 22-APR-2021 08:08:22:911] nlpcaini: env[29] = ORACLE_SPAWNED_PROCESS=1
[000001 22-APR-2021 08:08:22:911] nlpcaini: exit
[000001 22-APR-2021 08:08:22:911] nsc2addr: normal exit
[000001 22-APR-2021 08:08:22:911] nsbeqaddr: entry
[000001 22-APR-2021 08:08:22:911] nsbeqaddr: connecting...
[000001 22-APR-2021 08:08:22:911] nsopen: entry
[000001 22-APR-2021 08:08:22:911] nsmal: entry
[000001 22-APR-2021 08:08:22:911] nsmal: 1576 bytes at 0x1b79120
[000001 22-APR-2021 08:08:22:911] nsmal: normal exit
[000001 22-APR-2021 08:08:22:911] nsopenmplx: entry
[000001 22-APR-2021 08:08:22:911] nsmal: entry
[000001 22-APR-2021 08:08:22:911] nsmal: 2760 bytes at 0x1b7bcc0
[000001 22-APR-2021 08:08:22:911] nsmal: normal exit
[000001 22-APR-2021 08:08:22:911] nsiorini: entry
[000001 22-APR-2021 08:08:22:911] nsbal: entry
[000001 22-APR-2021 08:08:22:911] nsbgetfl: entry
[000001 22-APR-2021 08:08:22:911] nsbgetfl: normal exit
[000001 22-APR-2021 08:08:22:911] nsbal: normal exit
[000001 22-APR-2021 08:08:22:911] nsiorini: exit (0)
[000001 22-APR-2021 08:08:22:911] nscpxget: entry
[000001 22-APR-2021 08:08:22:911] nscpxget: normal exit
[000001 22-APR-2021 08:08:22:912] nsopenalloc_nsntx: nlhthput on mplx_ht_nsgbu:ctx=1b79120, nsntx=1b7bcc0
[000001 22-APR-2021 08:08:22:912] nsopenmplx: normal exit
[000001 22-APR-2021 08:08:22:912] ntpcon: entry
[000001 22-APR-2021 08:08:22:912] ntpcon: toc = 6
[000001 22-APR-2021 08:08:22:912] ntpcon: exit
[000001 22-APR-2021 08:08:22:912] nsopen: opening transport...
[000001 22-APR-2021 08:08:22:912] ntpcon: entry
[000001 22-APR-2021 08:08:22:912] ntpcon: toc = 1
[000001 22-APR-2021 08:08:22:912] sntpcall: entry
[000001 22-APR-2021 08:08:22:913] sntpcall: detaching from parent with additional fork
[000001 22-APR-2021 08:08:22:915] sntpcall: hdl[IR]=28, hdl[IW]=27
[000001 22-APR-2021 08:08:22:915] ntpcon: exit
[000001 22-APR-2021 08:08:22:915] nserror: entry
[000001 22-APR-2021 08:08:22:915] nsoptions: entry
[000001 22-APR-2021 08:08:22:915] nsoptions: lcl[0]=0x0, lcl[1]=0x2006, gbl[0]=0x0, gbl[1]=0x0, cha=0x0
[000001 22-APR-2021 08:08:22:915] nsoptions: Vectored IO not supported.
[000001 22-APR-2021 08:08:22:915] nsoptions: lcl[0]=0xf4ffe9ff, lcl[1]=0x6016, gbl[0]=0xe881, gbl[1]=0x0
[000001 22-APR-2021 08:08:22:915] nsoptions: normal exit
[000001 22-APR-2021 08:08:22:915] nsnainit: entry
[000001 22-APR-2021 08:08:22:915] nsnainit: normal exit
[000001 22-APR-2021 08:08:22:915] nsopen: global context check-in (to slot 7) complete
[000001 22-APR-2021 08:08:22:915] nsopen: lcl[0]=0xf4ffe9ff, lcl[1]=0x6016, gbl[0]=0xe881, gbl[1]=0x0, tdu=4096, sdu=8192
[000001 22-APR-2021 08:08:22:915] nsfull_opn: entry
[000001 22-APR-2021 08:08:22:915] nsfull_opn: cid=7, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x0
[000001 22-APR-2021 08:08:22:915] nsfull_opn: nsctx: state=7, flg=0x4001, mvd=0
[000001 22-APR-2021 08:08:22:915] nsfull_opn: normal exit
[000001 22-APR-2021 08:08:22:915] nsopen: normal exit
[000001 22-APR-2021 08:08:22:915] nsevreg: entry
[000001 22-APR-2021 08:08:22:915] nsevreg: begin registration process for 7
[000001 22-APR-2021 08:08:22:915] nsevregPrePost: entry
[000001 22-APR-2021 08:08:22:915] nsevregPrePost: normal exit
[000001 22-APR-2021 08:08:22:915] nsevreg: sgt=0, evn=1, evt[2]=0x0
[000001 22-APR-2021 08:08:22:915] nsevreg: begin notification process for 7
[000001 22-APR-2021 08:08:22:915] nsevregAffectNotif: entry
[000001 22-APR-2021 08:08:22:915] nsevregAffectNotif: exit (0)
[000001 22-APR-2021 08:08:22:915] nsevreg: rdm=0, sgt=0, evt[0]=0x800, [1]=0x800, [2]=0x0, nrg=0
[000001 22-APR-2021 08:08:22:915] nsevreg: registering for 0x800
[000001 22-APR-2021 08:08:22:915] ntpctl: entry
[000001 22-APR-2021 08:08:22:915] ntpctl: exit
[000001 22-APR-2021 08:08:22:915] nsevreg: normal exit
[000001 22-APR-2021 08:08:22:915] nsbeqaddr: error exit
[000001 22-APR-2021 08:08:22:915] nsbequeath: error exit
[000001 22-APR-2021 08:08:22:915] nsglhe: exit
[000001 22-APR-2021 08:08:22:915] nsevwait: entry
[000001 22-APR-2021 08:08:22:915] nsevwait: 6 registered connection(s)
[000001 22-APR-2021 08:08:22:915] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:08:22:915] nsevwait: waiting for transport event (1 thru 7)...
[000001 22-APR-2021 08:08:22:938] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:08:22:938] nsevfnt: cxd: 0x1b6c278 stage 0: NT events set:
READ
[000001 22-APR-2021 08:08:22:938] nsevfnt: cxd: 0x1b6c278 stage 0: NS events set:
[000001 22-APR-2021 08:08:22:938] ntpctl: entry
[000001 22-APR-2021 08:08:22:938] sntpcall: result string is NTP0 12955
[000001 22-APR-2021 08:08:22:938] sntpcall: exit
[000001 22-APR-2021 08:08:22:938] ntpctl: exit
[000001 22-APR-2021 08:08:22:938] nttaddr2bnd: entry
[000001 22-APR-2021 08:08:22:938] snlinGetNameInfo: entry
[000001 22-APR-2021 08:08:22:938] snlinGetNameInfo: exit
[000001 22-APR-2021 08:08:22:938] nttaddr2bnd: Resolved to 192.168.0.30
[000001 22-APR-2021 08:08:22:939] nttaddr2bnd: exit
[000001 22-APR-2021 08:08:22:939] nsbequeath_stg2: doing connect handshake...
[000001 22-APR-2021 08:08:22:939] nsbequeath: doing connect handshake...
[000001 22-APR-2021 08:08:22:939] ntpwr: entry
[000001 22-APR-2021 08:08:22:939] ntpwr: exit
[000001 22-APR-2021 08:08:22:939] ntpwr: entry
[000001 22-APR-2021 08:08:22:939] ntpwr: exit
[000001 22-APR-2021 08:08:22:939] ntpwr: entry
[000001 22-APR-2021 08:08:22:939] ntpwr: exit
[000001 22-APR-2021 08:08:22:939] ntprd: entry
[000001 22-APR-2021 08:08:22:939] ntprd: exit
[000001 22-APR-2021 08:08:22:939] ntprd: entry
[000001 22-APR-2021 08:08:22:939] ntprd: exit
[000001 22-APR-2021 08:08:22:939] nsbequeath: NSE=12586
[000001 22-APR-2021 08:08:22:939] nsbequeath: error reading REDIR/NSE msg
[000001 22-APR-2021 08:08:22:939] nserror: entry
[000001 22-APR-2021 08:08:22:939] nserror: nsres: id=6, op=72, ns=12586, ns2=0; nt[0]=0, nt[1]=0, nt[2]=0; ora[0]=0, ora[1]=0, ora[2]=0
[000001 22-APR-2021 08:08:22:939] nsdo: entry
[000001 22-APR-2021 08:08:22:939] nsdo: cid=6, opcode=67, *bl=0, *what=13, uflgs=0x0, cflgs=0x3
[000001 22-APR-2021 08:08:22:939] nsdo: rank=64, nsctxrnk=0
[000001 22-APR-2021 08:08:22:939] nsdo: nsctx: state=2, flg=0xa0004004, mvd=0
[000001 22-APR-2021 08:08:22:939] nsdo: gtn=243, gtc=243, ptn=10, ptc=8155
[000001 22-APR-2021 08:08:22:939] nscon: entry
[000001 22-APR-2021 08:08:22:939] nscon: sending NSPTRS packet
[000001 22-APR-2021 08:08:22:939] nspsend: entry
[000001 22-APR-2021 08:08:22:939] nspsend: plen=8, type=11
[000001 22-APR-2021 08:08:22:939] nttwr: entry
[000001 22-APR-2021 08:08:22:939] nttwr: socket 25 had bytes written=8
[000001 22-APR-2021 08:08:22:940] nttwr: exit
[000001 22-APR-2021 08:08:22:940] nspsend: packet dump
[000001 22-APR-2021 08:08:22:940] nspsend: 00 08 00 00 0B 00 00 00 |........|
[000001 22-APR-2021 08:08:22:940] nspsend: 8 bytes to transport
[000001 22-APR-2021 08:08:22:940] nspsend: normal exit
[000001 22-APR-2021 08:08:22:940] nscon: exit (0)
[000001 22-APR-2021 08:08:22:940] nsdo: nsctxrnk=0
[000001 22-APR-2021 08:08:22:940] nsdo: normal exit
[000001 22-APR-2021 08:08:22:940] nsclose: entry
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: entry
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: exit
[000001 22-APR-2021 08:08:22:940] nstimarmed: entry
[000001 22-APR-2021 08:08:22:940] nstimarmed: no timer allocated
[000001 22-APR-2021 08:08:22:940] nstimarmed: normal exit
[000001 22-APR-2021 08:08:22:940] nstoClearTimeout: entry
[000001 22-APR-2021 08:08:22:940] nstoClearTimeout: ATO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:08:22:940] nstoClearTimeout: STO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:08:22:940] nstoClearTimeout: RTO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:08:22:940] nstoClearTimeout: PITO disabled for ctx=0x0x1b79120
[000001 22-APR-2021 08:08:22:940] nstoUpdateActive: entry
[000001 22-APR-2021 08:08:22:940] nstoUpdateActive: Active timeout is -1 (see nstotyp)
[000001 22-APR-2021 08:08:22:940] ntpctl: entry
[000001 22-APR-2021 08:08:22:940] ntpctl: exit
[000001 22-APR-2021 08:08:22:940] ntpctl: entry
[000001 22-APR-2021 08:08:22:940] ntpctl: exit
[000001 22-APR-2021 08:08:22:940] nsfull_cls: entry
[000001 22-APR-2021 08:08:22:940] nsfull_cls: cid=7, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x40
[000001 22-APR-2021 08:08:22:940] nsfull_cls: nsctx: state=8, flg=0x20004001, mvd=0
[000001 22-APR-2021 08:08:22:940] nsevunreg: entry
[000001 22-APR-2021 08:08:22:940] nsevunreg: cid=7, sgt=0, rdm=0
[000001 22-APR-2021 08:08:22:940] nsevunreg: 5 registered connection(s)
[000001 22-APR-2021 08:08:22:940] nsevunreg: exit (0)
[000001 22-APR-2021 08:08:22:940] nsfull_cls: normal exit
[000001 22-APR-2021 08:08:22:940] nsiocancel: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: cur = 1b798c8
[000001 22-APR-2021 08:08:22:940] nsbfr: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: normal exit
[000001 22-APR-2021 08:08:22:940] nsbfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsiofrrg: exit
[000001 22-APR-2021 08:08:22:940] nsiocancel: exit
[000001 22-APR-2021 08:08:22:940] nsclose: closing transport
[000001 22-APR-2021 08:08:22:940] ntpdisc: entry
[000001 22-APR-2021 08:08:22:940] ntpdisc: exit
[000001 22-APR-2021 08:08:22:940] nsclose: global context check-out (from slot 7) complete
[000001 22-APR-2021 08:08:22:940] nsnadisc: entry
[000001 22-APR-2021 08:08:22:940] nsnadisc: no native services in use - returning
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: entry
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: exit
[000001 22-APR-2021 08:08:22:940] nsopenfree_nsntx: nlhthdel from mplx_ht_nsgbu, ctx=1b79120 nsntx=1b7bcc0
[000001 22-APR-2021 08:08:22:940] nsiocancel: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: exit
[000001 22-APR-2021 08:08:22:940] nsiocancel: exit
[000001 22-APR-2021 08:08:22:940] nsmfr: entry
[000001 22-APR-2021 08:08:22:940] nsmfr: 2760 bytes at 0x1b7bcc0
[000001 22-APR-2021 08:08:22:940] nsmfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsmfr: entry
[000001 22-APR-2021 08:08:22:940] nsmfr: 1576 bytes at 0x1b79120
[000001 22-APR-2021 08:08:22:940] nsmfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsclose: normal exit
[000001 22-APR-2021 08:08:22:940] nsclose: entry
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: entry
[000001 22-APR-2021 08:08:22:940] nsvntx_dei: exit
[000001 22-APR-2021 08:08:22:940] nstimarmed: entry
[000001 22-APR-2021 08:08:22:940] nstimarmed: no timer allocated
[000001 22-APR-2021 08:08:22:940] nstimarmed: normal exit
[000001 22-APR-2021 08:08:22:940] nsfull_cls: entry
[000001 22-APR-2021 08:08:22:940] nsfull_cls: cid=6, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x40
[000001 22-APR-2021 08:08:22:940] nsfull_cls: nsctx: state=2, flg=0xa0004000, mvd=0
[000001 22-APR-2021 08:08:22:940] nsevunreg: entry
[000001 22-APR-2021 08:08:22:940] nsevunreg: cid=6, sgt=0, rdm=0
[000001 22-APR-2021 08:08:22:940] nsevunreg: 4 registered connection(s)
[000001 22-APR-2021 08:08:22:940] nsevunreg: exit (0)
[000001 22-APR-2021 08:08:22:940] nsbfr: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: normal exit
[000001 22-APR-2021 08:08:22:940] nsbfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsbfr: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: normal exit
[000001 22-APR-2021 08:08:22:940] nsbfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsfull_cls: normal exit
[000001 22-APR-2021 08:08:22:940] nsiocancel: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: entry
[000001 22-APR-2021 08:08:22:940] nsiofrrg: cur = 1b574f8
[000001 22-APR-2021 08:08:22:940] nsbfr: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: entry
[000001 22-APR-2021 08:08:22:940] nsbaddfl: normal exit
[000001 22-APR-2021 08:08:22:940] nsbfr: normal exit
[000001 22-APR-2021 08:08:22:940] nsiofrrg: exit
[000001 22-APR-2021 08:08:22:940] nsiocancel: exit
[000001 22-APR-2021 08:08:22:940] nsclose: closing transport
[000001 22-APR-2021 08:08:22:941] nttdisc: entry
[000001 22-APR-2021 08:08:22:941] nttdisc: Closed socket 25
[000001 22-APR-2021 08:08:22:941] nttdisc: exit
[000001 22-APR-2021 08:08:22:941] nsclose: global context check-out (from slot 6) complete
[000001 22-APR-2021 08:08:22:941] nsnadisc: entry
[000001 22-APR-2021 08:08:22:941] nsnadisc: no native services in use - returning
[000001 22-APR-2021 08:08:22:941] nsvntx_dei: entry
[000001 22-APR-2021 08:08:22:941] nsvntx_dei: exit
[000001 22-APR-2021 08:08:22:941] nsopenfree_nsntx: nlhthdel from mplx_ht_nsgbu, ctx=1b6c260 nsntx=1b6a790
[000001 22-APR-2021 08:08:22:941] nsiocancel: entry
[000001 22-APR-2021 08:08:22:941] nsiofrrg: entry
[000001 22-APR-2021 08:08:22:941] nsiofrrg: exit
[000001 22-APR-2021 08:08:22:941] nsiocancel: exit
[000001 22-APR-2021 08:08:22:941] nsmfr: entry
[000001 22-APR-2021 08:08:22:941] nsmfr: 2760 bytes at 0x1b6a790
[000001 22-APR-2021 08:08:22:941] nsmfr: normal exit
[000001 22-APR-2021 08:08:22:941] nsmfr: entry
[000001 22-APR-2021 08:08:22:941] nsmfr: 1576 bytes at 0x1b6c260
[000001 22-APR-2021 08:08:22:941] nsmfr: normal exit
[000001 22-APR-2021 08:08:22:941] nsclose: normal exit
[000001 22-APR-2021 08:08:22:941] nsevrec: event is 0x20, on -1
[000001 22-APR-2021 08:08:22:941] nsevwait: 1 posted event(s)
[000001 22-APR-2021 08:08:22:941] nsevwait: exit (0)
[000001 22-APR-2021 08:08:22:941] nsglhe: entry
[000001 22-APR-2021 08:08:22:941] nsglhe: Event on cxd 0x1b59550.
[000001 22-APR-2021 08:08:22:941] nsgldissolve: entry
[000001 22-APR-2021 08:08:22:941] nsdisc: entry
[000001 22-APR-2021 08:08:22:941] nsclose: entry
[000001 22-APR-2021 08:08:22:941] nsclose: normal exit
[000001 22-APR-2021 08:08:22:941] nsdisc: exit (0)
[000001 22-APR-2021 08:08:22:941] nsgldissolve: Deallocating cxd 0x1b59550.
[000001 22-APR-2021 08:08:22:941] nsgldissolve: exit
[000001 22-APR-2021 08:08:22:941] nsglhe: exit
[000001 22-APR-2021 08:08:22:941] nsevwait: entry
[000001 22-APR-2021 08:08:22:941] nsevwait: 4 registered connection(s)
[000001 22-APR-2021 08:08:22:941] nsevwait: 0 pre-posted event(s)
[000001 22-APR-2021 08:08:22:941] nsevwait: waiting for transport event (1 thru 5)...621줄이 마지막 줄임
접속을 성공한 경우와 실패한 경우 로그 비교
실패한 로그의 마지막줄(621번째 줄)에 이 메세지가 기록되고
[000001 22-APR-2021 08:08:22:941] nsevwait: waiting for transport event (1 thru 5)...
성공한 로그의 622번째 줄부터 이 메세지가 시작됨
[000001 22-APR-2021 08:07:37:777] nsevwait: 1 newly-posted event(s)
[000001 22-APR-2021 08:07:37:777] nsevfnt: cxd: 0x1b60eb0 stage 0: NT events set:
READ
[000001 22-APR-2021 08:07:37:777] nsevfnt: cxd: 0x1b60eb0 stage 0: NS events set:
INCOMING SEND
이 부분 이후 로그의 존재유무가 접속 실패, 성공을 구분하는 요소임
* 접속량이 많은 db의 경우 트레이스 파일이 빠르게 쌓이기 때문에
위와 같이 접속 성공,실패 유무를 찾는게 어려울 수 있음
접속한 클라이언트 IP 확인
|
1
2
3
4
5
6
7
8
9
10
11
|
$ cd /home/oracle/lsnr/log/
$ tail -f listener_trace1.trc
================ <- 구분을 위해 ========입력
[000001 22-APR-2021 08:07:37:444] nttcnr: connected on ipaddr 192.168.0.30
[000001 22-APR-2021 08:07:37:444] nttvlser: entry
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: entry
[000001 22-APR-2021 08:07:37:444] snlinGetNameInfo: exit
[000001 22-APR-2021 08:07:37:444] nttvlser: valid node check on incoming node 192.168.0.40
[000001 22-APR-2021 08:07:37:444] nttvlser: Accepted Entry: 192.168.0.40
[000001 22-APR-2021 08:07:37:444] nttcnr: exit
[000001 22-APR-2021 08:07:37:444] nttcon: NT layer TCP/IP connection has been established.
|
tnsping 로그에서 확인한것과 같이 incoming node 부분을 검색하면됨
find 명령으로 접속한 클라이언트 ip 찾기
|
1
2
3
4
5
6
7
8
9
10
11
12
13
|
$ find . -name "*.trc" -print | xargs grep -i "incoming node" -a
./listener_trace1.trc:[000001 22-APR-2021 08:35:36:900] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 08:45:49:352] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 08:46:09:675] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 08:49:05:873] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 08:59:08:554] nttvlser: valid node check on incoming node 192.168.0.30
./listener_trace1.trc:[000001 22-APR-2021 08:59:28:199] nttvlser: valid node check on incoming node 192.168.0.30
./listener_trace1.trc:[000001 22-APR-2021 08:59:45:321] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 08:59:48:724] nttvlser: valid node check on incoming node 192.168.0.40
./listener_trace1.trc:[000001 22-APR-2021 09:08:48:042] nttvlser: valid node check on incoming node 192.168.0.30
./listener_trace1.trc:[000001 22-APR-2021 09:10:47:380] nttvlser: valid node check on incoming node 192.168.0.30
./listener_trace1.trc:[000001 22-APR-2021 09:10:52:283] nttvlser: valid node check on incoming node 192.168.0.30
./listener_trace1.trc:[000001 22-APR-2021 09:10:54:696] nttvlser: valid node check on incoming node 192.168.0.30
|
방법3. audit OS 로그 확인
DB서버 내 파라미터 확인(OS)
|
1
2
3
4
5
|
SQL> show parameter audit_trail
NAME TYPE VALUE
------------------------------------ ----------- ------------------------------
audit_trail string OS
|
파라미터 값이 OS가 아닌 다른 값이라면 아래와 같이 변경
|
1
2
3
4
5
6
|
SQL> alter system set audit_trail = OS scope=spfile;
System altered.
SQL> shutdown immediate
SQL> startup
|
audit 파일 경로 확인
|
1
2
3
4
5
|
SQL> show parameter audit_file_dest
NAME TYPE VALUE
------------------------------------ ----------- ------------------------------
audit_file_dest string /oracle/app/oracle/admin/ORCL11/adump
|
*tnsping 에는 audit이 남지 않기 때문에 로그를 첨부하지 않음
클라이언트에서 접속성공 테스트
|
1
2
3
4
5
6
7
8
9
10
11
12
|
$ sqlplus imsi/imsi@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 23:42:05 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
Connected to:
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
SQL>
|
audit 로그 확인
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
|
$ cd /oracle/app/oracle/admin/ORCL11/adump/
$ ls -ltr
-rw-r----- 1 oracle dba 1002 Apr 22 08:46 ORCL11_ora_13175_20210422084609746931143795.aud
$ vi ORCL11_ora_13175_20210422084609746931143795.aud
Audit file /oracle/app/oracle/admin/ORCL11/adump/ORCL11_ora_13175_20210422084609746931143795.aud
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
ORACLE_HOME = /oracle/app/oracle/product/11.2.0/db_1
System name: Linux
Node name: ORACLE11
Release: 4.1.12-37.4.1.el6uek.x86_64
Version: #2 SMP Tue May 17 07:23:38 PDT 2016
Machine: x86_64
VM name: VMWare Version: 6
Instance name: ORCL11
Redo thread mounted by this instance: 1
Oracle process number: 26
Unix process pid: 13175, image: oracle@ORACLE11
Thu Apr 22 08:46:09 2021 +09:00
LENGTH: "338"
SESSIONID:[6] "143177" ENTRYID:[1] "1" STATEMENT:[1] "1" USERID:[4] "IMSI"
USERHOST:[8] "ORACLE12" TERMINAL:[5] "pts/0" ACTION:[3] "100" RETURNCODE:[1] "0"
COMMENT$TEXT:[99] "Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22280))"
OS$USERID:[6] "oracle" DBID:[8] "13364092" PRIV$USED:[1] "5"
|
클라이언트에서 접속실패 테스트
|
1
2
3
4
5
6
7
8
9
10
11
|
$ sqlplus imsi/imsi1@orcl11
SQL*Plus: Release 12.2.0.1.0 Production on Wed Apr 21 23:45:01 2021
Copyright (c) 1982, 2016, Oracle. All rights reserved.
ERROR:
ORA-01017: invalid username/password; logon denied
Enter user-name:
|
audit 로그 확인
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
|
$ cd /oracle/app/oracle/admin/ORCL11/adump/
$ ls -ltr
total 8
-rw-r----- 1 oracle dba 1266 Apr 22 08:48 ORCL11_ora_13175_20210422084609746931143795.aud
-rw-r----- 1 oracle dba 988 Apr 22 08:49 ORCL11_ora_13184_20210422084905922829143795.aud
$ vi ORCL11_ora_13184_20210422084905922829143795.aud
Audit file /oracle/app/oracle/admin/ORCL11/adump/ORCL11_ora_13184_20210422084905922829143795.aud
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
ORACLE_HOME = /oracle/app/oracle/product/11.2.0/db_1
System name: Linux
Node name: ORACLE11
Release: 4.1.12-37.4.1.el6uek.x86_64
Version: #2 SMP Tue May 17 07:23:38 PDT 2016
Machine: x86_64
VM name: VMWare Version: 6
Instance name: ORCL11
Redo thread mounted by this instance: 1
Oracle process number: 26
Unix process pid: 13184, image: oracle@ORACLE11
Thu Apr 22 08:49:05 2021 +09:00
LENGTH: "324"
SESSIONID:[6] "143178" ENTRYID:[1] "1" STATEMENT:[1] "1" USERID:[4] "IMSI"
USERHOST:[8] "ORACLE12" TERMINAL:[5] "pts/0" ACTION:[3] "100" RETURNCODE:[4] "1017"
COMMENT$TEXT:[99] "Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22302))"
OS$USERID:[6] "oracle" DBID:[8] "13364092"
|
접속을 성공한 경우와 실패한 경우 로그 비교
|
1
2
3
4
5
6
7
8
9
10
11
12
|
성공
LENGTH: "338"
SESSIONID:[6] "143177" ENTRYID:[1] "1" STATEMENT:[1] "1" USERID:[4] "IMSI"
USERHOST:[8] "ORACLE12" TERMINAL:[5] "pts/0" ACTION:[3] "100" RETURNCODE:[1] "0"
COMMENT$TEXT:[99] "Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22280))"
OS$USERID:[6] "oracle" DBID:[8] "13364092" PRIV$USED:[1] "5"
실패
LENGTH: "324"
SESSIONID:[6] "143178" ENTRYID:[1] "1" STATEMENT:[1] "1" USERID:[4] "IMSI"
USERHOST:[8] "ORACLE12" TERMINAL:[5] "pts/0" ACTION:[3] "100" RETURNCODE:[4] "1017"
COMMENT$TEXT:[99] "Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22302))"
OS$USERID:[6] "oracle" DBID:[8] "13364092"
|
거의 비슷하지만 RETURNCODE를 보면 접속 성공, 실패 유무를 확인할 수 있음
RETURNCODE가 0이면 성공을 뜻하고 1017이면 실패를 뜻함
RETURNCODE 설명
0 : 작업 성공
1017 : username / password가 잘못됨, 로그온이 거부됨
28001 : 암호가 만료됨
942 : 테이블 또는 뷰가 없음
find 명령으로 접속실패한 로그만 확인
|
1
2
3
4
5
6
|
$ cd /oracle/app/oracle/admin/ORCL11/adump/
$ find . -name "*.aud" -print | xargs grep -i "RETURNCODE:\[4\]"
./ORCL11_ora_13184_20210422084905922829143795.aud:SESSIONID:[6] "143178" ENTRYID:[1] "1" STATEMENT:[1] "1"
USERID:[4] "IMSI" USERHOST:[8] "ORACLE12" TERMINAL:[5] "pts/0" ACTION:[3] "100" RETURNCODE:[4] "1017"
COMMENT$TEXT:[99] "Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22302))"
OS$USERID:[6] "oracle" DBID:[8] "13364092"
|
+추가
audit_trail이 db인 경우 접속 실패한 내역 확인하는 방법
접속 실패한 경우 로그
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
|
SQL> show parameter audit_trail
NAME TYPE VALUE
------------------------------------ ----------- ------------------------------
audit_trail string DB
SQL> select username, action_name, returncode, comment_text from dba_audit_trail where RETURNCODE = 1017;
USERNAME ACTION_NAME RETURNCODE
------------------------------ ---------------------------- ----------
COMMENT_TEXT
---------------------------------------------------------------------------------------------------
IMSI LOGON 1017
Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22394))
|
접속 성공한 경우 로그
|
1
2
3
4
5
6
7
8
9
10
11
|
SQL> select username, action_name, returncode, comment_text from dba_audit_trail where RETURNCODE = 0;
USERNAME ACTION_NAME RETURNCODE
------------------------------ ---------------------------- ----------
COMMENT_TEXT
----------------------------------------------------------------------------------------------------
IMSI LOGON 0
Authenticated by: DATABASE; Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.0.40)(PORT=22392))
IMSI LOGOFF 0
(null)
|
테스트 완료 후 설정 초기화
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
|
audit 설정 none으로 변경
SQL> alter system set audit_trail=none scope=spfile;
SQL> shutdown immediate
SQL> startup
리스너 파일 트레이스 명령 삭제
$ vi $ORACLE_HOME/network/admin/listener.ora
LISTENER =
(DESCRIPTION_LIST =
(DESCRIPTION =
(ADDRESS = (PROTOCOL = TCP)(HOST = ORACLE11)(PORT = 1521))
(ADDRESS = (PROTOCOL = IPC)(KEY = EXTPROC1521))
)
)
리스너 reload
$ lsnrctl reload
LSNRCTL for Linux: Version 11.2.0.4.0 - Production on 22-APR-2021 09:10:47
Copyright (c) 1991, 2013, Oracle. All rights reserved.
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ORACLE11)(PORT=1521)))
The command completed successfully
리스너 상태 조회
$ lsnrctl status
LSNRCTL for Linux: Version 11.2.0.4.0 - Production on 22-APR-2021 09:10:54
Copyright (c) 1991, 2013, Oracle. All rights reserved.
Connecting to (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ORACLE11)(PORT=1521)))
STATUS of the LISTENER
------------------------
Alias LISTENER
Version TNSLSNR for Linux: Version 11.2.0.4.0 - Production
Start Date 22-APR-2021 06:19:56
Uptime 0 days 2 hr. 50 min. 57 sec
Trace Level off
Security ON: Local OS Authentication
SNMP OFF
Listener Parameter File /oracle/app/oracle/product/11.2.0/db_1/network/admin/listener.ora
Listener Log File /oracle/app/oracle/diag/tnslsnr/ORACLE11/listener/alert/log.xml
Listening Endpoints Summary...
(DESCRIPTION=(ADDRESS=(PROTOCOL=tcp)(HOST=ORACLE11)(PORT=1521)))
(DESCRIPTION=(ADDRESS=(PROTOCOL=ipc)(KEY=EXTPROC1521)))
Services Summary...
Service "ORCL11" has 1 instance(s).
Instance "ORCL11", status READY, has 1 handler(s) for this service...
The command completed successfully
|
참조 : https://docs.oracle.com/database/121/NETRF/listener.htm#NETRF400
https://community.oracle.com/mosc/discussion/2771137/translate-returncode-from-sys-aud-into-message-text
https://community.oracle.com/mosc/discussion/3177132/audit-failed-logins
https://community.oracle.com/mosc/discussion/3481010/find-who-is-locked-the-account
https://docs.oracle.com/cd/E11882_01/server.112/e40402/statviews_3081.htm#REFRN23023
'ORACLE > Admin' 카테고리의 다른 글
| 오라클 19c New Features 및 주요 변경사항 (0) | 2021.05.12 |
|---|---|
| 오라클 19c XDB service dispatcher 포트 변경 및 비활성화 (0) | 2021.04.22 |
| 오라클 과도한 리두, 아카이브 로그를 생성하는 세션을 찾는 방법 (0) | 2021.04.14 |
| 오라클 11g R2 scn을 빠르게 증가시키는 방법 (0) | 2021.03.09 |
| 오라클 DBMS_OBFUSCATION_TOOLKIT 암호화 방법 (0) | 2021.01.07 |