HI,
This is the log file.
I use Sedna 3.1.175 on Windows Vista
INFO 29/07/2009 13:23:20 (GOV pid=6804) [gov.cpp:main:231]: SEDNA version
is 3.1.175
INFO 29/07/2009 13:23:20 (GOV pid=6804)
[gov_functions.cpp:log_out_system_information:79]: System: Windows 6.0.6002
(SP2.0) x86
INFO 29/07/2009 13:23:20 (GOV pid=6804)
[gmm.cpp:create_global_memory_mapping:129]: Layer address space start addr =
0x1aa30000
INFO 29/07/2009 13:23:20 (GOV pid=6804)
[gmm.cpp:create_global_memory_mapping:130]: Layer address space boundary =
0x5aa30000
INFO 29/07/2009 13:23:20 (GOV pid=6804)
[gmm.cpp:create_global_memory_mapping:131]: Persistent heap start addr =
0x14630000
LOG 29/07/2009 13:23:20 (GOV pid=6804) [gov.cpp:main:240]: Process ping
server is ready
LOG 29/07/2009 13:23:20 (GOV pid=6804) [listener.cpp:client_listener:67]:
GOVERNOR is ready
LOG 29/07/2009 13:25:15 (SM Test pid=6680) [sm.cpp:main:547]: Event log is
ready
LOG 29/07/2009 13:25:15 (SM Test pid=6680) [sm.cpp:main:560]: Ping client
has been started
LOG 29/07/2009 13:25:15 (SM Test pid=6680) [sm.cpp:main:566]: VMM region
values determined
SYS 29/07/2009 13:25:15 (SM Test pid=6680)
[uprocess.c:uGetEnvironmentVariable:67]: GetEnvironmentVariable (code =
203): Impossibile trovare l'opzione di ambiente specificata.
SYS 29/07/2009 13:25:15 (SM Test pid=6680)
[uprocess.c:uGetEnvironmentVariable:67]: GetEnvironmentVariable (code =
203): Impossibile trovare l'opzione di ambiente specificata.
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:830]: Event log in
recovery procedure is ready
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:834]:
init_transaction_ids_table done
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:838]:
init_checkpoint_sems done
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:844]: Logical log is
started
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:864]:
start_chekpoint_thread done
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:886]: Buffer manager is
started
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:898]: Checkpoints are
disabled
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:902]:
lm_table.init_lock_table done
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:925]: Wu is initialized
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:936]: Checkpoints are
enabled
SYS 29/07/2009 13:25:15 (SM Test pid=6680) [uhdd.c:uIsFileExist:367]:
GetFileAttributes (code = 2): Impossibile trovare il file specificato.
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[trmgr.cpp:checkpoint_thread:202]: Checkpoint procedure is finished
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:946]: Shutdown
checkpoint thread done
LOG 29/07/2009 13:25:15 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:949]: Wu is released
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:953]: Buffer manager is
stopped
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:957]: Logical log is
stopped
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:961]:
release_checkpoint_sems done
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:964]:
release_transaction_ids_table done
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:968]:
lm_table.release_lock_table done
LOG 29/07/2009 13:25:16 (SM Test pid=6680)
[sm.cpp:recover_database_by_physical_and_logical_log:970]: Recovery
procedure has been finished successfully
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:547]: Event log is
ready
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:560]: Ping client
has been started
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:566]: VMM region
values determined
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:657]:
init_transaction_ids_table done
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:661]:
init_checkpoint_sems done
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:665]:
start_chekpoint_thread done
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:672]: Logical log
has been started
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:679]: Temporary
files have been deleted
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:685]:
init_lock_table done
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:689]: Buffer
manager has been started
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:721]: Wu is
initialized
LOG 29/07/2009 13:25:16 (SM Test pid=8100) [sm.cpp:main:747]: SM has been
started
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=-1)
[tr.cpp:TRmain:252]: Session is ready
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$collections")/collections/collection[matches(@name,
"^[a-zA-Z0-9-_\s]+$")]/string-value(@name)
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/document/string(@name)
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test0"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("test0")
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test0"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- DROP DOCUMENT "test0"
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test2"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("test2")
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test2"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- DROP DOCUMENT "test2"
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test3"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("test3")
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test3"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- DROP DOCUMENT "test3"
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test0"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- LOAD STDIN "test0"
LOG 29/07/2009 13:27:44 (TRN Test pid=6496 sid=48 trid=-1)
[tr.cpp:TRmain:252]: Session is ready
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=48)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test3"]
LOG 29/07/2009 13:27:44 (TRN Test pid=6496 sid=48 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test1"]
LOG 29/07/2009 13:27:44 (TRN Test pid=7456 sid=49 trid=48)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- LOAD STDIN "test3"
LOG 29/07/2009 13:27:44 (TRN Test pid=6496 sid=48 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- LOAD STDIN "test1"
ERROR 29/07/2009 13:27:44 (SM Test pid=8100)
[lock_table.cpp:lock_table::visit:684]: (SE4705) Deadlock is detected
ERROR 29/07/2009 13:27:44 (TRN Test pid=6496 sid=48 trid=49)
[locks.cpp:LocalLockMgr::obtain_lock:246]: (SE4703) The transaction is a
victim of deadlock resolution procedure
LOG 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=-1)
[tr.cpp:TRmain:252]: Session is ready
LOG 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=48)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test2"]
LOG 29/07/2009 13:27:45 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- document("$documents")/documents/docume...@name="test4"]
LOG 29/07/2009 13:27:45 (TRN Test pid=7456 sid=49 trid=49)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- LOAD STDIN "test4"
LOG 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=48)
[tr_functions.cpp:on_user_statement_begin:80]: User query:
--- LOAD STDIN "test2"
ERROR 29/07/2009 13:27:45 (SM Test pid=8100)
[lock_table.cpp:lock_table::visit:684]: (SE4705) Deadlock is detected
ERROR 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=48)
[locks.cpp:LocalLockMgr::obtain_lock:246]: (SE4703) The transaction is a
victim of deadlock resolution procedure
SYS 29/07/2009 13:27:45 (TRN Test pid=6496 sid=48 trid=-1)
[usocket.c:urecv:293]: recv (code = 10054): Connessione in corso interrotta
forzatamente dall'host remoto.
ERROR 29/07/2009 13:27:45 (TRN Test pid=6496 sid=48 trid=-1)
[socket_client.cpp:socket_client::read_msg:142]: (SE3007) Failed to recieve
a message. Details: Connessione in corso interrotta forzatamente dall'host
remoto.
---
SYS 29/07/2009 13:27:45 (TRN Test pid=7456 sid=49 trid=-1)
[usocket.c:urecv:293]: recv (code = 10054): Connessione in corso interrotta
forzatamente dall'host remoto.
SYS 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=-1)
[usocket.c:urecv:293]: recv (code = 10054): Connessione in corso interrotta
forzatamente dall'host remoto.
INFO 29/07/2009 13:27:45 (SM Test pid=8100)
[bm_core.cpp:bm_log_out_io_statistics:525]: IO block reads:0, writes:0
ERROR 29/07/2009 13:27:45 (TRN Test pid=7456 sid=49 trid=-1)
[socket_client.cpp:socket_client::read_msg:142]: (SE3007) Failed to recieve
a message. Details: Connessione in corso interrotta forzatamente dall'host
remoto.
---
ERROR 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=-1)
[socket_client.cpp:socket_client::read_msg:142]: (SE3007) Failed to recieve
a message. Details: Connessione in corso interrotta forzatamente dall'host
remoto.
---
LOG 29/07/2009 13:27:45 (TRN Test pid=6496 sid=48 trid=-1)
[tr.cpp:TRmain:583]: Session is closed
INFO 29/07/2009 13:27:45 (SM Test pid=8100)
[bm_core.cpp:bm_log_out_io_statistics:525]: IO block reads:0, writes:0
LOG 29/07/2009 13:27:45 (TRN Test pid=7456 sid=49 trid=-1)
[tr.cpp:TRmain:583]: Session is closed
INFO 29/07/2009 13:27:45 (SM Test pid=8100)
[bm_core.cpp:bm_log_out_io_statistics:525]: IO block reads:0, writes:0
LOG 29/07/2009 13:27:45 (TRN Test pid=6428 sid=47 trid=-1)
[tr.cpp:TRmain:583]: Session is closed
LOG 29/07/2009 13:28:03 (STOP pid=6312) [stop_server.cpp:main:88]: Request
for GOVERNOR shutdown issued
SYS 29/07/2009 13:28:04 (SM Test pid=8100) [uhdd.c:uIsFileExist:367]:
GetFileAttributes (code = 2): Impossibile trovare il file specificato.
LOG 29/07/2009 13:28:04 (SM Test pid=8100)
[trmgr.cpp:checkpoint_thread:202]: Checkpoint procedure is finished
LOG 29/07/2009 13:28:04 (SM Test pid=8100) [sm.cpp:main:777]: Wu is
released
LOG 29/07/2009 13:28:04 (GOV pid=6804) [gov.cpp:main:274]: SEDNA event log
is down
2009/7/28 Ivan Shcheklein <[email protected]>
> Hi Michele,
>
> Send us please event log files (at SEDNA_HOME/data/event***.log). It'll be
> much easy to determine where the problem is.
>
> Ivan Shcheklein,
> Sedna Team
>
> On Tue, Jul 28, 2009 at 8:33 PM, Michele Bassanelli <
> [email protected]> wrote:
>
>> Hi,
>>
>> I've encountered a problem when I try to use a Sedna XML:DB API for Java
>> in a multithreading application.
>>
>> When more than one thread try to store a different resource in the same
>> collection and the operation is bounded in one transaction I get the
>> following error:
>>
>> SEDNA Message: ERROR SE4703 The transaction is a victim of deadlock
>> resolution procedure.
>>
>> This is the test code for replicate the problem:
>>
>>
>>
>>
>> import org.xmldb.api.DatabaseManager;
>> import org.xmldb.api.base.Collection;
>> import org.xmldb.api.base.Database;
>> import org.xmldb.api.base.Resource;
>> import org.xmldb.api.base.XMLDBException;
>> import org.xmldb.api.modules.CollectionManagementService;
>> import org.xmldb.api.modules.TransactionService;
>> import org.xmldb.api.modules.XMLResource;
>>
>> public class Test3 {
>> public Test3() throws Exception {
>>
>> Database sednaDatabase;
>> Class<?> clazz = Class.forName("net.cfoster.sedna.DatabaseImpl");
>> sednaDatabase = (Database) (clazz.newInstance());
>> DatabaseManager.registerDatabase(sednaDatabase);
>>
>> int numThread = 10;
>> final Thread[] listThread = new Thread[numThread];
>>
>> for (int i = 0; i < numThread; i++) {
>>
>> final int count = i;
>>
>> listThread[i] = new Thread(new Runnable() {
>> public void run() {
>> Collection root = null;
>> TransactionService transactionService = null;
>> try {
>> root =
>> DatabaseManager.getCollection("xmldb:sedna://localhost:5050/Test", "SYSTEM",
>> "MANAGER");
>> transactionService = (TransactionService)
>> root.getService("TransactionService", "1.0");
>> transactionService.begin();
>> Resource r = root.createResource("test" + count,
>> XMLResource.RESOURCE_TYPE);
>> r.setContent("<test/>");
>> root.storeResource(r);
>> transactionService.commit();
>> } catch (Exception e) {
>> e.printStackTrace();
>> try {
>> transactionService.rollback();
>> } catch (XMLDBException e1) {
>> e1.printStackTrace();
>> }
>> } finally {
>> try {
>> root.close();
>> } catch (Exception e) {
>> e.printStackTrace();
>> }
>> }
>>
>> }
>>
>> });
>>
>> }
>> System.out.println("init");
>> for (int i = 0; i < numThread; i++) {
>> listThread[i].start();
>> }
>>
>> for (int i = 0; i < numThread; i++) {
>> listThread[i].join();
>> }
>> System.out.println("end");
>> System.exit(0);
>> }
>>
>>
>>
>> public static void main(String[] args) {
>> try {
>> new Test3();
>> } catch (Exception e) {
>> e.printStackTrace();
>> }
>> }
>> }
>>
>>
>> ------------------------------------------------------------------------------
>> Let Crystal Reports handle the reporting - Free Crystal Reports 2008
>> 30-Day
>> trial. Simplify your report design, integration and deployment - and focus
>> on
>> what you do best, core application coding. Discover what's new with
>> Crystal Reports now. http://p.sf.net/sfu/bobj-july
>> _______________________________________________
>> Sedna-discussion mailing list
>> [email protected]
>> https://lists.sourceforge.net/lists/listinfo/sedna-discussion
>>
>>
>
------------------------------------------------------------------------------
Let Crystal Reports handle the reporting - Free Crystal Reports 2008 30-Day
trial. Simplify your report design, integration and deployment - and focus on
what you do best, core application coding. Discover what's new with
Crystal Reports now. http://p.sf.net/sfu/bobj-july
_______________________________________________
Sedna-discussion mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/sedna-discussion
