ODBC connection forces engine to hang
Posted in 2004
Hi Everyone,
HELP HELP HELP ...
Installed RHL 8.0, CSDK 2.81 UC3, IDS 9.40 UC3, 4js (3.50.1a) on a
DELL Xeon server. dbimport, dbaccess etc. looks ok. Ran onchecks. No
problem at all.
On a Window XP client (MDAC 2.8), installed CSDK 2.81 TC3. Setup
setnet32 with correct server info. Setup a user DSN (Also tried with
system DSN).
Using DBPING,
TCPIP Ping, NATIVE Ping, COM+ Ping and ODBC Ping work ok.
ODBC Ping returns following messages:
Database version: iclit09b.dll
Driver Name: iclit09b.dll
Driver Version: 3.82.0000 2.81.TC3
ODBC Version: 03.51
Driver ODBC Version: 03.52.0000
In last window, messages as:
09:20:12 : SQLAllocEnv Successful
09:20:12 : SQLAllocConnect Successful
09:20:13 : SQLConnect Successful
09:20:13 : SQLGetInfo for SQL_DATA_SOURCE_NAME Successful
09:20:13 : SQLGetInfo for SQL_USER_NAME Successful
09:20:13 : SQLGetInfo for SQL_DATABASE_NAME Successful
09:20:13 : SQLGetInfo for SQL_DBMS_VER Successful
09:20:13 : SQLGetInfo for SQL_DRIVER_NAME Successful
09:20:13 : SQLGetInfo for SQL_DRIVER_VER Successful
09:20:13 : SQLGetInfo for SQL_DRIVER_ODBC_VER Successful
09:20:13 : SQLGetInfo for SQL_ODBC_VER Successful
09:20:13 : SQLGetInfo for SQL_DBMS_NAME Successful
09:20:13 : SQLDisconnect was Successful
09:20:13 : SQLFreeConnect Successful\\n
09:20:13 : SQLFreeEnv Successful
09:20:13 : ODBC connection closed.
Up to this stage engine runs ok. I can bounce the engine without any
prob and
I can launch 4js program on client PC. Pl. note that 4js program uses
port and service to run.
Problem start when I use any 3rd party tool such as MS Excel, WinSQL
using ODBC DSN. As soon that application connections to database,
database server looses its mind and hangs forever.
I can't even bounce the engine and had to reboot the box.
Here are some stats from onstat while engine is in hang state:
1. onstat -
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:43:24 -- 1368004 Kbytes
2. onstat -g spi
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:42:40 -- 1368004 Kbytes
Spin locks with waits:
Num Waits Num Loops Avg Loop/Wait Name
6 7783032 1297172.00 mtcb vproc_sync_lock
433 145431 335.87 mtcb sleeping_lock
27 45926 1700.96 mtcb mutex_list_lock
2 2 1.00 mtcb notify_lock
137 24369 177.88 vproc vp_lock, id = 1
185 19797 107.01 vproc vp_lock, id = 3
62 7360 118.71 vproc vp_lock, id = 4
1 1 1.00 mutex lock, name = vpc aio
1075001136 2032221048 1.89 mutex lock, name = ^LW^R@^Z
Changing data structure forced command termination.
3. onstat -g con
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:39:23 -- 1368004 Kbytes
Conditions with waiters:
cid addr name waiter waittime
487 794184a8 arrived 29 866
4. onstat -g ntd
Client Type Calls Accepted Rejected Read Write
sqlexec yes 1 0 6 6
srvinfx yes 0 0 0 0
onspace yes 0 0 0 0
onlog yes 0 0 0 0
onparam yes 0 0 0 0
oncheck yes 0 0 0 0
onload yes 0 0 0 0
onunload yes 0 0 0 0
onmonitor yes 0 0 0 0
dr_accept yes 0 0 0 0
cdraccept no 0 0 0 0
ontape yes 0 0 0 0
srvstat yes 0 0 0 0
asfecho yes 0 0 0 0
listener yes 0 0 1 0
crsamexec yes 0 0 0 0
safe yes 0 0 0 0
onutil yes 0 0 0 0
Totals 1 0 7 6
5. onstat -g ntm
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:33:27 -- 1368004 Kbytes
global network information:
#netscb connects read write q-free q-limits q-exceed
alloc/max
10/ 10 1 7 6 1/ 1 204/ 10 0/ 0
2/ 2
Network mailbox information:
box netscb thread name max received in box max in box full
signal
5 79103e58 soctcppoll 10 6 0 2 0
yes
6 7941ba98 soctcppoll 10 1 0 1 0
yes
7 79454780 soctcplst 10 0 0 0 0
no
6. onstat -g ntt
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:32:20 -- 1368004 Kbytes
global network information:
#netscb connects read write q-free q-limits q-exceed
alloc/max
10/ 10 1 7 6 1/ 1 204/ 10 0/ 0
2/ 2
Individual thread network information (times):
netscb thread name sid open read write address
79c68018 sqlexec 11 09:46:32 09:52:56 09:46:33
794634f0 sm_discon 13 09:28:07
79452a28 sm_listen 10 09:28:07
79454c88 sm_discon 9 09:28:07
7946d780 sm_listen 7 09:28:07
79454780 soctcplst 6 09:28:07 09:46:32
abc.xyz.com|2525|soctcp
79440780 sm_poll 5 09:28:07
7942ca98 sm_poll 4 09:28:07
7941ba98 soctcppoll 3 09:28:07
79103e58 soctcppoll 2 09:46:33
7. onstat -g seg
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:30:56 -- 1368004 Kbytes
Segment Summary:
id key addr size ovhd class blkused
blkfree
327684 1381713921 44000000 882241536 241748 R* 215368 23
360453 1381713922 7895f000 512000000 16272 V* 4947 120053
393222 1381713923 971a7000 3297280 744 M 776 29
425991 1381713924 974cc000 3297280 744 M 774 31
Total: - - 1400836096 - - 221865 120136
(* segment locked in memory)
8. onstat -g glo
IBM Informix Dynamic Server Version 9.40.UC3 -- On-Line -- Up
00:29:03 -- 1368004 Kbytes
MT global info:
sessions threads vps lngspins
1 167 31 6
sched calls thread switches yield 0 yield n yield
forever
total: 9120085 339947 8945256 4635 715
per sec: 12 0 12 0 0
Virtual processor summary:
class vps usercpu syscpu total
cpu 3 7.30 2.94 10.24
aio 22 7.49 1.35 8.84
lio 1