Hi all,
today I cloning a baan installation in order to create a machine for development.
The new machine is, as the production machine, HP-UX 11.23 with oracle 10.0.2; Baan LN is FP3 with porting set 8.4a.01.

The problem happens when importing the 000 company from a dumo created on the production server. I import the data using this command line:

env ORACLE_HOME= ORACLE_SID= TWO_TASK= BSE_CLASSPATH= CLASSPATH= ORACLE_BASE= SLM_HOME= BAANHOME= \
BSE=/appl/baanlntest PATH=/appl/baanlntest/bin:$PATH time bdbpost6.2 -E import.log -f -m -n -r5000 -I dump000.pre -p b61au -c 000 \*

The machine start working until the dump file is completely analyzed, but then I see this errors in logfiles:

baanln01> grep rror import-last.log
ttadv140000 5 1141598 Adding indexes ...Can not create index 9999 (error 522)
ttadv141000 1 Can't lock table (error 522)
ttadv150000 2 Can't lock table (error 522)
ttadv151000 1 Can't lock table (error 522)
ttadv160000 6 Can't lock table (error 522)
ttadv161000 1 Can't lock table (error 522)
ttadv163000 3 Can't lock table (error 522)
[]


This is rather strange, since index 9999 doesn't exists.
After that error, all remaining tables gave the same error since the the oracle driver disconnected from oracle server.

oracle8.log
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: ******* S T A R T of Error message *******
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Log message called from /view/port.8.4a.01/vobs/tt/servers/ORACLE_2/ora_native.c: #2022 keyword: Oracle Error
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Pid 21265 Uid 125 Euid 125 Gid 125 Egid 125 Pset bsp@baanln01:21264
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: user_type S language 6 user_name bsp tty 0 locale ISO88591/NULL
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Errno 0 bdb_errno 0
2008-03-13[16:17:06(UTC-01:00)]:E:bsp:
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: dbs_errno = 522, Error 522 occurred:
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Error ORA-3114 occurred during rollback.
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: ORA-03114: not connected to ORACLE
2008-03-13[16:17:06(UTC-01:00)]:E:bsp:
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Error BDB-522 returned.
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Flushed at /view/port.8.4a.01/vobs/tt/servers/ORACLE_2/ora_db.c : #97.
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: ******* E N D of Error message *******

baanln02> oerr ora 03114
03114, 00000, "not connected to ORACLE"
// *Cause:
// *Action:

bdbpost.log
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: ******* S T A R T of Error message *******
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Log message called from /view/port.8.4a.01/vobs/tt/bdb_tools/bdb_bdbpost.c: #805 keyword: db_lock
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Pid 21264 Uid 125 Euid 125 Gid 125 Egid 125 Pset bsp@baanln01:21264
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: user_type S language 6 user_name bsp tty 0 locale ISO88591/NULL
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Errno 0 bdb_errno 522 (Database driver lost connection to the database)
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: Log_mesg: Can't lock table (error 522)
2008-03-13[16:17:06(UTC-01:00)]:E:bsp: ******* E N D of Error message *******

So, it seems that the oracle driver drop the connection because of an unspecified error.

When trying to import only table ttadv140 I get the same error, so probably the error is about this table.
I found that on oracle machine I have a lot of trace file, like this:
baanln02> more test_ora_15717.trc
/oratest/app/oracle/admin/test/udump/test_ora_15717.trc
Oracle Database 10g Release 10.2.0.3.0 - 64bit Production
ORACLE_HOME = /oratest/app/oracle/product/10.2.0
System name: HP-UX
Node name: baanln02
Release: B.11.31
Version: U
Machine: ia64
Instance name: test
Redo thread mounted by this instance: 0 <none>
Oracle process number: 13
Unix process pid: 15717, image: oracle@baanln02 (TNS V1-V3)

*** SERVICE NAME:() 2008-03-13 16:06:45.501
*** SESSION ID:(544.1) 2008-03-13 16:06:45.501
kccsga_update_ckpt: num_1 = 8, num_2 = 0, num_3 = 0, lbn_2 = 0, lbn_3 = 0

