SQLPlus Hangs
in [Oracle]
|
From: raghu on 26 Dec 2007 06:38 When I enter the credentials in SQL Plus, it hangs. This happens both in the server machine (Oracle 10.2.0) and the clients. But I am able to login using the command prompt in the server. Tnsping works correctly. Nothing is logged in the alert log for the login attempt. Any ideas? Here is an excerpt of the alert log: Starting background process EMN0 EMN0 started with pid=134, OS id=3648 Wed Dec 26 11:56:33 2007 Shutting down instance: further logons disabled Wed Dec 26 11:56:33 2007 Stopping background process QMNC Wed Dec 26 11:56:34 2007 Stopping background process CJQ0 Wed Dec 26 11:56:34 2007 Background process QMNC not dead after 150 seconds Wed Dec 26 11:56:34 2007 Killing background process QMNC Wed Dec 26 11:56:34 2007 Stopping background process MMNL Wed Dec 26 11:56:36 2007 Background process MMNL not dead after 10 seconds Wed Dec 26 11:56:36 2007 Killing background process MMNL Wed Dec 26 11:56:36 2007 Stopping background process MMON Wed Dec 26 11:56:37 2007 Background process MMON not dead after 30 seconds Wed Dec 26 11:56:37 2007 Killing background process MMON Wed Dec 26 11:56:37 2007 Shutting down instance (immediate) License high water mark = 5 Wed Dec 26 11:56:37 2007 Stopping Job queue slave processes Wed Dec 26 11:56:37 2007 Job queue slave processes stopped All dispatchers and shared servers shutdown Wed Dec 26 11:56:44 2007 ALTER DATABASE CLOSE NORMAL Wed Dec 26 11:56:44 2007 SMON: disabling tx recovery SMON: disabling cache recovery Wed Dec 26 11:56:44 2007 SUCCESS: diskgroup ORAREDO was dismounted Shutting down archive processes Archiving is disabled Wed Dec 26 11:56:49 2007 ARCH shutting down ARC1: Archival stopped Wed Dec 26 11:56:54 2007 ARCH shutting down ARC0: Archival stopped Wed Dec 26 11:56:55 2007 Thread 1 closed at log sequence 15521 Successful close of redo thread 1 Wed Dec 26 11:56:59 2007 Completed: ALTER DATABASE CLOSE NORMAL Wed Dec 26 11:56:59 2007 ALTER DATABASE DISMOUNT Wed Dec 26 11:56:59 2007 SUCCESS: diskgroup ORADATA was dismounted SUCCESS: diskgroup ORABACKUP was dismounted Wed Dec 26 11:56:59 2007 Completed: ALTER DATABASE DISMOUNT ARCH: Archival disabled due to shutdown: 1089 Shutting down archive processes Archiving is disabled Archive process shutdown avoided: 0 active ARCH: Archival disabled due to shutdown: 1089 Shutting down archive processes Archiving is disabled Archive process shutdown avoided: 0 active Wed Dec 26 11:57:05 2007 freeing rdom 0 Wed Dec 26 11:58:31 2007 Starting ORACLE instance (normal) LICENSE_MAX_SESSION = 0 LICENSE_SESSIONS_WARNING = 0 Interface type 1 Private 192.168.70.0 configured from OCR for use as a cluster interconnect Interface type 1 Public 10.45.5.0 configured from OCR for use as a public interface Picked latch-free SCN scheme 3 Autotune of undo retention is turned on. LICENSE_MAX_USERS = 0 SYS auditing is disabled ksdpec: called for event 13740 prior to event group initialization Starting up ORACLE RDBMS Version: 10.2.0.2.0. System parameters with non-default values: processes = 500 sessions = 555 __shared_pool_size = 1711276032 __large_pool_size = 0 __java_pool_size = 16777216 __streams_pool_size = 0 trace_enabled = FALSE nls_language = AMERICAN nls_territory = UNITED KINGDOM sga_target = 12884901888 control_files = +ORADATA/edwprd/controlfile/current. 256.620240201, +ORABACKUP/edwprd/controlfile/current.256.620240201 db_block_size = 16384 __db_cache_size = 11140071424 db_writer_processes = 8 compatible = 10.2.0.2.0 log_archive_dest_1 = LOCATION=+ORABACKUP/EDWPRD/ log_archive_format = ARC%S_%R.%T db_file_multiblock_read_count= 16 cluster_database = TRUE cluster_database_instances= 2 db_create_file_dest = +ORADATA db_recovery_file_dest = +ORABACKUP db_recovery_file_dest_size= 10737418240 thread = 1 instance_number = 1 undo_management = AUTO undo_tablespace = UNDOTBS1 remote_login_passwordfile= EXCLUSIVE db_domain = dispatchers = (PROTOCOL=TCP) (SERVICE=EDWPRDXDB) remote_listener = LISTENERS_EDWPRD job_queue_processes = 10 audit_file_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD \ADUMP background_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD \BDUMP user_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD \UDUMP max_dump_file_size = 1024 core_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD \CDUMP db_name = EDWPRD open_cursors = 300 optimizer_mode = choose pga_aggregate_target = 1707081728 Cluster communication is configured to use the following interface(s) for this instance 192.168.70.11 Wed Dec 26 11:58:37 2007 cluster interconnect IPC version:Oracle 9i Winsock2 TCP/IP IPC IPC Vendor 0 proto 0 Version 0.0 PMON started with pid=2, OS id=7116 DIAG started with pid=6, OS id=6880 PSP0 started with pid=10, OS id=6476 LMON started with pid=14, OS id=6856 Wed Dec 26 11:58:39 2007 ORA-00130: invalid listener address '(ADDRESS=(PROTOCOL=TCP) (HOST=BRNORA62-vip)(PORT=1521))' LMD0 started with pid=18, OS id=7016 LMS0 started with pid=22, OS id=6728 LMS1 started with pid=26, OS id=4036 MMAN started with pid=30, OS id=6204 DBW0 started with pid=34, OS id=448 DBW1 started with pid=38, OS id=5492 DBW2 started with pid=42, OS id=4436 DBW3 started with pid=46, OS id=5960 DBW4 started with pid=50, OS id=6324 DBW5 started with pid=54, OS id=5700 DBW6 started with pid=58, OS id=2828 DBW7 started with pid=62, OS id=4612 LGWR started with pid=66, OS id=3952 CKPT started with pid=70, OS id=1572 SMON started with pid=74, OS id=6288 RECO started with pid=78, OS id=5860 CJQ0 started with pid=82, OS id=6672 MMON started with pid=86, OS id=5288 MMNL started with pid=90, OS id=6976 Wed Dec 26 11:58:39 2007 starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES) (PROTOCOL=TCP))'... starting up 1 shared server(s) ... Wed Dec 26 11:58:39 2007 lmon registered with NM - instance id 1 (internal mem no 0) Wed Dec 26 11:58:41 2007 Reconfiguration started (old inc 0, new inc 2) List of nodes: 0 Global Resource Directory frozen * allocate domain 0, invalid = TRUE Communication channels reestablished Master broadcasted resource hash value bitmaps Non-local Process blocks cleaned out Wed Dec 26 11:58:41 2007 LMS 1: 0 GCS shadows cancelled, 0 closed Wed Dec 26 11:58:42 2007 LMS 0: 0 GCS shadows cancelled, 0 closed Set master node info Submitted all remote-enqueue requests Dwn-cvts replayed, VALBLKs dubious All grantable enqueues granted Post SMON to start 1st pass IR Wed Dec 26 11:58:42 2007 LMS 0: 0 GCS shadows traversed, 0 replayed Wed Dec 26 11:58:42 2007 LMS 1: 0 GCS shadows traversed, 0 replayed Wed Dec 26 11:58:42 2007 Submitted all GCS remote-cache requests Post SMON to start 1st pass IR Fix write in gcs resources Reconfiguration complete LCK0 started with pid=102, OS id=1876 Wed Dec 26 11:58:43 2007 ALTER DATABASE MOUNT Wed Dec 26 11:58:43 2007 This instance was first to mount Wed Dec 26 11:58:43 2007 Starting background process ASMB ASMB started with pid=110, OS id=5428 Starting background process RBAL RBAL started with pid=114, OS id=4344 Wed Dec 26 11:58:48 2007 SUCCESS: diskgroup ORADATA was mounted SUCCESS: diskgroup ORABACKUP was mounted Wed Dec 26 11:58:52 2007 Setting recovery target incarnation to 1 Wed Dec 26 11:58:52 2007 Successful mount of redo thread 1, with mount id 606843251 Wed Dec 26 11:58:52 2007 Database mounted in Shared Mode (CLUSTER_DATABASE=TRUE) Completed: ALTER DATABASE MOUNT Wed Dec 26 11:58:52 2007 ALTER DATABASE OPEN This instance was first to open Picked broadcast on commit scheme to generate SCNs Wed Dec 26 11:58:53 2007 LGWR: STARTING ARCH PROCESSES ARC0 started with pid=134, OS id=4724 Wed Dec 26 11:58:53 2007 ARC0: Archival started ARC1 started with pid=138, OS id=4700 Wed Dec 26 11:58:53 2007 ARC1: Archival started LGWR: STARTING ARCH PROCESSES COMPLETE SUCCESS: diskgroup ORAREDO was mounted Thread 1 opened at log sequence 15521 Current log# 6 seq# 15521 mem# 0: +ORAREDO/edwprd/onlinelog/ group_6.257.630862051 Current log# 6 seq# 15521 mem# 1: +ORAREDO/edwprd/onlinelog/ group_6.256.630862053 Successful open of redo thread 1 Wed Dec 26 11:58:53 2007 MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set Wed Dec 26 11:58:53 2007 ARC1: STARTING ARCH PROCESSES Wed Dec 26 11:58:53 2007 ARC0: Becoming the 'no FAL' ARCH ARC0: Becoming the 'no SRL' ARCH Wed Dec 26 11:58:53 2007 ARC2: Archival started ARC2 started with pid=142, OS id=4256 Wed Dec 26 11:58:53 2007 SMON: enabling cache recovery Wed Dec 26 11:58:53 2007 ARC1: STARTING ARCH PROCESSES COMPLETE ARC1: Becoming the heartbeat ARCH Wed Dec 26 11:58:54 2007 Successfully onlined Undo Tablespace 1. Wed Dec 26 11:58:54 2007 SMON: enabling tx recovery Wed Dec 26 11:58:54 2007 Database Characterset is WE8MSWIN1252 Wed Dec 26 11:58:54 2007 Instance recovery: looking for dead threads Instance recovery: lock domain invalid but no dead threads Wed Dec 26 11:58:54 2007 replication_dependency_tracking turned off (no async multimaster replication found) Starting background process QMNC QMNC started with pid=146, OS id=4912 Wed Dec 26 11:58:58 2007 Completed: ALTER DATABASE OPEN Wed Dec 26 11:58:58 2007 db_recovery_file_dest_size of 10240 MB is 0.21% used. This is a user-specified limit on the amount of space that will be used by this database for recovery-related files, and does not reflect the amount of space available in the underlying filesystem or ASM diskgroup. Wed Dec 26 11:59:53 2007 Shutting down archive processes Wed Dec 26 11:59:58 2007 ARCH shutting down ARC2: Archival stopped
From: fitzjarrell on 26 Dec 2007 09:31 On Dec 26, 5:38 am, raghu <raghu_v...(a)yahoo.com> wrote: > When I enter the credentials in SQL Plus, it hangs. This happens both > in the server machine (Oracle 10.2.0) and the clients. But I am able > to login using the command prompt in the server. Tnsping works > correctly. Nothing is logged in the alert log for the login attempt. > Any ideas? > > Here is an excerpt of the alert log: > > Starting background process EMN0 > EMN0 started with pid=134, OS id=3648 > Wed Dec 26 11:56:33 2007 > Shutting down instance: further logons disabled > Wed Dec 26 11:56:33 2007 > Stopping background process QMNC > Wed Dec 26 11:56:34 2007 > Stopping background process CJQ0 > Wed Dec 26 11:56:34 2007 > Background process QMNC not dead after 150 seconds > Wed Dec 26 11:56:34 2007 > Killing background process QMNC > Wed Dec 26 11:56:34 2007 > Stopping background process MMNL > Wed Dec 26 11:56:36 2007 > Background process MMNL not dead after 10 seconds > Wed Dec 26 11:56:36 2007 > Killing background process MMNL > Wed Dec 26 11:56:36 2007 > Stopping background process MMON > Wed Dec 26 11:56:37 2007 > Background process MMON not dead after 30 seconds > Wed Dec 26 11:56:37 2007 > Killing background process MMON > Wed Dec 26 11:56:37 2007 > Shutting down instance (immediate) > License high water mark = 5 > Wed Dec 26 11:56:37 2007 > Stopping Job queue slave processes > Wed Dec 26 11:56:37 2007 > Job queue slave processes stopped > All dispatchers and shared servers shutdown > Wed Dec 26 11:56:44 2007 > ALTER DATABASE CLOSE NORMAL > Wed Dec 26 11:56:44 2007 > SMON: disabling tx recovery > SMON: disabling cache recovery > Wed Dec 26 11:56:44 2007 > SUCCESS: diskgroup ORAREDO was dismounted > Shutting down archive processes > Archiving is disabled > Wed Dec 26 11:56:49 2007 > ARCH shutting down > ARC1: Archival stopped > Wed Dec 26 11:56:54 2007 > ARCH shutting down > ARC0: Archival stopped > Wed Dec 26 11:56:55 2007 > Thread 1 closed at log sequence 15521 > Successful close of redo thread 1 > Wed Dec 26 11:56:59 2007 > Completed: ALTER DATABASE CLOSE NORMAL > Wed Dec 26 11:56:59 2007 > ALTER DATABASE DISMOUNT > Wed Dec 26 11:56:59 2007 > SUCCESS: diskgroup ORADATA was dismounted > SUCCESS: diskgroup ORABACKUP was dismounted > Wed Dec 26 11:56:59 2007 > Completed: ALTER DATABASE DISMOUNT > ARCH: Archival disabled due to shutdown: 1089 > Shutting down archive processes > Archiving is disabled > Archive process shutdown avoided: 0 active > ARCH: Archival disabled due to shutdown: 1089 > Shutting down archive processes > Archiving is disabled > Archive process shutdown avoided: 0 active > Wed Dec 26 11:57:05 2007 > freeing rdom 0 > Wed Dec 26 11:58:31 2007 > Starting ORACLE instance (normal) > LICENSE_MAX_SESSION = 0 > LICENSE_SESSIONS_WARNING = 0 > Interface type 1 Private 192.168.70.0 configured from OCR for use as a > cluster interconnect > Interface type 1 Public 10.45.5.0 configured from OCR for use as a > public interface > Picked latch-free SCN scheme 3 > Autotune of undo retention is turned on. > LICENSE_MAX_USERS = 0 > SYS auditing is disabled > ksdpec: called for event 13740 prior to event group initialization > Starting up ORACLE RDBMS Version: 10.2.0.2.0. > System parameters with non-default values: > processes = 500 > sessions = 555 > __shared_pool_size = 1711276032 > __large_pool_size = 0 > __java_pool_size = 16777216 > __streams_pool_size = 0 > trace_enabled = FALSE > nls_language = AMERICAN > nls_territory = UNITED KINGDOM > sga_target = 12884901888 > control_files = +ORADATA/edwprd/controlfile/current. > 256.620240201, +ORABACKUP/edwprd/controlfile/current.256.620240201 > db_block_size = 16384 > __db_cache_size = 11140071424 > db_writer_processes = 8 > compatible = 10.2.0.2.0 > log_archive_dest_1 = LOCATION=+ORABACKUP/EDWPRD/ > log_archive_format = ARC%S_%R.%T > db_file_multiblock_read_count= 16 > cluster_database = TRUE > cluster_database_instances= 2 > db_create_file_dest = +ORADATA > db_recovery_file_dest = +ORABACKUP > db_recovery_file_dest_size= 10737418240 > thread = 1 > instance_number = 1 > undo_management = AUTO > undo_tablespace = UNDOTBS1 > remote_login_passwordfile= EXCLUSIVE > db_domain = > dispatchers = (PROTOCOL=TCP) (SERVICE=EDWPRDXDB) > remote_listener = LISTENERS_EDWPRD > job_queue_processes = 10 > audit_file_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > \ADUMP > background_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > \BDUMP > user_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > \UDUMP > max_dump_file_size = 1024 > core_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > \CDUMP > db_name = EDWPRD > open_cursors = 300 > optimizer_mode = choose > pga_aggregate_target = 1707081728 > Cluster communication is configured to use the following interface(s) > for this instance > 192.168.70.11 > Wed Dec 26 11:58:37 2007 > cluster interconnect IPC version:Oracle 9i Winsock2 TCP/IP IPC > IPC Vendor 0 proto 0 > Version 0.0 > PMON started with pid=2, OS id=7116 > DIAG started with pid=6, OS id=6880 > PSP0 started with pid=10, OS id=6476 > LMON started with pid=14, OS id=6856 > Wed Dec 26 11:58:39 2007 > ORA-00130: invalid listener address '(ADDRESS=(PROTOCOL=TCP) > (HOST=BRNORA62-vip)(PORT=1521))' > > LMD0 started with pid=18, OS id=7016 > LMS0 started with pid=22, OS id=6728 > LMS1 started with pid=26, OS id=4036 > MMAN started with pid=30, OS id=6204 > DBW0 started with pid=34, OS id=448 > DBW1 started with pid=38, OS id=5492 > DBW2 started with pid=42, OS id=4436 > DBW3 started with pid=46, OS id=5960 > DBW4 started with pid=50, OS id=6324 > DBW5 started with pid=54, OS id=5700 > DBW6 started with pid=58, OS id=2828 > DBW7 started with pid=62, OS id=4612 > LGWR started with pid=66, OS id=3952 > CKPT started with pid=70, OS id=1572 > SMON started with pid=74, OS id=6288 > RECO started with pid=78, OS id=5860 > CJQ0 started with pid=82, OS id=6672 > MMON started with pid=86, OS id=5288 > MMNL started with pid=90, OS id=6976 > Wed Dec 26 11:58:39 2007 > starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES) > (PROTOCOL=TCP))'... > starting up 1 shared server(s) ... > Wed Dec 26 11:58:39 2007 > lmon registered with NM - instance id 1 (internal mem no 0) > Wed Dec 26 11:58:41 2007 > Reconfiguration started (old inc 0, new inc 2) > List of nodes: > 0 > Global Resource Directory frozen > * allocate domain 0, invalid = TRUE > Communication channels reestablished > Master broadcasted resource hash value bitmaps > Non-local Process blocks cleaned out > Wed Dec 26 11:58:41 2007 > LMS 1: 0 GCS shadows cancelled, 0 closed > Wed Dec 26 11:58:42 2007 > LMS 0: 0 GCS shadows cancelled, 0 closed > Set master node info > Submitted all remote-enqueue requests > Dwn-cvts replayed, VALBLKs dubious > All grantable enqueues granted > Post SMON to start 1st pass IR > Wed Dec 26 11:58:42 2007 > LMS 0: 0 GCS shadows traversed, 0 replayed > Wed Dec 26 11:58:42 2007 > LMS 1: 0 GCS shadows traversed, 0 replayed > Wed Dec 26 11:58:42 2007 > Submitted all GCS remote-cache requests > Post SMON to start 1st pass IR > Fix write in gcs resources > Reconfiguration complete > LCK0 started with pid=102, OS id=1876 > Wed Dec 26 11:58:43 2007 > ALTER DATABASE MOUNT > Wed Dec 26 11:58:43 2007 > This instance was first to mount > Wed Dec 26 11:58:43 2007 > Starting background process ASMB > ASMB started with pid=110, OS id=5428 > Starting background process RBAL > RBAL started with pid=114, OS id=4344 > Wed Dec 26 11:58:48 2007 > SUCCESS: diskgroup ORADATA was mounted > SUCCESS: diskgroup ORABACKUP was mounted > Wed Dec 26 11:58:52 2007 > Setting recovery target incarnation to 1 > Wed Dec 26 11:58:52 2007 > Successful mount of redo thread 1, with mount id 606843251 > Wed Dec 26 11:58:52 2007 > Database mounted in Shared Mode (CLUSTER_DATABASE=TRUE) > Completed: ALTER DATABASE MOUNT > Wed Dec 26 11:58:52 2007 > ALTER DATABASE OPEN > This instance was first to open > Picked broadcast on commit scheme to generate SCNs > Wed Dec 26 11:58:53 2007 > LGWR: STARTING ARCH PROCESSES > ARC0 started with pid=134, OS id=4724 > Wed Dec 26 11:58:53 2007 > ARC0: Archival started > ARC1 started with pid=138, OS id=4700 > Wed Dec 26 11:58:53 2007 > ARC1: Archival started > LGWR: STARTING ARCH PROCESSES COMPLETE > SUCCESS: diskgroup ORAREDO was mounted > Thread 1 opened at log sequence 15521 > Current log# 6 seq# 15521 mem# 0: +ORAREDO/edwprd/onlinelog/ > group_6.257.630862051 > Current log# 6 seq# 15521 mem# 1: +ORAREDO/edwprd/onlinelog/ > group_6.256.630862053 > Successful open of redo thread 1 > Wed Dec 26 11:58:53 2007 > MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set > Wed Dec 26 11:58:53 2007 > ARC1: STARTING ARCH PROCESSES > Wed Dec 26 11:58:53 2007 > ARC0: Becoming the 'no FAL' ARCH > ARC0: Becoming the 'no SRL' ARCH > Wed Dec 26 11:58:53 2007 > ARC2: Archival started > ARC2 started with pid=142, OS id=4256 > Wed Dec 26 11:58:53 2007 > SMON: enabling cache recovery > Wed Dec 26 11:58:53 2007 > ARC1: STARTING ARCH PROCESSES COMPLETE > ARC1: Becoming the heartbeat ARCH > Wed Dec 26 11:58:54 2007 > Successfully onlined Undo Tablespace 1. > Wed Dec 26 11:58:54 2007 > SMON: enabling tx recovery > Wed Dec 26 11:58:54 2007 > Database Characterset is WE8MSWIN1252 > Wed Dec 26 11:58:54 2007 > Instance recovery: looking for dead threads > Instance recovery: lock domain invalid but no dead threads > Wed Dec 26 11:58:54 2007 > replication_dependency_tracking turned off (no async multimaster > replication found) > Starting background process QMNC > QMNC started with pid=146, OS id=4912 > Wed Dec 26 11:58:58 2007 > Completed: ALTER DATABASE OPEN > Wed Dec 26 11:58:58 2007 > db_recovery_file_dest_size of 10240 MB is 0.21% used. This is a > user-specified limit on the amount of space that will be used by this > database for recovery-related files, and does not reflect the amount > of > space available in the underlying filesystem or ASM diskgroup. > Wed Dec 26 11:59:53 2007 > Shutting down archive processes > Wed Dec 26 11:59:58 2007 > ARCH shutting down > ARC2: Archival stopped The alert log won't usually help you troubleshoot connection issues; sqlnet tracing/logging and the listener.log might. I'd look at the listener.log and see if tracing the connection attempt through sqlnet can pinpoint the problem. David Fitzjarrell
From: raghu on 26 Dec 2007 10:59 On Dec 26, 7:31 pm, "fitzjarr...(a)cox.net" <fitzjarr...(a)cox.net> wrote: > On Dec 26, 5:38 am, raghu <raghu_v...(a)yahoo.com> wrote: > > > > > When I enter the credentials in SQL Plus, it hangs. This happens both > > in the server machine (Oracle 10.2.0) and the clients. But I am able > > to login using the command prompt in the server. Tnsping works > > correctly. Nothing is logged in the alert log for the login attempt. > > Any ideas? > > > Here is an excerpt of the alert log: > > > Starting background process EMN0 > > EMN0 started with pid=134, OS id=3648 > > Wed Dec 26 11:56:33 2007 > > Shutting down instance: further logons disabled > > Wed Dec 26 11:56:33 2007 > > Stopping background process QMNC > > Wed Dec 26 11:56:34 2007 > > Stopping background process CJQ0 > > Wed Dec 26 11:56:34 2007 > > Background process QMNC not dead after 150 seconds > > Wed Dec 26 11:56:34 2007 > > Killing background process QMNC > > Wed Dec 26 11:56:34 2007 > > Stopping background process MMNL > > Wed Dec 26 11:56:36 2007 > > Background process MMNL not dead after 10 seconds > > Wed Dec 26 11:56:36 2007 > > Killing background process MMNL > > Wed Dec 26 11:56:36 2007 > > Stopping background process MMON > > Wed Dec 26 11:56:37 2007 > > Background process MMON not dead after 30 seconds > > Wed Dec 26 11:56:37 2007 > > Killing background process MMON > > Wed Dec 26 11:56:37 2007 > > Shutting down instance (immediate) > > License high water mark = 5 > > Wed Dec 26 11:56:37 2007 > > Stopping Job queue slave processes > > Wed Dec 26 11:56:37 2007 > > Job queue slave processes stopped > > All dispatchers and shared servers shutdown > > Wed Dec 26 11:56:44 2007 > > ALTER DATABASE CLOSE NORMAL > > Wed Dec 26 11:56:44 2007 > > SMON: disabling tx recovery > > SMON: disabling cache recovery > > Wed Dec 26 11:56:44 2007 > > SUCCESS: diskgroup ORAREDO was dismounted > > Shutting down archive processes > > Archiving is disabled > > Wed Dec 26 11:56:49 2007 > > ARCH shutting down > > ARC1: Archival stopped > > Wed Dec 26 11:56:54 2007 > > ARCH shutting down > > ARC0: Archival stopped > > Wed Dec 26 11:56:55 2007 > > Thread 1 closed at log sequence 15521 > > Successful close of redo thread 1 > > Wed Dec 26 11:56:59 2007 > > Completed: ALTER DATABASE CLOSE NORMAL > > Wed Dec 26 11:56:59 2007 > > ALTER DATABASE DISMOUNT > > Wed Dec 26 11:56:59 2007 > > SUCCESS: diskgroup ORADATA was dismounted > > SUCCESS: diskgroup ORABACKUP was dismounted > > Wed Dec 26 11:56:59 2007 > > Completed: ALTER DATABASE DISMOUNT > > ARCH: Archival disabled due to shutdown: 1089 > > Shutting down archive processes > > Archiving is disabled > > Archive process shutdown avoided: 0 active > > ARCH: Archival disabled due to shutdown: 1089 > > Shutting down archive processes > > Archiving is disabled > > Archive process shutdown avoided: 0 active > > Wed Dec 26 11:57:05 2007 > > freeing rdom 0 > > Wed Dec 26 11:58:31 2007 > > Starting ORACLE instance (normal) > > LICENSE_MAX_SESSION = 0 > > LICENSE_SESSIONS_WARNING = 0 > > Interface type 1 Private x.168.70.0 configured from OCR for use as a > > cluster interconnect > > Interface type 1 Public x.45.5.0 configured from OCR for use as a > > public interface > > Picked latch-free SCN scheme 3 > > Autotune of undo retention is turned on. > > LICENSE_MAX_USERS = 0 > > SYS auditing is disabled > > ksdpec: called for event 13740 prior to event group initialization > > Starting up ORACLE RDBMS Version: 10.2.0.2.0. > > System parameters with non-default values: > > processes = 500 > > sessions = 555 > > __shared_pool_size = 1711276032 > > __large_pool_size = 0 > > __java_pool_size = 16777216 > > __streams_pool_size = 0 > > trace_enabled = FALSE > > nls_language = AMERICAN > > nls_territory = UNITED KINGDOM > > sga_target = 12884901888 > > control_files = +ORADATA/edwprd/controlfile/current. > > 256.620240201, +ORABACKUP/edwprd/controlfile/current.256.620240201 > > db_block_size = 16384 > > __db_cache_size = 11140071424 > > db_writer_processes = 8 > > compatible = 10.2.0.2.0 > > log_archive_dest_1 = LOCATION=+ORABACKUP/EDWPRD/ > > log_archive_format = ARC%S_%R.%T > > db_file_multiblock_read_count= 16 > > cluster_database = TRUE > > cluster_database_instances= 2 > > db_create_file_dest = +ORADATA > > db_recovery_file_dest = +ORABACKUP > > db_recovery_file_dest_size= 10737418240 > > thread = 1 > > instance_number = 1 > > undo_management = AUTO > > undo_tablespace = UNDOTBS1 > > remote_login_passwordfile= EXCLUSIVE > > db_domain = > > dispatchers = (PROTOCOL=TCP) (SERVICE=EDWPRDXDB) > > remote_listener = LISTENERS_EDWPRD > > job_queue_processes = 10 > > audit_file_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > > \ADUMP > > background_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > > \BDUMP > > user_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > > \UDUMP > > max_dump_file_size = 1024 > > core_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\EDWPRD > > \CDUMP > > db_name = EDWPRD > > open_cursors = 300 > > optimizer_mode = choose > > pga_aggregate_target = 1707081728 > > Cluster communication is configured to use the following interface(s) > > for this instance > > 192.168.70.11 > > Wed Dec 26 11:58:37 2007 > > cluster interconnect IPC version:Oracle 9i Winsock2 TCP/IP IPC > > IPC Vendor 0 proto 0 > > Version 0.0 > > PMON started with pid=2, OS id=7116 > > DIAG started with pid=6, OS id=6880 > > PSP0 started with pid=10, OS id=6476 > > LMON started with pid=14, OS id=6856 > > Wed Dec 26 11:58:39 2007 > > ORA-00130: invalid listener address '(ADDRESS=(PROTOCOL=TCP) > > (HOST=BRNORA62-vip)(PORT=1521))' > > > LMD0 started with pid=18, OS id=7016 > > LMS0 started with pid=22, OS id=6728 > > LMS1 started with pid=26, OS id=4036 > > MMAN started with pid=30, OS id=6204 > > DBW0 started with pid=34, OS id=448 > > DBW1 started with pid=38, OS id=5492 > > DBW2 started with pid=42, OS id=4436 > > DBW3 started with pid=46, OS id=5960 > > DBW4 started with pid=50, OS id=6324 > > DBW5 started with pid=54, OS id=5700 > > DBW6 started with pid=58, OS id=2828 > > DBW7 started with pid=62, OS id=4612 > > LGWR started with pid=66, OS id=3952 > > CKPT started with pid=70, OS id=1572 > > SMON started with pid=74, OS id=6288 > > RECO started with pid=78, OS id=5860 > > CJQ0 started with pid=82, OS id=6672 > > MMON started with pid=86, OS id=5288 > > MMNL started with pid=90, OS id=6976 > > Wed Dec 26 11:58:39 2007 > > starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES) > > (PROTOCOL=TCP))'... > > starting up 1 shared server(s) ... > > Wed Dec 26 11:58:39 2007 > > lmon registered with NM - instance id 1 (internal mem no 0) > > Wed Dec 26 11:58:41 2007 > > Reconfiguration started (old inc 0, new inc 2) > > List of nodes: > > 0 > > Global Resource Directory frozen > > * allocate domain 0, invalid = TRUE > > Communication channels reestablished > > Master broadcasted resource hash value bitmaps > > Non-local Process blocks cleaned out > > Wed Dec 26 11:58:41 2007 > > LMS 1: 0 GCS shadows cancelled, 0 closed > > Wed Dec 26 11:58:42 2007 > > LMS 0: 0 GCS shadows cancelled, 0 closed > > Set master node info > > Submitted all remote-enqueue requests > > Dwn-cvts replayed, VALBLKs dubious > > All grantable enqueues granted > > Post SMON to start 1st pass IR > > Wed Dec 26 11:58:42 2007 > > LMS 0: 0 GCS shadows traversed, 0 replayed > > Wed Dec 26 11:58:42 2007 > > LMS 1: 0 GCS shadows traversed, 0 replayed > > Wed Dec 26 11:58:42 2007 > > Submitted all GCS remote-cache requests > > Post SMON to start 1st pass IR > > Fix write in gcs resources > > Reconfiguration complete > > LCK0 started with pid=102, OS id=1876 > > Wed Dec 26 11:58:43 2007 > > ALTER DATABASE MOUNT > > Wed Dec 26 11:58:43 2007 > > This instance was first to mount > > Wed Dec 26 11:58:43 2007 > > Starting background process ASMB > > ASMB started with pid=110, OS id=5428 > > Starting background process RBAL > > RBAL started with pid=114, OS id=4344 > > Wed Dec 26 11:58:48 2007 > > SUCCESS: diskgroup ORADATA was mounted > > SUCCESS: diskgroup ORABACKUP was mounted > > Wed Dec 26 11:58:52 2007 > > Setting recovery target incarnation to 1 > > Wed Dec 26 11:58:52 2007 > > Successful mount of redo thread 1, with mount id 606843251 > > Wed Dec 26 11:58:52 2007 > > Database mounted in Shared Mode (CLUSTER_DATABASE=TRUE) > > Completed: ALTER DATABASE MOUNT > > Wed Dec 26 11:58:52 2007 > > ALTER DATABASE OPEN > > This instance was first to open > > Picked broadcast on commit scheme to generate SCNs > > Wed Dec 26 11:58:53 2007 > > LGWR: STARTING ARCH PROCESSES > > ARC0 started with pid=134, OS id=4724 > > Wed Dec 26 11:58:53 2007 > > ARC0: Archival started > > ARC1 started with pid=138, OS id=4700 > > Wed Dec 26 11:58:53 2007 > > ARC1: Archival started > > LGWR: STARTING ARCH PROCESSES COMPLETE > > SUCCESS: diskgroup ORAREDO was mounted > > Thread 1 opened at log sequence 15521 > > Current log# 6 seq# 15521 mem# 0: +ORAREDO/edwprd/onlinelog/ > > group_6.257.630862051 > > Current log# 6 seq# 15521 mem# 1: +ORAREDO/edwprd/onlinelog/ > > group_6.256.630862053 > > Successful open of redo thread 1 > > Wed Dec 26 11:58:53 2007 > > MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set > > Wed Dec 26 11:58:53 2007 > > ARC1: STARTING ARCH PROCESSES > > Wed Dec 26 11:58:53 2007 > > ARC0: Becoming the 'no FAL' ARCH > > ARC0: Becoming the 'no SRL' ARCH > > Wed Dec 26 11:58:53 2007 > > ARC2: Archival started > > ARC2 started with pid=142, OS id=4256 > > Wed Dec 26 11:58:53 2007 > > SMON: enabling cache recovery > > Wed Dec 26 11:58:53 2007 > > ARC1: STARTING ARCH PROCESSES COMPLETE > > ARC1: Becoming the heartbeat ARCH > > Wed Dec 26 11:58:54 2007 > > Successfully onlined Undo Tablespace 1. > > Wed Dec 26 11:58:54 2007 > > SMON: enabling tx recovery > > Wed Dec 26 11:58:54 2007 > > Database Characterset is WE8MSWIN1252 > > Wed Dec 26 11:58:54 2007 > > Instance recovery: looking > > ... > > read more »- Hide quoted text - > > - Show quoted text - Here are the listener and sqlnet trace files. I cannot seem to make much sense out of it. Sqlnet tracing is not happening inspite of turning on the tracing. sqlnet trace -------------------- Fatal NI connect error 12560, connecting to: (LOCAL=NO) VERSION INFORMATION: TNS for 64-bit Windows: Version 10.2.0.2.0 - Production Oracle Bequeath NT Protocol Adapter for 64-bit Windows: Version 10.2.0.2.0 - Production Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.2.0 - Production Time: 26-DEC-2007 16:43:48 Tracing not turned on. Tns error struct: ns main err code: 12560 TNS-12560: TNS:protocol adapter error ns secondary err code: 0 nt main err code: 0 nt secondary err code: 0 nt OS err code: 0 ----------------------------------------------------------------------------------------------------- listener trace ----------------- nsglrespond: entry nsdo: cid=7, opcode=67, *bl=82, *what=1, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x100400c, mvd=0 nsdo: gtn=207, gtc=207, ptn=10, ptc=2011 nsdo: 82 bytes to NS buffer nsdo: nsctxrnk=0 nsglrespond: exit nsgldissolve: entry nstimarmed: no timer allocated nsdo: cid=7, opcode=66, *bl=0, *what=0, uflgs=0x0, cflgs=0x2 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x1004008, mvd=0 nsevunreg: cid=7, sgt=0, rdm=2 nsevunreg: 5 registered connection(s) nsdo: cid=7, opcode=67, *bl=0, *what=1, uflgs=0x0, cflgs=0x1 nsdo: nsctx: state=8, flg=0x1004008, mvd=0 nsdo: gtn=207, gtc=207, ptn=92, ptc=2011 nsdofls: DATA flags: 0x40 nsdofls: sending NSPTDA packet nspsend: plen=92, type=6 ntnwr: failed to write 92 bytes sntn2err: entry sntn2err: error: handle=480, op=6, nt[0]=524, nt[1]=997 sntn2err: exit nspsend: 92 bytes to transport nsdo: nsctxrnk=0 nsclose: closing transport ntndisc: entry sntndisc: Closed pipe afer FlushFileBuffers480 ntndisc: exit nsclose: global context check-out (from slot 7) complete nsmfr: 2176 bytes at 0x3682a00 nsmfr: 1112 bytes at 0x22961c0 nsgldissolve: Deallocating cxd 0x22db310. nsgldissolve: exit nsevwait: 5 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 0 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevwait: 0 posted event(s) nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 318, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 318, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22daf20 stage 0: NT events set: READ nsevfnt: cxd: 0x22daf20 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 318 bytes from leftover nsprecv: tlen=318, plen=318, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 308 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:0 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 316 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 318 bytes from leftover nsprecv: tlen=318, plen=318, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 308 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:0 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 350, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 350, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22daf20 stage 0: NT events set: READ nsevfnt: cxd: 0x22daf20 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 350 bytes from leftover nsprecv: tlen=350, plen=350, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 340 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: instance flags - req:256 cur:272 nsglgrDoRegister: inst loads: ld1:1 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 316 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 350 bytes from leftover nsprecv: tlen=350, plen=350, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 340 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: instance flags - req:256 cur:272 nsglgrDoRegister: inst loads: ld1:1 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 318, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22dab30 stage 0: NT events set: READ nsevfnt: cxd: 0x22dab30 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 4 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=4, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=214, gtc=214, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 318 bytes from leftover nsprecv: tlen=318, plen=318, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 308 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 308 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:1 mld2:49 nsglgrDoRegister: exit nsdo: cid=4, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 308 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 318, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22dab30 stage 0: NT events set: READ nsevfnt: cxd: 0x22dab30 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 4 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=4, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 318 bytes from leftover nsprecv: tlen=318, plen=318, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 308 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 308 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:1 mld2:49 nsglgrDoRegister: exit nsdo: cid=4, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 308 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 10, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22daf20 stage 0: NT events set: READ nsevfnt: cxd: 0x22daf20 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 10 bytes from leftover nsprecv: tlen=10, plen=10, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x40 nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x1 nsdo: nsctx: state=6, flg=0x600c, mvd=0 nsdo: gtn=10, gtc=10, ptn=10, ptc=8155 nsdo: nsctxrnk=0 nsglhfre: entry nsglhrem: entry nsglhrem: exit nsglhfre: exit nsglhrem: entry nsglhrem: exit nsglhfre: entry nsglhrem: entry nstimarmed: no timer allocated nttctl: entry nttctl: entry nsdo: cid=5, opcode=98, *bl=0, *what=0, uflgs=0x40, cflgs=0x2 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=3, flg=0x4008, mvd=0 nsevunreg: cid=5, sgt=0, rdm=2 nsevunreg: 4 registered connection(s) nsdo: nsctxrnk=0 snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 316 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit nsclose: closing transport nttdisc: entry nttdisc: Closed socket 316 nttdisc: exit nsclose: global context check-out (from slot 5) complete nsmfr: 2176 bytes at 0x36818e0 nsmfr: 1112 bytes at 0x2295d30 nsglhfre: Deallocating cxd 0x22daf20. nsglhfre: exit nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 4 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 10, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 10 bytes from leftover nsprecv: tlen=10, plen=10, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x40 nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x1 nsdo: nsctx: state=6, flg=0x600c, mvd=0 nsdo: gtn=10, gtc=10, ptn=10, ptc=8155 nsdo: nsctxrnk=0 nsglhfre: entry nsglhrem: entry nsglhrem: exit nsglhfre: exit nsglhfre: entry nsglhrem: entry nsglhrem: exit nsc2addr: (ADDRESS=(PROTOCOL=tcp)(HOST=brnora61.bestcorp.net) (PORT=2697)) nttbnd2addr: entry snlinGetAddrInfo: entry snlinGetAddrInfo: Invalid IP address string brnora61.bestcorp.net snlinFreeAddrInfo: entry snlinFreeAddrInfo: exit snlinGetAddrInfo: exit nttbnd2addr: looking up IP addr for host: brnora61.bestcorp.net snlinGetAddrInfo: entry snlinGetAddrInfo: exit snlinFreeAddrInfo: entry snlinFreeAddrInfo: exit nttbnd2addr: exit nsglhfre: exit nsglhrem: entry nsglhrem: exit nsglhfre: entry nsglhrem: entry nstimarmed: no timer allocated nttctl: entry nttctl: entry nsdo: cid=6, opcode=98, *bl=0, *what=0, uflgs=0x40, cflgs=0x2 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=3, flg=0x4008, mvd=0 nsevunreg: cid=6, sgt=0, rdm=2 nsevunreg: 3 registered connection(s) nsdo: nsctxrnk=0 snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 0, err = 995 ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=530, ntresnt[1]=995, ntresnt[2]=0 ntt2err: exit snttcallback: exit nsclose: closing transport nttdisc: entry nttdisc: Closed socket 328 nttdisc: exit nsclose: global context check-out (from slot 6) complete nsmfr: 2176 bytes at 0x3682170 nsmfr: 1112 bytes at 0x22958a0 nsglhfre: Deallocating cxd 0x22db1c0. nsglhfre: exit nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 3 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 4)... nsevwait: 0 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevwait: 0 posted event(s) nsevwait: 3 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 4)... snttcallback: entry snttcallback: op = 5, bytes = 318, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22dab30 stage 0: NT events set: READ nsevfnt: cxd: 0x22dab30 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 4 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=4, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 318 bytes from leftover nsprecv: tlen=318, plen=318, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 308 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 308 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:1 mld2:49 nsglgrDoRegister: exit nsdo: cid=4, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=318, gtc=318, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 308 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 3 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 4)... nsevwait: 1 newly-posted event(s) nsevfnt: cxd: 0x22da740 stage 0: NT events set: CONNECTION REQUEST nsevfnt: cxd: 0x22da740 stage 0: NS events set: INCOMING CALL nsevwait: event is 0x1, on 1 nsevwait: 1 posted event(s) nsglhe: entry nsmal: 1112 bytes at 0x22958a0 nsmal: 2176 bytes at 0x36818e0 nsopen: opening transport... nttcon: entry nttcon: toc = 3 nttcnp: entry nttcnp: getting sockname nttcnp: getting peername nttcnp: exit nttcnr: entry nttcnr: waiting to accept a connection. nttcnr: getting sockname snlinGetNameInfo: entry snlinGetNameInfo: Using numeric form of host's address x.x.5.20 snlinGetNameInfo: exit nttcnr: connected on ipaddr x.x.5.20 nttvlser: entry snlinGetNameInfo: entry snlinGetNameInfo: Using numeric form of host's address x.x.5.20 snlinGetNameInfo: exit nttvlser: valid node check on incoming node x.x.5.20 nttvlser: Accepted Entry: x.x.5.20 nttcnr: exit nttcon: set TCP_NODELAY on 328 nttcon: exit nsopen: transport is open nsnainit: answer nsnasvnainfo: NA disabled for this connection nainit: entry nagblini: entry nau_gin: entry nau_gparams: entry nam_gbp: Reading parameter "sqlnet.authentication_required" from parameter file nam_gbp: Parameter not found nau_gparams: Using default value "FALSE" nau_gslf: entry nam_gic: entry nam_gic: Counting # of items in "sqlnet.authentication_services" parameter nam_gic: Parameter not found nam_gic: Found 0 items nam_gic: exit nau_gslf: Using default value "all available adapters" nauss_set_state: entry nauss_set_state: exit nau_gslf: exit nau_gparams: exit nau_gin: exit nagblini: exit na_saveprot: entry na_saveprot: exit nacomin: entry nas_init: entry nas_init: exit nau_ini: entry naugcp_get_connect_parameters: entry nauss_set_state: entry nauss_set_state: exit naugcp_get_connect_parameters: exit nau_gettab: entry nau_gettab: exit nau_sini: entry nau_sini: exit nau_ini: exit naeeinit: entry nam_gbp: Reading parameter "SQLNET.FIPS_140" from parameter file nam_gbp: Parameter not found nam_gnsp: Reading parameter "SQLNET.ENCRYPTION_SERVER" from parameter file nam_gnsp: Parameter not found naequad: Using default value "ACCEPTED" nam_gic: entry nam_gic: Counting # of items in "SQLNET.ENCRYPTION_TYPES_SERVER" parameter nam_gic: Parameter not found nam_gic: exit naesno: Using default value "all available algorithms" naeshow: entry naeshow: exit naeeinit: exit naecinit: entry nam_gnsp: Reading parameter "SQLNET.CRYPTO_CHECKSUM_SERVER" from parameter file nam_gnsp: Parameter not found naequad: Using default value "ACCEPTED" nam_gic: entry nam_gic: Counting # of items in "SQLNET.CRYPTO_CHECKSUM_TYPES_SERVER" parameter nam_gic: Parameter not found nam_gic: exit naesno: Using default value "all available algorithms" naeshow: entry naeshow: exit naecinit: exit nadisc: entry nacomtm: entry nacompd: entry nacompd: exit nacompd: entry nacompd: exit nacomtm: exit nas_dis: entry nas_dis: exit nau_dis: entry nau_dis: exit naeetrm: entry naeetrm: exit naectrm: entry naectrm: exit nagbltrm: entry nau_gtm: entry nau_gtm: exit nagbltrm: exit nadisc: exit nainit: exit nsnainit: NS Connection version: 313 nsnainit: inf->nsinfflg[0]: 0xd inf->nsinfflg[1]: 0xd 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 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 nsopen: global context check-in (to slot 5) complete nsopen: lcl[0]=0xf4ffefff, lcl[1]=0x12003, gbl[0]=0x7abf, gbl[1]=0x2001, tdu=32767, sdu=8192 nsdo: cid=5, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x2 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=7, flg=0x4000, mvd=0 nsdo: nsctxrnk=0 nsanswer: deferring connect attempt; at stage 5 nsevreg: begin registration process for 5 nsevreg: sgt=0, evn=4, evt[2]=0x0 nsevreg: begin notification process for 5 nsrah: setting transport read mode (2) nttctl: entry nttctl: Clearing non-blocking mode nttctl: entry nttctl: Setting connection into async mode nsevreg: rdm=2, sgt=0, evt[0]=0x20, [1]=0x20, [2]=0x0, nrg=0 nsevreg: registering for 0x20 nttmrd: entry nttrd: entry snttcallback: entry snttcallback: exit nttrd: socket 328 had bytes read=104 nttrd: exit nsglhe: exit nsevwait: 4 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 5)... nsevwait: 1 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevdansw: at STAGE 5 nsdo: cid=5, opcode=68, *bl=2040, *what=8, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=14, flg=0x4004, mvd=0 nsdo: gtn=10, gtc=10, ptn=10, ptc=8155 nscon: doing connect handshake... nscon: recving a packet nsprecv: 104 bytes from leftover nsprecv: tlen=104, plen=104, type=1 nscon: got NSPTCN packet nsconneg: vsn=313, lov=300, opt=0x0, sdu=8192, tdu=32767, ntc=0xc60e nsconneg: vsn=313, gbl=0x1, sdu=8192, tdu=32767 nscon: got 46 bytes connect data nsdo: nsctxrnk=0 nsevdansw: exit nsevwait: event is 0x20, on 5 nsevfnt: cxd: 0x22da740 stage 0: NT events set: CONNECTION REQUEST nsevfnt: cxd: 0x22da740 stage 0: NS events set: INCOMING CALL nsevwait: event is 0x1, on 1 nsevwait: 2 posted event(s) nsglhe: entry nsglfc: command = service_register_NSGR nsglauthorized: entry nsglrespond: entry nsdo: cid=5, opcode=67, *bl=20, *what=9, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=2, flg=0x4004, mvd=0 nsdo: gtn=104, gtc=104, ptn=10, ptc=8155 nscon: sending NSPTAC packet nspsend: plen=52, type=2 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=52 nttwr: exit nspsend: 52 bytes to transport nscon: connect handshake is complete nscon: nsctxinf[0]=0x6d, [1]=0x9 nsconbrok: asking transport to enable NTOBROKEN nttctl: entry nsdo: nsctxrnk=0 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsglrespond: exit nsglhe: exit nsglhe: entry nsmal: 1112 bytes at 0x2295d30 nsmal: 2176 bytes at 0x3682170 nsopen: opening transport... nttcon: entry nttcon: toc = 3 nttcnp: entry nttcnp: getting sockname nttcnp: getting peername nttcnp: exit nttcnr: entry nttcnr: waiting to accept a connection. nttcnr: getting sockname snlinGetNameInfo: entry snlinGetNameInfo: Using numeric form of host's address x.x.5.10 snlinGetNameInfo: exit nttcnr: connected on ipaddr x.x.5.10 nttvlser: entry snlinGetNameInfo: entry snlinGetNameInfo: Using numeric form of host's address x.x.5.10 snlinGetNameInfo: exit nttvlser: valid node check on incoming node x.x.5.10 nttvlser: Accepted Entry: x.x.5.10 nttcnr: exit nttcon: set TCP_NODELAY on 320 nttcon: exit nsopen: transport is open nsnainit: answer nsnasvnainfo: NA disabled for this connection nainit: entry nagblini: entry nau_gin: entry nau_gparams: entry nam_gbp: Reading parameter "sqlnet.authentication_required" from parameter file nam_gbp: Parameter not found nau_gparams: Using default value "FALSE" nau_gslf: entry nam_gic: entry nam_gic: Counting # of items in "sqlnet.authentication_services" parameter nam_gic: Parameter not found nam_gic: Found 0 items nam_gic: exit nau_gslf: Using default value "all available adapters" nauss_set_state: entry nauss_set_state: exit nau_gslf: exit nau_gparams: exit nau_gin: exit nagblini: exit na_saveprot: entry na_saveprot: exit nacomin: entry nas_init: entry nas_init: exit nau_ini: entry naugcp_get_connect_parameters: entry nauss_set_state: entry nauss_set_state: exit naugcp_get_connect_parameters: exit nau_gettab: entry nau_gettab: exit nau_sini: entry nau_sini: exit nau_ini: exit naeeinit: entry nam_gbp: Reading parameter "SQLNET.FIPS_140" from parameter file nam_gbp: Parameter not found nam_gnsp: Reading parameter "SQLNET.ENCRYPTION_SERVER" from parameter file nam_gnsp: Parameter not found naequad: Using default value "ACCEPTED" nam_gic: entry nam_gic: Counting # of items in "SQLNET.ENCRYPTION_TYPES_SERVER" parameter nam_gic: Parameter not found nam_gic: exit naesno: Using default value "all available algorithms" naeshow: entry naeshow: exit naeeinit: exit naecinit: entry nam_gnsp: Reading parameter "SQLNET.CRYPTO_CHECKSUM_SERVER" from parameter file nam_gnsp: Parameter not found naequad: Using default value "ACCEPTED" nam_gic: entry nam_gic: Counting # of items in "SQLNET.CRYPTO_CHECKSUM_TYPES_SERVER" parameter nam_gic: Parameter not found nam_gic: exit naesno: Using default value "all available algorithms" naeshow: entry naeshow: exit naecinit: exit nadisc: entry nacomtm: entry nacompd: entry nacompd: exit nacompd: entry nacompd: exit nacomtm: exit nas_dis: entry nas_dis: exit nau_dis: entry nau_dis: exit naeetrm: entry naeetrm: exit naectrm: entry naectrm: exit nagbltrm: entry nau_gtm: entry nau_gtm: exit nagbltrm: exit nadisc: exit nainit: exit nsnainit: NS Connection version: 313 nsnainit: inf->nsinfflg[0]: 0xd inf->nsinfflg[1]: 0xd 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 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 nsopen: global context check-in (to slot 6) complete nsopen: lcl[0]=0xf4ffefff, lcl[1]=0x12003, gbl[0]=0x7abf, gbl[1]=0x2001, tdu=32767, sdu=8192 nsdo: cid=6, opcode=65, *bl=0, *what=0, uflgs=0x0, cflgs=0x2 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=7, flg=0x4000, mvd=0 nsdo: nsctxrnk=0 nsanswer: deferring connect attempt; at stage 5 nsevreg: begin registration process for 6 nsevreg: sgt=0, evn=4, evt[2]=0x0 nsevreg: begin notification process for 6 nsrah: setting transport read mode (2) nttctl: entry nttctl: Clearing non-blocking mode nttctl: entry nttctl: Setting connection into async mode nsevreg: rdm=2, sgt=0, evt[0]=0x20, [1]=0x20, [2]=0x0, nrg=0 nsevreg: registering for 0x20 nttmrd: entry nttrd: entry snttcallback: entry snttcallback: op = 5, bytes = 910, err = 0 snttcallback: exit snttcallback: entry snttcallback: exit nttrd: socket 320 had bytes read=104 nttrd: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 2 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 0 newly-posted event(s) nsevwait: 3 pre-posted event(s) nsevdansw: at STAGE 5 nsdo: cid=6, opcode=68, *bl=2040, *what=8, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=14, flg=0x4004, mvd=0 nsdo: gtn=10, gtc=10, ptn=10, ptc=8155 nscon: doing connect handshake... nscon: recving a packet nsprecv: 104 bytes from leftover nsprecv: tlen=104, plen=104, type=1 nscon: got NSPTCN packet nsconneg: vsn=313, lov=300, opt=0x0, sdu=8192, tdu=32767, ntc=0xc60e nsconneg: vsn=313, gbl=0x1, sdu=8192, tdu=32767 nscon: got 46 bytes connect data nsdo: nsctxrnk=0 nsevdansw: exit nsevwait: event is 0x20, on 6 nsevfnt: cxd: 0x22db1c0 stage 7: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 7: NS events set: OUTGOING CALL COMPLETE nsevdansw: at STAGE 7 nsevdansw: no NA services in use nsevunreg: cid=5, sgt=0, rdm=2 nsrah: re-setting transport read mode nttctl: entry nttctl: Clearing async mode nsevunreg: 4 registered connection(s) nsevdansw: exit nsevwait: event is 0x20, on 5 nsevwait: 2 posted event(s) nsglhe: entry nsglfc: command = service_register_NSGR nsglauthorized: entry nsglrespond: entry nsdo: cid=6, opcode=67, *bl=20, *what=9, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=2, flg=0x4004, mvd=0 nsdo: gtn=104, gtc=104, ptn=10, ptc=8155 nscon: sending NSPTAC packet nspsend: plen=52, type=2 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=52 nttwr: exit nspsend: 52 bytes to transport nscon: connect handshake is complete nscon: nsctxinf[0]=0x6d, [1]=0x9 nsconbrok: asking transport to enable NTOBROKEN nttctl: entry nsdo: nsctxrnk=0 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsglrespond: exit nsglhe: exit nsglhe: entry nsevunreg: cid=5, sgt=0, rdm=0 nsevreg: begin registration process for 5 nsevregPrePost: NSVDATA already available nsevreg: sgt=0, evn=4, evt[2]=0x2 nsevreg: begin notification process for 5 nsrah: setting transport read mode (2) nttctl: entry nttctl: Setting connection into async mode nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsevreg: rdm=2, sgt=0, evt[0]=0x12, [1]=0x10, [2]=0x2, nrg=0 nsevreg: registering for 0x12 nsglauthorized: entry nsglecmd: entry nsglhcrt: entry nsglhcrt: exit nsglhins: entry nsglhins: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 1 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevwait: event is 0x12, on 5 nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: WRITE nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: READY FOR SEND nsevwait: event is 0x12, on 5 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsevmute: cid=5 nsglroinit: entry nsglroinit: exit nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=104, gtc=104, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 910 bytes from leftover nsprecv: tlen=910, plen=910, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 900 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: Creating new instance: "edwprd1". nttctl: entry nscontrol: cmd=7, lcl=0x0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:0 mld2:555 nsglgrDoRegister: instance flags - req:256 cur:272 nsglgrDoRegister: Creating new service: "EDWPRD_XPT". nsglgrDoRegister: service:EDWPRD_XPT flag:2 goodness:0 delta:0 nsglgrDoRegister: Creating new service: "EDWPRD". nsglgrDoRegister: service:EDWPRD flag:2 goodness:0 delta:0 nsglgrDoRegister: Creating new handler: "DEDICATED". nsglhcrt: entry nsglhcrt: exit nsglbgetRSPidx: entry nladini: entry nladini: exit nladget: entry nladget: exit nsglbn2i: entry nsglbn2i: exit nladtrm: entry nladtrm: exit nsglbgetRSPidx: returning ecode=0 nsglbgetRSPidx: exit nsglhins: entry nsglhins: exit nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=336, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=910, gtc=910, ptn=10, ptc=8155 nsdo: 336 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=346, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: op = 5, bytes = 974, err = 0 snttcallback: exit snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=346 nttwr: exit nspsend: 346 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 0 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevfnt: cxd: 0x22dadd0 stage 7: NT events set: READ nsevfnt: cxd: 0x22dadd0 stage 7: NS events set: OUTGOING CALL COMPLETE nsevdansw: at STAGE 7 nsevdansw: no NA services in use nsevunreg: cid=6, sgt=0, rdm=2 nsrah: re-setting transport read mode nttctl: entry nttctl: Clearing async mode nsevunreg: 4 registered connection(s) nsevdansw: exit nsevwait: event is 0x20, on 6 nsevwait: 1 posted event(s) nsglhe: entry nsevunreg: cid=6, sgt=0, rdm=0 nsevreg: begin registration process for 6 nsevregPrePost: NSVDATA already available nsevreg: sgt=0, evn=4, evt[2]=0x2 nsevreg: begin notification process for 6 nsrah: setting transport read mode (2) nttctl: entry nttctl: Setting connection into async mode nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsevreg: rdm=2, sgt=0, evt[0]=0x12, [1]=0x10, [2]=0x2, nrg=0 nsevreg: registering for 0x12 nsglauthorized: entry nsglecmd: entry nsglhcrt: entry nsglhcrt: exit nsglhins: entry nsglhins: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 1 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 1 newly-posted event(s) nsevwait: 1 pre-posted event(s) nsevwait: event is 0x12, on 6 nsevfnt: cxd: 0x22dadd0 stage 0: NT events set: WRITE nsevfnt: cxd: 0x22dadd0 stage 0: NS events set: READY FOR SEND nsevwait: event is 0x12, on 6 nsevwait: 1 posted event(s) nsglhe: entry nsglrohe: entry nsevmute: cid=6 nsglroinit: entry nsglroinit: exit nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=104, gtc=104, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 974 bytes from leftover nsprecv: tlen=974, plen=974, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 964 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:0 mld2:555 nsglgrDoRegister: instance flags - req:256 cur:272 nsglgrDoRegister: service:EDWPRD_XPT flag:2 goodness:0 delta:0 nsglgrDoRegister: service:EDWPRD flag:2 goodness:0 delta:0 nsglgrDoRegister: Creating new handler: "DEDICATED". nsglhcrt: entry nsglhcrt: exit nsglbgetRSPidx: entry nladini: entry nladini: exit nladget: entry nladget: exit nsglbn2i: entry nsglbn2i: exit nladtrm: entry nladtrm: exit nsglbgetRSPidx: returning ecode=0 nsglbgetRSPidx: exit nsglhins: entry nsglhins: exit nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=336, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=974, gtc=974, ptn=10, ptc=8155 nsdo: 336 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=346, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=346 nttwr: exit nspsend: 346 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 350, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 350, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22dadd0 stage 0: NT events set: READ nsevfnt: cxd: 0x22dadd0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=910, gtc=910, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 350 bytes from leftover nsprecv: tlen=350, plen=350, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 340 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: instance flags - req:0 cur:16 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:4 mld2:555 nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=974, gtc=974, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 350 bytes from leftover nsprecv: tlen=350, plen=350, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 340 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: instance flags - req:0 cur:16 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:4 mld2:555 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=168, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsdo: 168 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=178, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=178 nttwr: exit nspsend: 178 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 310, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 310, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22dadd0 stage 0: NT events set: READ nsevfnt: cxd: 0x22dadd0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 310 bytes from leftover nsprecv: tlen=310, plen=310, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 300 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: service:EDWPRD what:4 value:100 nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=160, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=310, gtc=310, ptn=10, ptc=8155 nsdo: 160 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=170, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=170 nttwr: exit nspsend: 170 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=350, gtc=350, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 310 bytes from leftover nsprecv: tlen=310, plen=310, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 300 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: service:EDWPRD what:4 value:100 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=160, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=310, gtc=310, ptn=10, ptc=8155 nsdo: 160 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=170, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=170 nttwr: exit nspsend: 170 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 574, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 574, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22dadd0 stage 0: NT events set: READ nsevfnt: cxd: 0x22dadd0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=310, gtc=310, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 574 bytes from leftover nsprecv: tlen=574, plen=574, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 564 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: Creating new service: "EDWPRDXDB". nsglgrDoRegister: service:EDWPRDXDB flag:3 goodness:0 delta:100 nsglgrDoRegister: Creating new handler: "D000". nsglhcrt: entry nsglhcrt: exit nsglbgetRSPidx: entry nladini: entry nladini: exit nladget: entry nladget: exit nsglbn2i: entry nsglbn2i: exit nladtrm: entry nladtrm: exit nsglbgetRSPidx: returning ecode=0 nsglbgetRSPidx: exit nsmal: 1112 bytes at 0x22961c0 nsmal: 2176 bytes at 0x3682a00 nsopen: opening transport... nttcon: entry nttcon: toc = 6 nttcnp: entry nttcnp: exit snlinGetAddrInfo: entry snlinGetAddrInfo: exit snlinFreeAddrInfo: entry snlinFreeAddrInfo: exit nttcon: exit nsopen: transport is open nsoptions: lcl[0]=0x0, lcl[1]=0x0, gbl[0]=0x0, gbl[1]=0x0, cha=0x0 nsoptions: lcl[0]=0xf4ffefff, lcl[1]=0x0, gbl[0]=0x7abf, gbl[1]=0x0 nsopen: lcl[0]=0xf4ffefff, lcl[1]=0x0, gbl[0]=0x7abf, gbl[1]=0x0, tdu=32767, sdu=2048 nsmfr: 2176 bytes at 0x3682a00 nsmfr: 1112 bytes at 0x22961c0 nsglgrDoRegister: will do TPSWITCH for this hdlr nsglhins: entry nsglhins: exit nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=164, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=574, gtc=574, ptn=10, ptc=8155 nsdo: 164 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=174, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=174 nttwr: exit nspsend: 174 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=310, gtc=310, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 574 bytes from leftover nsprecv: tlen=574, plen=574, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 564 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: service:EDWPRDXDB flag:3 goodness:0 delta:100 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=164, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=574, gtc=574, ptn=10, ptc=8155 nsdo: 164 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=174, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=174 nttwr: exit nspsend: 174 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... snttcallback: entry snttcallback: op = 5, bytes = 514, err = 0 snttcallback: exit snttcallback: entry snttcallback: op = 5, bytes = 514, err = 0 snttcallback: exit nsevwait: 0 newly-posted event(s) nsevfnt: cxd: 0x22db1c0 stage 0: NT events set: READ nsevfnt: cxd: 0x22db1c0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 5 nsevfnt: cxd: 0x22dadd0 stage 0: NT events set: READ nsevfnt: cxd: 0x22dadd0 stage 0: NS events set: INCOMING SEND nsevwait: event is 0x2, on 6 nsevwait: 2 posted event(s) nsglhe: entry nsglrohe: entry nsdo: cid=5, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=574, gtc=574, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 514 bytes from leftover nsprecv: tlen=514, plen=514, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 328 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 504 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: service:EDWPRDXDB what:4 value:1 nsglgrDoRegister: service:EDWPRD what:4 value:1 nsglgrDoRegister: exit nsdo: cid=5, opcode=67, *bl=300, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=514, gtc=514, ptn=10, ptc=8155 nsdo: 300 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=310, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 328 had bytes written=310 nttwr: exit nspsend: 310 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsglhe: entry nsglrohe: entry nsdo: cid=6, opcode=68, *bl=8196, *what=0, uflgs=0x0, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=574, gtc=574, ptn=10, ptc=8155 nsrdr: recving a packet nsprecv: 514 bytes from leftover nsprecv: tlen=514, plen=514, type=6 nttmrd: entry nttrd: entry ntt2err: entry ntt2err: soc 320 error - operation=5, ntresnt[0]=524, ntresnt[1]=997, ntresnt[2]=0 ntt2err: exit nttrd: exit nsrdr: got NSPTDA packet nsrdr: NSPTDA flags: 0x0 nsdo: *what=1, *bl=8196 nsdo: 504 bytes from NS buffer nsdo: nsctxrnk=0 nsglgrDoRegister: inst loads: ld1:10 mld1:800 ld2:5 mld2:555 nsglgrDoRegister: service:EDWPRDXDB what:4 value:1 nsglgrDoRegister: service:EDWPRD what:4 value:1 nsglgrDoRegister: exit nsdo: cid=6, opcode=67, *bl=300, *what=1, uflgs=0x2, cflgs=0x3 nsdo: rank=64, nsctxrnk=0 nsdo: nsctx: state=8, flg=0x400c, mvd=0 nsdo: gtn=514, gtc=514, ptn=10, ptc=8155 nsdo: 300 bytes to NS buffer nsdofls: DATA flags: 0x0 nsdofls: sending NSPTDA packet nspsend: plen=310, type=6 nttmwr: entry nttwr: entry snttcallback: entry snttcallback: exit nttwr: socket 320 had bytes written=310 nttwr: exit nspsend: 310 bytes to transport nsdoacts: flushing transport nttctl: entry nsdo: nsctxrnk=0 nsglroHandleError: exit nsglrohe: exit nsglhe: exit nsevwait: 5 registered connection(s) nsevwait: 0 pre-posted event(s) nsevwait: waiting for transport event (1 thru 6)... nsevwait: 1 newly-posted event(s) nsevfnt: cxd: 0x22da740 stage
From: Frank van Bortel on 27 Dec 2007 14:02 raghu wrote: > When I enter the credentials in SQL Plus, it hangs. This happens both > in the server machine (Oracle 10.2.0) and the clients. But I am able > to login using the command prompt in the server. Tnsping works > correctly. Nothing is logged in the alert log for the login attempt. > Any ideas? tnsping only checks for the listener - not whether it can connect. > Starting up ORACLE RDBMS Version: 10.2.0.2.0. > System parameters with non-default values: > sga_target = 12884901888 That would be 12GB?!? On Windows? Given the fact you state you can connect from the command line on the machine (how?!?), it should be working - just frowning eyebrows here... > db_block_size = 16384 > __db_cache_size = 11140071424 > pga_aggregate_target = 1707081728 ditto > Wed Dec 26 11:58:39 2007 > ORA-00130: invalid listener address '(ADDRESS=(PROTOCOL=TCP) > (HOST=BRNORA62-vip)(PORT=1521))' > Does that say anything? vip is Virtual IP, or what? -- Regards, Frank van Bortel Top-posting is one way to shut me up...
|
Pages: 1 Prev: What is the difference between this two SQL? Next: High JS kgl get object wait |