Any ideas?

Thanks,
Giuseppe

What do your ora_storage*/ora_driver, db_resource and tabledef6.X files look like?


Dave

Here they are:

[CODE]baanln01> cat defaults/db_resource
dbsinit:01
ora_max_array_fetch:5
ora_max_array_insert:5
nls_lang:american_america.al32utf8
nls_sort:infor_generic_m
oracle_home:/oratest/app/oracle/product/10.2.0
ora_temporary_tablespace:TMPSPACE
ora_default_tablespace:DATSPACE
use_shm_info:0
nls_comp:ansi
first_rows_hint:1
baanln01> cat ora/ora_driver_param
*:*:T:group:014:0:
*:*:I:group:014:0:
baanln01> cat ora/ora_storage_param
*:*:T:TABLESPACE DATSPACE PCTFREE 5 INITRANS 3
*:*:I:TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3
baanln01> [|CODE]

when running bdbpost6.2 with DBSLOG=0400 I see that table is correctly created:
<24708> 2008-03-13[18:10:08]: Logging started mode 0400
---- LOG SQL INFO [0000400] ----

SQL> ora_parse( "select upper(value) from v$nls_parameters where parameter = 'NLS_CHARACTERSET'" )
SQL> ora_parse( "ALTER SESSION SET NLS_SORT = infor_generic_m" )
SQL> ora_parse( "ALTER SESSION SET QUERY_REWRITE_ENABLED = TRUE" )
SQL> ora_parse( "ALTER SESSION SET NLS_COMP = ansi" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
<24773> 2008-03-13[18:12:44]: Logging started mode 0400
---- LOG SQL INFO [0000400] ----

SQL> ora_parse( "select upper(value) from v$nls_parameters where parameter = 'NLS_CHARACTERSET'" )
SQL> ora_parse( "ALTER SESSION SET NLS_SORT = infor_generic_m" )
SQL> ora_parse( "ALTER SESSION SET QUERY_REWRITE_ENABLED = TRUE" )
SQL> ora_parse( "ALTER SESSION SET NLS_COMP = ansi" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "DROP TABLE baan.tttadv140000" )
SQL> ora_parse( "CREATE TABLE baan.tttadv140000 (t$clan NCHAR(1) not null,t$cpac NCHAR(2) not null,t$clab NCHAR(17) not null,t$lhgt NUMBER not null,t$leng NUMBER not null,t$vers NCHAR(4) not null,t$rele NCHAR(2) not null,t$cust NCHAR(4) not null,t$desc NCHAR(70) not null,t$expi NUMBER not null,t$seak NCHAR(10) not null,t$zb_brnc NCHAR(6) not null,t$zc_cont NUMBER not null,t$Refcntd NUMBER not null,t$Refcntu NUMBER not null) TABLESPACE DATSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "GRANT select, insert, update, delete ON baan.tttadv140000 TO R_baan" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> INSERT INTO baan.tttadv140000 (t$clan,t$cpac,t$clab,t$lhgt,t$leng,t$vers,t$rele,t$cust,t$desc,t$expi,t$seak,t$zb_brnc,t$zc_cont,t$Refcntd,t$Refcntu) VALUES (:1,:2,:3,:4,:5,:6,:7,:8,:9,:10,:11,:12,:13,:14,:15)
SQL> ora_parse( "INSERT INTO baan.tttadv140000 (t$clan,t$cpac,t$clab,t$lhgt,t$leng,t$vers,t$rele,t$cust,t$desc,t$expi,t$seak,t$zb_brnc,t$zc_cont,t$Refcntd,t$Refcntu) VALUES (:1,:2,:3,:4,:5,:6,:7,:8,:9,:10,:11,:12,:13,:14,:15)" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
...

SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "LOCK TABLE baan.tttadv140000 IN EXCLUSIVE MODE" )
SQL> ora_parse( "CREATE UNIQUE INDEX tttadv140000$idx1 ON baan.tttadv140000 (NLSSORT(t$clan,'NLS_SORT=infor_generic_m'),NLSSORT(t$cpac,'NLS_SORT=infor_generic_m'),NLSSORT(t$clab,'NLS_SORT=infor_generic_m'),t$lhgt,t$leng,NLSSORT(t$vers,'NLS_SORT=infor_generic_m'),NLSSORT(t$rele,'NLS_SORT=infor_generic_m'),NLSSORT(t$cust,'NLS_SORT=infor_generic_m'),t$zc_cont,NLSSORT(t$zb_brnc,'NLS_SORT=infor_generic_m')) TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "CREATE UNIQUE INDEX tttadv140000$idx2 ON baan.tttadv140000 (NLSSORT(t$clan,'NLS_SORT=infor_generic_m'),NLSSORT(t$cpac,'NLS_SORT=infor_generic_m'),NLSSORT(t$vers,'NLS_SORT=infor_generic_m'),NLSSORT(t$rele,'NLS_SORT=infor_generic_m'),NLSSORT(t$cust,'NLS_SORT=infor_generic_m'),NLSSORT(t$clab,'NLS_SORT=infor_generic_m'),t$lhgt,t$leng,t$zc_cont,NLSSORT(t$zb_brnc,'NLS_SORT=infor_generic_m')) TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "CREATE UNIQUE INDEX tttadv140000$idx3 ON baan.tttadv140000 (NLSSORT(t$clan,'NLS_SORT=infor_generic_m'),NLSSORT(t$cpac,'NLS_SORT=infor_generic_m'),NLSSORT(t$seak,'NLS_SORT=infor_generic_m'),NLSSORT(t$clab,'NLS_SORT=infor_generic_m'),t$lhgt,t$leng,NLSSORT(t$vers,'NLS_SORT=infor_generic_m'),NLSSORT(t$rele,'NLS_SORT=infor_generic_m'),NLSSORT(t$cust,'NLS_SORT=infor_generic_m'),t$zc_cont,NLSSORT(t$zb_brnc,'NLS_SORT=infor_generic_m')) TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "CREATE UNIQUE INDEX tttadv140000$idx4 ON baan.tttadv140000 (NLSSORT(t$clan,'NLS_SORT=infor_generic_m'),NLSSORT(t$cpac,'NLS_SORT=infor_generic_m'),t$zc_cont,NLSSORT(t$clab,'NLS_SORT=infor_generic_m'),t$lhgt,t$leng,NLSSORT(t$vers,'NLS_SORT=infor_generic_m'),NLSSORT(t$rele,'NLS_SORT=infor_generic_m'),NLSSORT(t$cust,'NLS_SORT=infor_generic_m')) TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "CREATE UNIQUE INDEX tttadv140000$idx5 ON baan.tttadv140000 (NLSSORT(t$cpac,'NLS_SORT=infor_generic_m'),NLSSORT(t$clab,'NLS_SORT=infor_generic_m'),NLSSORT(t$vers,'NLS_SORT=infor_generic_m'),NLSSORT(t$rele,'NLS_SORT=infor_generic_m'),NLSSORT(t$cust,'NLS_SORT=infor_generic_m'),t$lhgt,t$leng,t$zc_cont,NLSSORT(t$zb_brnc,'NLS_SORT=infor_generic_m'),NLSSORT(t$clan,'NLS_SORT=infor_generic_m')) TABLESPACE IDXSPACE PCTFREE 5 INITRANS 3" )
SQL> ora_parse( "BEGIN DBMS_STATS.GATHER_TABLE_STATS(ownname=>'baan',tabname=>'tttadv140000',cascade=>true); END;" )

Try with dbslog=1570 that should show where the error happens

Dave

Using dbslog as suggested created 2Gb of log and filled my file system.
I have to reduce the verbosity level since I cannot enlarge any file system on this machine.

can't think of the flag that would show the error but would also not spam to that logfile.

Dave

So, it seems I found it. I managed to get the single record that actually stop the import process.

SQL> ora_parse( "INSERT INTO baan.tttadv140000 (t$clan,t$cpac,t$clab,t$lhgt,t$leng,t$vers,t$rele,t$cust,t$desc,t$expi,t$seak,t$zb_brnc,t$zc_cont,t$Refcntd,t$Refcntu) VALUES (:1,:2,:3,:4,:5,:6,:7,:8,:9,:10,:11,:12,:13,:14,:15)" )
SQL> ora_parse( 40307068 )
ora_parse( 40307068 ) done
ora_bind 40307068 : nr 1, addr 40311100, size 2, ext_type 96, mode 0, indp 403110c0 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 2, addr 40311108, size 4, ext_type 96, mode 0, indp 403110c2 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 3, addr 40311110, size 34, ext_type 96, mode 0, indp 403110c4 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 4, addr 40311138, size 2, ext_type 3, mode 0, indp 403110c6 lenp 00000000
ora_bind 40307068 : nr 5, addr 40311140, size 2, ext_type 3, mode 0, indp 403110c8 lenp 00000000
ora_bind 40307068 : nr 6, addr 40311148, size 8, ext_type 96, mode 0, indp 403110ca lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 7, addr 40311150, size 4, ext_type 96, mode 0, indp 403110cc lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 8, addr 40311158, size 8, ext_type 96, mode 0, indp 403110ce lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 9, addr 40311160, size 140, ext_type 96, mode 0, indp 403110d0 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 10, addr 403111f0, size 2, ext_type 3, mode 0, indp 403110d2 lenp 00000000
ora_bind 40307068 : nr 11, addr 403111f8, size 20, ext_type 96, mode 0, indp 403110d4 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 12, addr 40311210, size 12, ext_type 96, mode 0, indp 403110d6 lenp 00000000
ora_bind 40307068 : OCI_ATTR_CHARSET_ID 1000, OCI_ATTR_CHARSET_FORM 2
ora_bind 40307068 : nr 13, addr 40311220, size 2, ext_type 3, mode 0, indp 403110d8 lenp 00000000
ora_bind 40307068 : nr 14, addr 40311228, size 4, ext_type 3, mode 0, indp 403110da lenp 00000000
ora_bind 40307068 : nr 15, addr 40311230, size 4, ext_type 3, mode 0, indp 403110dc lenp 00000000
oracle_prepare_cursor done.
oracle_open_cursor : id 40311008
oracle_exec_cursor 40311008
------ QPS Input Row -------
Bind :1 : string : [0x4031035c] 'j'
Bind :2 : string : [0x4031035d] 'tl'
Bind :3 : string : [0x4031035f] 'tlvsc300.cmod '
Bind :4 : char : [0x40310370] <1>
Bind :5 : char : [0x40310371] <10>
Bind :6 : string : [0x40310372] '7.6 '
Bind :7 : string : [0x40310376] 'a '
Bind :8 : string : [0x40310378] ' '
Bind :9 : Tstring : [0x4031037c] '›¼á⛼ḛ¼á囼áü›¼áë '
Bind :10 : char : [0x40310494] <2>
Bind :11 : Tstring : [0x40310495] '›¼á⛼ḛ¼á囼áü›¼áë '
Bind :12 : string : [0x403104bd] ' '
Bind :13 : char : [0x403104c3] <1>
Bind :14 : long : [0x403104c4] <0>
Bind :15 : long : [0x403104c8] <0>
----- DBMS Update Input ----
Bind nr 1 : clan : string : '\0j' [utf-16]
Bind nr 2 : cpac : string : '\0t\0l' [utf-16]
Bind nr 3 : clab : string : '\0t\0l\0v\0s\0c\03\00\00\0.\0c\0m\0o\0d\0 \0 \0 \0 ' [utf-16]
Bind nr 4 : lhgt : char : <1>
Bind nr 5 : leng : char : <10>
Bind nr 6 : vers : string : '\07\0.\06\0 ' [utf-16]
Bind nr 7 : rele : string : '\0a\0 ' [utf-16]
Bind nr 8 : cust : string : '\0 \0 \0 \0 ' [utf-16]
Bind nr 9 : desc : Tstring : '0â0¸0å0ü0ë\0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 \0 ' [utf-16]
Bind nr 10 : expi : char : <2>
Bind nr 11 : seak : Tstring : '0â0¸0å0ü0ë\0 \0 \0 \0 \0 ' [utf-16]
Bind nr 12 : zb_brnc : string : '\0 \0 \0 \0 \0 \0 ' [utf-16]
Bind nr 13 : zc_cont : char : <1>
Bind nr 14 : Refcntd : long : <0>
Bind nr 15 : Refcntu : long : <0>
SQL> ora_multi_execute( 40307068 ) do 1, timeout 30, prefetch 1 --> oci_ret -1
ora_error 3113 dbs_errno 522.
ora_multi_execute( 40307068 ) done - rows 0
oracle_break_cursor 40311008
SQL> ora_cancel_cursor( 40307068 ) - not done (no SELECT)
Cursor 40307068 put in break list [1].
oracle_exec_cursor 40311008
Taking cursor from break list.
Cursor 40307068 removed from break list [0].
No rows in buffer.
Msg_type 5 received.
local_server type 5

<23286> bsp [1]--------- D_ABORT on session ------------

oracle_exec_session id 1 : 3.
ora_error 3114 dbs_errno 522.
FATAL /view/port.8.4a.01/vobs/tt/servers/ORACLE_2/ora_native.c:#2022 :

Error ORA-3114 occurred during rollback.
ORA-03114: not connected to ORACLE

Error BDB-522 returned.
Dbs_on_transaction_rollback s_id 1 done.
Error 522 .
In detach_cursor cursor_id 6.
Msg_type 4 received.
local_server type 4
detect_pending_dd
detect_pending_dd returns 0
In dbs_attach_cursor
Search for 'ttadv140000'
Searching for DD 'ttadv140000'
Found 'ttadv140000' phys_compnr 000, log_compnr 000.
Cursor attached : cursor_id 6.
dbms_exec_table : cursor 40304c78

<23286> bsp [1]--------- T_STATS 0 on ttadv140000 ------------

oracle_analyze_table
Reading storage parameters from 'lib/ora/ora_storage_param'
ora_logon : name = 'baan', pwd = 40180f88, ora_session 401817a8
using service name : 'test-x'
oci_link_server ( dbase = 'test-x' ) : # logon = 2 : OK
ora_logon : OCISvcCtx 402470b0 Allocated
ora_error 24327 dbs_errno 25327.
oci_unlink_server ( # logon = 2 ) : OK
ora_logon error: ora_session 401817a8 err 25327
FATAL /view/port.8.4a.01/vobs/tt/servers/ORACLE_2/ora_native.c:#2022 :

Error ORA-24327 occurred during logon.
ORA-24327: need explicit attach before authenticating a user

Error BDB-25327 returned.
Logon failed; errno 25327
Error -1 .
Msg_type 3 received.
local_server type 3
In close_session
oracle_close_cursor id 40311008
Cursor 40307068 put in free list [1].
Before detach_cursor: 6
In detach_cursor cursor_id 6.
Before detach_cursor: 5
In detach_cursor cursor_id 5.
Before detach_cursor: 4
In detach_cursor cursor_id 4.
Before detach_cursor: 3
In detach_cursor cursor_id 3.
Before detach_cursor: 2
In detach_cursor cursor_id 2.
Before close_cursor 2. (status: 010)
Before close_cursor 3. (status: 010)
Before close_cursor 4. (status: 010)
Before close_cursor 5. (status: 010)
Before close_cursor 6. (status: 012)
oracle_close_session sid 1: logoff
ora_close_cursor 40307068
oci_unlink_server ( # logon = 1 ) : detach connection : OK
ora_logoff: OCISvcCtx 40209dd0 Freed
Msg_type 1 received.
local_server type 1
In detach server
oracle_detach_server
oci_unlink_server ( # logon = 0 ) : OK
ora_logoff: OCISvcCtx 00000000 Freed
oracle_detach_server done.
In detach server

I noticed this before but it didn't apply, but now it does..
I don't think that nls_lang:american_america.al32utf8 is a valid character set for Baan.

you might want to check the install guide - if you're doing a Unicode install there's a specific character set you need to use.

Dave