Re: [h2] Can't use h2 database in a thread only with Java 8

[Eric Chatellier]

Le 19/03/2015 07:45, Thomas Mueller a écrit :
> Hi,
>
> The settings can be changed in any order... Does it consistently work in one
> case, but not the other?
Yes, it consistently fails if "set cluster ''" is not the first instruction.
In the same sql file, if i modify script just to set "set cluster ''" at the
begining of the file, it's working fine.
>
> Could you try with the latest version of H2, and append ";mv_store=false" to
> the database URL? I can't reproduce the problem with the latest version, and I
> didn't try yet with the version you use (1.3.176).
Same behaviour happen with 1.3.176 and 1.4.186 with ;mv_store=false

But you are right, i can't reproduce this bug with only h2 or h2 using
connection pool.

I'm currently able to reproduce this bug using h2 with hibernate (i attached my
test file)
(full maven test project is available here :
https://svn.nuiton.org/sandbox/h2j8test/ )

So this is even stranger :(
>
> Please note the beginning of the trace file is missing (where the database is
> opened). If you change the database URL to use "trace_level_file=3" then this
> should no occur.
I attached full trace file.

Regards,

-- 
Éric Chatellier - www.codelutin.com - 02.40.50.29.28

-- 
You received this message because you are subscribed to the Google Groups "H2 
Database" group.
To unsubscribe from this group and stop receiving emails from it, send an email 
to h2-database+unsubscr...@googlegroups.com.
To post to this group, send email to h2-database@googlegroups.com.
Visit this group at http://groups.google.com/group/h2-database.
For more options, visit https://groups.google.com/d/optout.

package org.test;

import java.io.File;
import java.util.Properties;

import org.hibernate.SQLQuery;
import org.hibernate.Session;
import org.hibernate.SessionFactory;
import org.hibernate.boot.registry.StandardServiceRegistry;
import org.hibernate.boot.registry.StandardServiceRegistryBuilder;
import org.hibernate.cfg.Configuration;

public class H2J8Test {

    public static void main(String[] args) throws Exception {

        // set properties
        Configuration config = new Configuration();
        config.setProperty("hibernate.connection.username", "sa");
        config.setProperty("hibernate.connection.password", "sa");
        config.setProperty("hibernate.dialect", "org.hibernate.dialect.H2Dialect");
        config.setProperty("hibernate.connection.driver_class", "org.h2.Driver");
        //config.setProperty("hibernate.current_session_context_class", "thread");
        config.setProperty("hibernate.connection.url", "jdbc:h2:file:./test_" + System.currentTimeMillis()
                + ";FILE_LOCK=file;DEFAULT_LOCK_TIMEOUT=1000;DB_CLOSE_DELAY=0;LOCK_MODE=3;TRACE_LEVEL_FILE=3;TRACE_LEVEL_SYSTEM_OUT=0;LOG=1;mv_store=false");

        // define hibernate factory
        Properties properties = config.getProperties();
        StandardServiceRegistryBuilder builder = new StandardServiceRegistryBuilder();
        StandardServiceRegistry standardServiceRegistry = builder.applySettings(properties).build();
        SessionFactory hibernateFactory = config.buildSessionFactory(standardServiceRegistry);

        // runscript
        final File file = new File("data-backup8.sql");
        String options = file.getName().endsWith(".gz") ? " COMPRESSION GZIP" : "";
        Session session = hibernateFactory.openSession();
        SQLQuery query = session.createSQLQuery("RUNSCRIPT FROM '" + file.getAbsolutePath() + "'" + options);
        query.executeUpdate();
        session.close();
        hibernateFactory.close();
    }
  
}

03-19 10:59:29 database: opening /tmp/h2j8test/test_1426759169560 (build 176)
03-19 10:59:29 fileLock: load {}
03-19 10:59:29 fileLock: save {id=14c317936d23f67c6aabe86040af1fbbf6dcf3fd544, 
method=file}
03-19 10:59:29 fileLock: load {method=file, 
id=14c317936d23f67c6aabe86040af1fbbf6dcf3fd544}
03-19 10:59:29 pageStore: writeVariableHeader
03-19 10:59:29 pageStore: updateRecord page[4] data leaf table:-1 PAGE_INDEX 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:29 pageStore: updateRecord page [3] freeList
03-19 10:59:29 index: PAGE_INDEX_DATA opened rows: 0
03-19 10:59:29 pageStore: log openForWriting firstPage: 5
03-19 10:59:29 pageStore: setLogFirstPage key: 1 trunk: 5 data: 6
03-19 10:59:29 pageStore: writeVariableHeader
03-19 10:59:29 pageStore: log undo 3
03-19 10:59:29 pageStore: log undo 514
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:1 */ 0, 0, 0, 514, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:29 pageStore: log undo 4
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:1 */ 0, 0, 0, 514, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:29 pageStore: updateRecord page[514] data leaf table:0 SYS 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:29 index: SYS_DATA opened rows: 0
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 index: SYS_DATA add ( /* key:1 */ 1, 0, 6, 'SET CREATE_BUILD 
176')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:1 */ 1, 0, 6, 'SET 
CREATE_BUILD 176')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 pageStore: log undo 515
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:3 */ 2, 0, 2, 515, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:3 */ 2, 0, 2, 515, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:29 pageStore: updateRecord page[515] data leaf table:2 LOBS 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:29 index: LOBS_DATA opened rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:2 */ 2, 0, 0, STRINGDECODE('CREATE 
CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOBS(\n    ID BIGINT NOT NULL,\n  
  BYTE_COUNT BIGINT,\n    TABLE INT\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:2 */ 2, 0, 0, 
STRINGDECODE('CREATE CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOBS(\n    
ID BIGINT NOT NULL,\n    BYTE_COUNT BIGINT,\n    TABLE INT\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOBS
03-19 10:59:29 lock: 1 exclusive write lock added for LOBS
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:4 */ 3, 1, 2, 0, 
'OFF,0,,d,false', '0')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:4 */ 3, 1, 2, 0, 
'OFF,0,,d,false', '0')
03-19 10:59:29 index: SYS_DATA add ( /* key:3 */ 3, 0, 1, 'CREATE PRIMARY KEY 
IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_2 ON INFORMATION_SCHEMA.LOBS(ID)')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:3 */ 3, 0, 1, 
'CREATE PRIMARY KEY IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_2 ON 
INFORMATION_SCHEMA.LOBS(ID)')
03-19 10:59:29 index: SYS_DATA add ( /* key:4 */ 4, 0, 5, 'ALTER TABLE 
INFORMATION_SCHEMA.LOBS ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_2 PRIMARY KEY(ID) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_2')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:4 */ 4, 0, 5, 
'ALTER TABLE INFORMATION_SCHEMA.LOBS ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_2 PRIMARY KEY(ID) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_2')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock unlock LOBS
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOBS
03-19 10:59:29 lock: 1 exclusive write lock added for LOBS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 pageStore: log undo 516
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:6 */ 5, 1, 2, 516, 
'OFF,0,,,false', '2')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:6 */ 5, 1, 2, 516, 
'OFF,0,,,false', '2')
03-19 10:59:29 pageStore: updateRecord page[516] b-tree leaf table:5 entries:0
03-19 10:59:29 index: opened INDEX_LOB_TABLE rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:5 */ 5, 0, 1, 'CREATE INDEX IF NOT 
EXISTS INFORMATION_SCHEMA.INDEX_LOB_TABLE ON INFORMATION_SCHEMA.LOBS(TABLE)')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:5 */ 5, 0, 1, 
'CREATE INDEX IF NOT EXISTS INFORMATION_SCHEMA.INDEX_LOB_TABLE ON 
INFORMATION_SCHEMA.LOBS(TABLE)')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock LOBS
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 pageStore: log undo 517
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:7 */ 6, 0, 6, 517, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:7 */ 6, 0, 6, 517, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:29 pageStore: updateRecord page[517] data leaf table:6 LOB_MAP 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:29 index: LOB_MAP_DATA opened rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:6 */ 6, 0, 0, STRINGDECODE('CREATE 
CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOB_MAP(\n    LOB BIGINT NOT 
NULL,\n    SEQ INT NOT NULL,\n    POS BIGINT,\n    HASH INT,\n    BLOCK 
BIGINT\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:6 */ 6, 0, 0, 
STRINGDECODE('CREATE CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOB_MAP(\n   
 LOB BIGINT NOT NULL,\n    SEQ INT NOT NULL,\n    POS BIGINT,\n    HASH INT,\n  
  BLOCK BIGINT\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock added for LOB_MAP
03-19 10:59:29 pageStore: log undo 518
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:8 */ 7, 1, 6, 518, 
'OFF,0,,,false', '0,1')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:8 */ 7, 1, 6, 518, 
'OFF,0,,,false', '0,1')
03-19 10:59:29 pageStore: updateRecord page[518] b-tree leaf table:7 entries:0
03-19 10:59:29 index: opened PRIMARY_KEY_3 rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:7 */ 7, 0, 1, 'CREATE PRIMARY KEY 
IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_3 ON 
INFORMATION_SCHEMA.LOB_MAP(LOB, SEQ)')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:7 */ 7, 0, 1, 
'CREATE PRIMARY KEY IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_3 ON 
INFORMATION_SCHEMA.LOB_MAP(LOB, SEQ)')
03-19 10:59:29 index: SYS_DATA add ( /* key:8 */ 8, 0, 5, 'ALTER TABLE 
INFORMATION_SCHEMA.LOB_MAP ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_3 PRIMARY KEY(LOB, SEQ) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_3')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:8 */ 8, 0, 5, 
'ALTER TABLE INFORMATION_SCHEMA.LOB_MAP ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_3 PRIMARY KEY(LOB, SEQ) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_3')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock unlock LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock added for LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock unlock LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock added for LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 pageStore: log undo 519
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:10 */ 9, 1, 6, 519, 
'OFF,0,,,false', '4,0')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:10 */ 9, 1, 6, 
519, 'OFF,0,,,false', '4,0')
03-19 10:59:29 pageStore: updateRecord page[519] b-tree leaf table:9 entries:0
03-19 10:59:29 index: opened INDEX_LOB_MAP_DATA_LOB rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:9 */ 9, 0, 1, 'CREATE INDEX IF NOT 
EXISTS INFORMATION_SCHEMA.INDEX_LOB_MAP_DATA_LOB ON 
INFORMATION_SCHEMA.LOB_MAP(BLOCK, LOB)')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:9 */ 9, 0, 1, 
'CREATE INDEX IF NOT EXISTS INFORMATION_SCHEMA.INDEX_LOB_MAP_DATA_LOB ON 
INFORMATION_SCHEMA.LOB_MAP(BLOCK, LOB)')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock LOB_MAP
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 pageStore: log undo 520
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:11 */ 10, 0, 10, 520, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:11 */ 10, 0, 10, 
520, 'OFF,0,,,false', '0,1,2')
03-19 10:59:29 pageStore: updateRecord page[520] data leaf table:10 LOB_DATA 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:29 index: LOB_DATA_DATA opened rows: 0
03-19 10:59:29 index: SYS_DATA add ( /* key:10 */ 10, 0, 0, 
STRINGDECODE('CREATE CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOB_DATA(\n  
  BLOCK BIGINT NOT NULL,\n    COMPRESSED INT,\n    DATA BINARY\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:10 */ 10, 0, 0, 
STRINGDECODE('CREATE CACHED TABLE IF NOT EXISTS INFORMATION_SCHEMA.LOB_DATA(\n  
  BLOCK BIGINT NOT NULL,\n    COMPRESSED INT,\n    DATA BINARY\n)\nHIDDEN'))
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 lock: 1 exclusive write lock requesting for LOB_DATA
03-19 10:59:29 lock: 1 exclusive write lock added for LOB_DATA
03-19 10:59:29 index: PAGE_INDEX_DATA add ( /* key:12 */ 11, 1, 10, 0, 
'OFF,0,,d,false', '0')
03-19 10:59:29 pageStore: log + s: 1 table: -1 row: ( /* key:12 */ 11, 1, 10, 
0, 'OFF,0,,d,false', '0')
03-19 10:59:29 index: SYS_DATA add ( /* key:11 */ 11, 0, 1, 'CREATE PRIMARY KEY 
IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_9 ON 
INFORMATION_SCHEMA.LOB_DATA(BLOCK)')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:11 */ 11, 0, 1, 
'CREATE PRIMARY KEY IF NOT EXISTS INFORMATION_SCHEMA.PRIMARY_KEY_9 ON 
INFORMATION_SCHEMA.LOB_DATA(BLOCK)')
03-19 10:59:29 index: SYS_DATA add ( /* key:12 */ 12, 0, 5, 'ALTER TABLE 
INFORMATION_SCHEMA.LOB_DATA ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_9 PRIMARY KEY(BLOCK) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_9')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:12 */ 12, 0, 5, 
'ALTER TABLE INFORMATION_SCHEMA.LOB_DATA ADD CONSTRAINT IF NOT EXISTS 
INFORMATION_SCHEMA.CONSTRAINT_9 PRIMARY KEY(BLOCK) INDEX 
INFORMATION_SCHEMA.PRIMARY_KEY_9')
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 lock: 1 exclusive write lock unlock LOB_DATA
03-19 10:59:29 lock: 1 shared read lock requesting for LOB_DATA
03-19 10:59:29 database: opened /tmp/h2j8test/test_1426759169560
03-19 10:59:29 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 1 exclusive write lock added for SYS
03-19 10:59:29 index: SYS_DATA add ( /* key:13 */ 13, 0, 2, 'CREATE USER IF NOT 
EXISTS SA SALT ''2553dfde111ac0f6'' HASH 
''2f4047c23518b427f70e56e8409e88fb63a2f2ec58dfffeb4dbb87b4165161b5'' ADMIN')
03-19 10:59:29 pageStore: log + s: 1 table: 0 row: ( /* key:13 */ 13, 0, 2, 
'CREATE USER IF NOT EXISTS SA SALT ''2553dfde111ac0f6'' HASH 
''2f4047c23518b427f70e56e8409e88fb63a2f2ec58dfffeb4dbb87b4165161b5'' ADMIN')
03-19 10:59:29 pageStore: pageOut.storePage [6] stream data key:1 pos:2048 
remaining:0
03-19 10:59:29 pageStore: log commit s: 1
03-19 10:59:29 lock: 1 exclusive write lock unlock SYS
03-19 10:59:29 database: connecting session #3 to 
/tmp/h2j8test/test_1426759169560
03-19 10:59:29 pageStore: pageOut.storePage [7] stream data key:1 pos:91 
remaining:1957
03-19 10:59:29 lock: 3 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 3 exclusive write lock added for SYS
03-19 10:59:29 index: SYS_DATA add ( /* key:14 */ 14, 0, 6, 'SET DB_CLOSE_DELAY 
0')
03-19 10:59:29 pageStore: log + s: 3 table: 0 row: ( /* key:14 */ 14, 0, 6, 
'SET DB_CLOSE_DELAY 0')
03-19 10:59:29 jdbc[3]: 
/*SQL t:1*/SET DB_CLOSE_DELAY 0;
03-19 10:59:29 pageStore: log commit s: 3
03-19 10:59:29 lock: 3 exclusive write lock unlock SYS
03-19 10:59:29 lock: 3 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 3 exclusive write lock added for SYS
03-19 10:59:29 index: SYS_DATA add ( /* key:15 */ 15, 0, 6, 'SET LOCK_MODE 3')
03-19 10:59:29 pageStore: log + s: 3 table: 0 row: ( /* key:15 */ 15, 0, 6, 
'SET LOCK_MODE 3')
03-19 10:59:29 jdbc[3]: 
/*SQL */SET LOCK_MODE 3;
03-19 10:59:29 pageStore: log commit s: 3
03-19 10:59:29 lock: 3 exclusive write lock unlock SYS
03-19 10:59:29 jdbc[3]: 
/*SQL */SET TRACE_LEVEL_FILE 3;
03-19 10:59:29 jdbc[3]: 
/*SQL */SET TRACE_LEVEL_SYSTEM_OUT 0;
03-19 10:59:29 lock: 3 exclusive write lock requesting for SYS
03-19 10:59:29 lock: 3 exclusive write lock added for SYS
03-19 10:59:29 index: SYS_DATA add ( /* key:16 */ 16, 0, 6, 'SET 
DEFAULT_LOCK_TIMEOUT 1000')
03-19 10:59:29 pageStore: log + s: 3 table: 0 row: ( /* key:16 */ 16, 0, 6, 
'SET DEFAULT_LOCK_TIMEOUT 1000')
03-19 10:59:29 jdbc[3]: 
/*SQL */SET DEFAULT_LOCK_TIMEOUT 1000;
03-19 10:59:29 pageStore: log commit s: 3
03-19 10:59:29 lock: 3 exclusive write lock unlock SYS
03-19 10:59:29 jdbc[3]: 
/*SQL */SET LOG 1;
03-19 10:59:29 jdbc[3]: 
/*SQL */SET FILE_LOCK file;
03-19 10:59:29 jdbc[3]: 
/**/Connection conn2 = 
DriverManager.getConnection("jdbc:h2:file:./test_1426759169560;FILE_LOCK=file;DEFAULT_LOCK_TIMEOUT=1000;DB_CLOSE_DELAY=0;LOCK_MODE=3;TRACE_LEVEL_FILE=3;TRACE_LEVEL_SYSTEM_OUT=0;LOG=1;mv_store=false",
 "SA", "");
03-19 10:59:29 jdbc[3]: 
/**/conn2.getAutoCommit();
03-19 10:59:29 jdbc[3]: 
/**/conn2.setAutoCommit(false);
03-19 10:59:29 jdbc[3]: 
/**/DatabaseMetaData dbMeta0 = conn2.getMetaData();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.supportsNamedParameters();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.supportsResultSetType(1004);
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.supportsBatchUpdates();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.dataDefinitionCausesTransactionCommit();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.dataDefinitionIgnoredInTransactions();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.supportsGetGeneratedKeys();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.getSQLKeywords();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.getSQLStateType();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.locatorsUpdateCopy();
03-19 10:59:29 jdbc[3]: 
/**/dbMeta0.getTypeInfo();
03-19 10:59:29 jdbc[3]: 
/**/PreparedStatement prep1 = conn2.prepareStatement("SELECT TYPE_NAME, 
DATA_TYPE, PRECISION, PREFIX LITERAL_PREFIX, SUFFIX LITERAL_SUFFIX, PARAMS 
CREATE_PARAMS, NULLABLE, CASE_SENSITIVE, SEARCHABLE, FALSE UNSIGNED_ATTRIBUTE, 
FALSE FIXED_PREC_SCALE, AUTO_INCREMENT, TYPE_NAME LOCAL_TYPE_NAME, 
MINIMUM_SCALE, MAXIMUM_SCALE, DATA_TYPE SQL_DATA_TYPE, ZERO() SQL_DATETIME_SUB, 
RADIX NUM_PREC_RADIX FROM INFORMATION_SCHEMA.TYPE_INFO ORDER BY DATA_TYPE, 
POS");
03-19 10:59:29 jdbc[3]: 
/**/ResultSet rs10 = prep1.executeQuery();
03-19 10:59:29 jdbc[3]: 
/*SQL #:29 t:3*/SELECT TYPE_NAME, DATA_TYPE, PRECISION, PREFIX LITERAL_PREFIX, 
SUFFIX LITERAL_SUFFIX, PARAMS CREATE_PARAMS, NULLABLE, CASE_SENSITIVE, 
SEARCHABLE, FALSE UNSIGNED_ATTRIBUTE, FALSE FIXED_PREC_SCALE, AUTO_INCREMENT, 
TYPE_NAME LOCAL_TYPE_NAME, MINIMUM_SCALE, MAXIMUM_SCALE, DATA_TYPE 
SQL_DATA_TYPE, ZERO() SQL_DATETIME_SUB, RADIX NUM_PREC_RADIX FROM 
INFORMATION_SCHEMA.TYPE_INFO ORDER BY DATA_TYPE, POS;
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("TYPE_NAME");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("DATA_TYPE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("CREATE_PARAMS");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("UNSIGNED_ATTRIBUTE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getInt("PRECISION");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MINIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("MAXIMUM_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("FIXED_PREC_SCALE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_PREFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getString("LITERAL_SUFFIX");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getBoolean("CASE_SENSITIVE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("SEARCHABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.getShort("NULLABLE");
03-19 10:59:29 jdbc[3]: 
/**/rs10.next();
03-19 10:59:29 jdbc[3]: 
/**/rs10.close();
03-19 10:59:29 jdbc[3]: 
/**/prep1.close();
03-19 10:59:30 jdbc[3]: 
/**/conn2.getCatalog();
03-19 10:59:30 jdbc[3]: 
/*SQL #:1*/CALL DATABASE();
03-19 10:59:30 jdbc[3]: 
/**/DatabaseMetaData dbMeta1 = conn2.getMetaData();
03-19 10:59:30 jdbc[3]: 
/**/dbMeta1.getJDBCMajorVersion();
03-19 10:59:30 jdbc[3]: 
/**/Clob clob0 = conn2.createClob();
03-19 10:59:30 jdbc[3]: 
/**/clob0.free();
03-19 10:59:30 jdbc[3]: 
/**/PreparedStatement prep2 = conn2.prepareStatement("RUNSCRIPT FROM 
'/tmp/h2j8test/data-backup8.sql'");
03-19 10:59:30 jdbc[3]: 
/**/prep2.executeUpdate();
03-19 10:59:30 lock: 3 exclusive write lock requesting for SYS
03-19 10:59:30 lock: 3 exclusive write lock added for SYS
03-19 10:59:30 index: SYS_DATA add ( /* key:17 */ 17, 0, 6, 'SET CACHE_SIZE 
16384')
03-19 10:59:30 pageStore: log + s: 3 table: 0 row: ( /* key:17 */ 17, 0, 6, 
'SET CACHE_SIZE 16384')
03-19 10:59:30 lock: 1 exclusive write lock requesting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 pageStore: pageOut.storePage [7] stream data key:1 pos:223 
remaining:1825
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:30 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:31 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:32 lock: 1 exclusive write lock waiting for SYS
03-19 10:59:32 lock: 1 exclusive write lock timeout after 2000 SYS
03-19 10:59:32 pageStore: log commit s: 3
03-19 10:59:32 lock: 3 exclusive write lock unlock SYS
03-19 10:59:32 command: slow query: 2 003 ms
03-19 10:59:32 jdbc[3]: exception
org.h2.jdbc.JdbcSQLException: Timeout trying to lock table "SYS"; SQL statement:
          
SET CLUSTER '' [50200-176]
        at org.h2.message.DbException.getJdbcSQLException(DbException.java:344)
        at org.h2.message.DbException.get(DbException.java:178)
        at org.h2.message.DbException.get(DbException.java:154)
        at org.h2.table.RegularTable.doLock(RegularTable.java:530)
        at org.h2.table.RegularTable.lock(RegularTable.java:464)
        at org.h2.engine.Database.lockMeta(Database.java:869)
        at org.h2.engine.Database.addDatabaseObject(Database.java:983)
        at org.h2.command.dml.Set.addOrUpdateSetting(Set.java:524)
        at org.h2.command.dml.Set.update(Set.java:111)
        at org.h2.command.dml.RunScriptCommand.execute(RunScriptCommand.java:79)
        at org.h2.command.dml.RunScriptCommand.update(RunScriptCommand.java:58)
        at org.h2.command.CommandContainer.update(CommandContainer.java:79)
        at org.h2.command.Command.executeUpdate(Command.java:254)
        at 
org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:158)
        at 
org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:144)
        at 
org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:208)
        at 
org.hibernate.engine.query.spi.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:211)
        at 
org.hibernate.internal.SessionImpl.executeNativeUpdate(SessionImpl.java:1310)
        at 
org.hibernate.internal.SQLQueryImpl.executeUpdate(SQLQueryImpl.java:389)
        at org.test.H2J8Test.main(H2J8Test.java:38)
03-19 10:59:32 jdbc[3]: 
/**/prep2.getWarnings();
03-19 10:59:32 jdbc[3]: 
/**/prep2.clearWarnings();
03-19 10:59:32 jdbc[3]: 
/**/prep2.getMaxRows();
03-19 10:59:32 jdbc[3]: 
/**/prep2.getQueryTimeout();
03-19 10:59:32 jdbc[3]: 
/**/conn2.getQueryTimeout();
03-19 10:59:32 jdbc[3]: 
/*SQL l:58 #:1 t:3*/SELECT VALUE FROM INFORMATION_SCHEMA.SETTINGS WHERE NAME=? 
{1: 'QUERY_TIMEOUT'};
03-19 10:59:32 jdbc[3]: 
/**/prep2.close();
03-19 10:59:32 jdbc[3]: 
/**/conn2.getAutoCommit();
03-19 10:59:32 pageStore: pageOut.storePage [7] stream data key:1 pos:225 
remaining:1823
03-19 10:59:33 database: closing /tmp/h2j8test/test_1426759169560 from shutdown 
hook
03-19 10:59:33 database: disconnecting session #3
03-19 10:59:33 database: disconnected session #3
03-19 10:59:33 database: closing /tmp/h2j8test/test_1426759169560
03-19 10:59:33 lock: 2 shared read lock requesting for LOBS
03-19 10:59:33 lock: 2 shared read lock requesting for LOBS
03-19 10:59:33 index: LOB_MAP_DATA close
03-19 10:59:33 index: close
03-19 10:59:33 index: close
03-19 10:59:33 index: LOB_DATA_DATA close
03-19 10:59:33 index: LOBS_DATA close
03-19 10:59:33 index: close
03-19 10:59:33 index: SYS_DATA close
03-19 10:59:33 pageStore: checkpoint
03-19 10:59:33 pageStore: pageOut.storePage [7] stream data key:1 pos:226 
remaining:1822
03-19 10:59:33 pageStore: pageOut.storePage fill 7
03-19 10:59:33 pageStore: writeBack page [3] freeList
03-19 10:59:33 pageStore: writeBack page[4] data leaf table:-1 PAGE_INDEX 
entries:9 parent:0 keys:[1, 3, 4, 6, 7, 8, 10, 11, 12, 0] offsets:[2020, 1994, 
1973, 1951, 1921, 1897, 1873, 1847, 1826, 0]
03-19 10:59:33 pageStore: writeBack page[514] data leaf table:0 SYS entries:17 
parent:0 keys:[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 0, 0, 
0] offsets:[2024, 1890, 1789, 1632, 1532, 1362, 1252, 1086, 971, 831, 723, 559, 
423, 399, 380, 346, 321, 0, 0, 0]
03-19 10:59:33 pageStore: writeBack page[515] data leaf table:2 LOBS entries:0 
parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: writeBack page[516] b-tree leaf table:5 entries:0
03-19 10:59:33 pageStore: writeBack page[517] data leaf table:6 LOB_MAP 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: writeBack page[518] b-tree leaf table:7 entries:0
03-19 10:59:33 pageStore: writeBack page[519] b-tree leaf table:9 entries:0
03-19 10:59:33 pageStore: writeBack page[520] data leaf table:10 LOB_DATA 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: getFirstUncommittedSection
03-19 10:59:33 pageStore: log.removeUntil 5 8
03-19 10:59:33 pageStore: setLogFirstPage key: 1 trunk: 5 data: 8
03-19 10:59:33 pageStore: writeVariableHeader
03-19 10:59:33 pageStore: pageOut.storePage [8] stream data key:1 pos:12 
remaining:2036
03-19 10:59:33 pageStore: pageOut.storePage fill 8
03-19 10:59:33 pageStore: writeFree
03-19 10:59:33 lock: 0 exclusive write lock requesting for SYS
03-19 10:59:33 lock: 0 exclusive write lock added for SYS
03-19 10:59:33 pageStore: log free
03-19 10:59:33 pageStore: updateRecord page [3] freeList
03-19 10:59:33 pageStore: freeUnused 10
03-19 10:59:33 pageStore: freeUnused 11
03-19 10:59:33 pageStore: freeUnused 12
03-19 10:59:33 pageStore: freeUnused 13
03-19 10:59:33 pageStore: freeUnused 14
03-19 10:59:33 pageStore: freeUnused 15
03-19 10:59:33 pageStore: freeUnused 16
03-19 10:59:33 pageStore: freeUnused 17
03-19 10:59:33 pageStore: freeUnused 18
03-19 10:59:33 pageStore: freeUnused 19
03-19 10:59:33 pageStore: freeUnused 20
03-19 10:59:33 pageStore: freeUnused 21
03-19 10:59:33 pageStore: freeUnused 22
03-19 10:59:33 pageStore: freeUnused 23
03-19 10:59:33 pageStore: freeUnused 24
03-19 10:59:33 pageStore: freeUnused 25
03-19 10:59:33 pageStore: freeUnused 26
03-19 10:59:33 pageStore: freeUnused 27
03-19 10:59:33 pageStore: freeUnused 28
03-19 10:59:33 pageStore: freeUnused 29
03-19 10:59:33 pageStore: freeUnused 30
03-19 10:59:33 pageStore: freeUnused 31
03-19 10:59:33 pageStore: freeUnused 32
03-19 10:59:33 pageStore: freeUnused 33
03-19 10:59:33 pageStore: freeUnused 34
03-19 10:59:33 pageStore: freeUnused 35
03-19 10:59:33 pageStore: freeUnused 36
03-19 10:59:33 pageStore: freeUnused 37
03-19 10:59:33 pageStore: freeUnused 38
03-19 10:59:33 pageStore: freeUnused 39
03-19 10:59:33 pageStore: freeUnused 40
03-19 10:59:33 pageStore: freeUnused 41
03-19 10:59:33 pageStore: freeUnused 42
03-19 10:59:33 pageStore: freeUnused 43
03-19 10:59:33 pageStore: freeUnused 44
03-19 10:59:33 pageStore: freeUnused 45
03-19 10:59:33 pageStore: freeUnused 46
03-19 10:59:33 pageStore: freeUnused 47
03-19 10:59:33 pageStore: freeUnused 48
03-19 10:59:33 pageStore: freeUnused 49
03-19 10:59:33 pageStore: freeUnused 50
03-19 10:59:33 pageStore: freeUnused 51
03-19 10:59:33 pageStore: freeUnused 52
03-19 10:59:33 pageStore: freeUnused 53
03-19 10:59:33 pageStore: freeUnused 54
03-19 10:59:33 pageStore: freeUnused 55
03-19 10:59:33 pageStore: freeUnused 56
03-19 10:59:33 pageStore: freeUnused 57
03-19 10:59:33 pageStore: freeUnused 58
03-19 10:59:33 pageStore: freeUnused 59
03-19 10:59:33 pageStore: freeUnused 60
03-19 10:59:33 pageStore: freeUnused 61
03-19 10:59:33 pageStore: freeUnused 62
03-19 10:59:33 pageStore: freeUnused 63
03-19 10:59:33 pageStore: freeUnused 64
03-19 10:59:33 pageStore: freeUnused 65
03-19 10:59:33 pageStore: freeUnused 66
03-19 10:59:33 pageStore: freeUnused 67
03-19 10:59:33 pageStore: freeUnused 68
03-19 10:59:33 pageStore: freeUnused 69
03-19 10:59:33 pageStore: freeUnused 70
03-19 10:59:33 pageStore: freeUnused 71
03-19 10:59:33 pageStore: freeUnused 72
03-19 10:59:33 pageStore: freeUnused 73
03-19 10:59:33 pageStore: freeUnused 74
03-19 10:59:33 pageStore: freeUnused 75
03-19 10:59:33 pageStore: freeUnused 76
03-19 10:59:33 pageStore: freeUnused 77
03-19 10:59:33 pageStore: freeUnused 78
03-19 10:59:33 pageStore: freeUnused 79
03-19 10:59:33 pageStore: freeUnused 80
03-19 10:59:33 pageStore: freeUnused 81
03-19 10:59:33 pageStore: freeUnused 82
03-19 10:59:33 pageStore: freeUnused 83
03-19 10:59:33 pageStore: freeUnused 84
03-19 10:59:33 pageStore: freeUnused 85
03-19 10:59:33 pageStore: freeUnused 86
03-19 10:59:33 pageStore: freeUnused 87
03-19 10:59:33 pageStore: freeUnused 88
03-19 10:59:33 pageStore: freeUnused 89
03-19 10:59:33 pageStore: freeUnused 90
03-19 10:59:33 pageStore: freeUnused 91
03-19 10:59:33 pageStore: freeUnused 92
03-19 10:59:33 pageStore: freeUnused 93
03-19 10:59:33 pageStore: freeUnused 94
03-19 10:59:33 pageStore: freeUnused 95
03-19 10:59:33 pageStore: freeUnused 96
03-19 10:59:33 pageStore: freeUnused 97
03-19 10:59:33 pageStore: freeUnused 98
03-19 10:59:33 pageStore: freeUnused 99
03-19 10:59:33 pageStore: freeUnused 100
03-19 10:59:33 pageStore: freeUnused 101
03-19 10:59:33 pageStore: freeUnused 102
03-19 10:59:33 pageStore: freeUnused 103
03-19 10:59:33 pageStore: freeUnused 104
03-19 10:59:33 pageStore: freeUnused 105
03-19 10:59:33 pageStore: freeUnused 106
03-19 10:59:33 pageStore: freeUnused 107
03-19 10:59:33 pageStore: freeUnused 108
03-19 10:59:33 pageStore: freeUnused 109
03-19 10:59:33 pageStore: freeUnused 110
03-19 10:59:33 pageStore: freeUnused 111
03-19 10:59:33 pageStore: freeUnused 112
03-19 10:59:33 pageStore: freeUnused 113
03-19 10:59:33 pageStore: freeUnused 114
03-19 10:59:33 pageStore: freeUnused 115
03-19 10:59:33 pageStore: freeUnused 116
03-19 10:59:33 pageStore: freeUnused 117
03-19 10:59:33 pageStore: freeUnused 118
03-19 10:59:33 pageStore: freeUnused 119
03-19 10:59:33 pageStore: freeUnused 120
03-19 10:59:33 pageStore: freeUnused 121
03-19 10:59:33 pageStore: freeUnused 122
03-19 10:59:33 pageStore: freeUnused 123
03-19 10:59:33 pageStore: freeUnused 124
03-19 10:59:33 pageStore: freeUnused 125
03-19 10:59:33 pageStore: freeUnused 126
03-19 10:59:33 pageStore: freeUnused 127
03-19 10:59:33 pageStore: freeUnused 128
03-19 10:59:33 pageStore: freeUnused 129
03-19 10:59:33 pageStore: freeUnused 130
03-19 10:59:33 pageStore: freeUnused 131
03-19 10:59:33 pageStore: freeUnused 132
03-19 10:59:33 pageStore: freeUnused 133
03-19 10:59:33 pageStore: freeUnused 134
03-19 10:59:33 pageStore: freeUnused 135
03-19 10:59:33 pageStore: freeUnused 136
03-19 10:59:33 pageStore: freeUnused 137
03-19 10:59:33 pageStore: freeUnused 138
03-19 10:59:33 pageStore: freeUnused 139
03-19 10:59:33 pageStore: freeUnused 140
03-19 10:59:33 pageStore: freeUnused 141
03-19 10:59:33 pageStore: freeUnused 142
03-19 10:59:33 pageStore: freeUnused 143
03-19 10:59:33 pageStore: freeUnused 144
03-19 10:59:33 pageStore: freeUnused 145
03-19 10:59:33 pageStore: freeUnused 146
03-19 10:59:33 pageStore: freeUnused 147
03-19 10:59:33 pageStore: freeUnused 148
03-19 10:59:33 pageStore: freeUnused 149
03-19 10:59:33 pageStore: freeUnused 150
03-19 10:59:33 pageStore: freeUnused 151
03-19 10:59:33 pageStore: freeUnused 152
03-19 10:59:33 pageStore: freeUnused 153
03-19 10:59:33 pageStore: freeUnused 154
03-19 10:59:33 pageStore: freeUnused 155
03-19 10:59:33 pageStore: freeUnused 156
03-19 10:59:33 pageStore: freeUnused 157
03-19 10:59:33 pageStore: freeUnused 158
03-19 10:59:33 pageStore: freeUnused 159
03-19 10:59:33 pageStore: freeUnused 160
03-19 10:59:33 pageStore: freeUnused 161
03-19 10:59:33 pageStore: freeUnused 162
03-19 10:59:33 pageStore: freeUnused 163
03-19 10:59:33 pageStore: freeUnused 164
03-19 10:59:33 pageStore: freeUnused 165
03-19 10:59:33 pageStore: freeUnused 166
03-19 10:59:33 pageStore: freeUnused 167
03-19 10:59:33 pageStore: freeUnused 168
03-19 10:59:33 pageStore: freeUnused 169
03-19 10:59:33 pageStore: freeUnused 170
03-19 10:59:33 pageStore: freeUnused 171
03-19 10:59:33 pageStore: freeUnused 172
03-19 10:59:33 pageStore: freeUnused 173
03-19 10:59:33 pageStore: freeUnused 174
03-19 10:59:33 pageStore: freeUnused 175
03-19 10:59:33 pageStore: freeUnused 176
03-19 10:59:33 pageStore: freeUnused 177
03-19 10:59:33 pageStore: freeUnused 178
03-19 10:59:33 pageStore: freeUnused 179
03-19 10:59:33 pageStore: freeUnused 180
03-19 10:59:33 pageStore: freeUnused 181
03-19 10:59:33 pageStore: freeUnused 182
03-19 10:59:33 pageStore: freeUnused 183
03-19 10:59:33 pageStore: freeUnused 184
03-19 10:59:33 pageStore: freeUnused 185
03-19 10:59:33 pageStore: freeUnused 186
03-19 10:59:33 pageStore: freeUnused 187
03-19 10:59:33 pageStore: freeUnused 188
03-19 10:59:33 pageStore: freeUnused 189
03-19 10:59:33 pageStore: freeUnused 190
03-19 10:59:33 pageStore: freeUnused 191
03-19 10:59:33 pageStore: freeUnused 192
03-19 10:59:33 pageStore: freeUnused 193
03-19 10:59:33 pageStore: freeUnused 194
03-19 10:59:33 pageStore: freeUnused 195
03-19 10:59:33 pageStore: freeUnused 196
03-19 10:59:33 pageStore: freeUnused 197
03-19 10:59:33 pageStore: freeUnused 198
03-19 10:59:33 pageStore: freeUnused 199
03-19 10:59:33 pageStore: freeUnused 200
03-19 10:59:33 pageStore: freeUnused 201
03-19 10:59:33 pageStore: freeUnused 202
03-19 10:59:33 pageStore: freeUnused 203
03-19 10:59:33 pageStore: freeUnused 204
03-19 10:59:33 pageStore: freeUnused 205
03-19 10:59:33 pageStore: freeUnused 206
03-19 10:59:33 pageStore: freeUnused 207
03-19 10:59:33 pageStore: freeUnused 208
03-19 10:59:33 pageStore: freeUnused 209
03-19 10:59:33 pageStore: freeUnused 210
03-19 10:59:33 pageStore: freeUnused 211
03-19 10:59:33 pageStore: freeUnused 212
03-19 10:59:33 pageStore: freeUnused 213
03-19 10:59:33 pageStore: freeUnused 214
03-19 10:59:33 pageStore: freeUnused 215
03-19 10:59:33 pageStore: freeUnused 216
03-19 10:59:33 pageStore: freeUnused 217
03-19 10:59:33 pageStore: freeUnused 218
03-19 10:59:33 pageStore: freeUnused 219
03-19 10:59:33 pageStore: freeUnused 220
03-19 10:59:33 pageStore: freeUnused 221
03-19 10:59:33 pageStore: freeUnused 222
03-19 10:59:33 pageStore: freeUnused 223
03-19 10:59:33 pageStore: freeUnused 224
03-19 10:59:33 pageStore: freeUnused 225
03-19 10:59:33 pageStore: freeUnused 226
03-19 10:59:33 pageStore: freeUnused 227
03-19 10:59:33 pageStore: freeUnused 228
03-19 10:59:33 pageStore: freeUnused 229
03-19 10:59:33 pageStore: freeUnused 230
03-19 10:59:33 pageStore: freeUnused 231
03-19 10:59:33 pageStore: freeUnused 232
03-19 10:59:33 pageStore: freeUnused 233
03-19 10:59:33 pageStore: freeUnused 234
03-19 10:59:33 pageStore: freeUnused 235
03-19 10:59:33 pageStore: freeUnused 236
03-19 10:59:33 pageStore: freeUnused 237
03-19 10:59:33 pageStore: freeUnused 238
03-19 10:59:33 pageStore: freeUnused 239
03-19 10:59:33 pageStore: freeUnused 240
03-19 10:59:33 pageStore: freeUnused 241
03-19 10:59:33 pageStore: freeUnused 242
03-19 10:59:33 pageStore: freeUnused 243
03-19 10:59:33 pageStore: freeUnused 244
03-19 10:59:33 pageStore: freeUnused 245
03-19 10:59:33 pageStore: freeUnused 246
03-19 10:59:33 pageStore: freeUnused 247
03-19 10:59:33 pageStore: freeUnused 248
03-19 10:59:33 pageStore: freeUnused 249
03-19 10:59:33 pageStore: freeUnused 250
03-19 10:59:33 pageStore: freeUnused 251
03-19 10:59:33 pageStore: freeUnused 252
03-19 10:59:33 pageStore: freeUnused 253
03-19 10:59:33 pageStore: freeUnused 254
03-19 10:59:33 pageStore: freeUnused 255
03-19 10:59:33 pageStore: freeUnused 256
03-19 10:59:33 pageStore: freeUnused 257
03-19 10:59:33 pageStore: freeUnused 258
03-19 10:59:33 pageStore: freeUnused 259
03-19 10:59:33 pageStore: freeUnused 260
03-19 10:59:33 pageStore: freeUnused 261
03-19 10:59:33 pageStore: freeUnused 262
03-19 10:59:33 pageStore: freeUnused 263
03-19 10:59:33 pageStore: freeUnused 264
03-19 10:59:33 pageStore: freeUnused 265
03-19 10:59:33 pageStore: freeUnused 266
03-19 10:59:33 pageStore: freeUnused 267
03-19 10:59:33 pageStore: freeUnused 268
03-19 10:59:33 pageStore: freeUnused 269
03-19 10:59:33 pageStore: freeUnused 270
03-19 10:59:33 pageStore: freeUnused 271
03-19 10:59:33 pageStore: freeUnused 272
03-19 10:59:33 pageStore: freeUnused 273
03-19 10:59:33 pageStore: freeUnused 274
03-19 10:59:33 pageStore: freeUnused 275
03-19 10:59:33 pageStore: freeUnused 276
03-19 10:59:33 pageStore: freeUnused 277
03-19 10:59:33 pageStore: freeUnused 278
03-19 10:59:33 pageStore: freeUnused 279
03-19 10:59:33 pageStore: freeUnused 280
03-19 10:59:33 pageStore: freeUnused 281
03-19 10:59:33 pageStore: freeUnused 282
03-19 10:59:33 pageStore: freeUnused 283
03-19 10:59:33 pageStore: freeUnused 284
03-19 10:59:33 pageStore: freeUnused 285
03-19 10:59:33 pageStore: freeUnused 286
03-19 10:59:33 pageStore: freeUnused 287
03-19 10:59:33 pageStore: freeUnused 288
03-19 10:59:33 pageStore: freeUnused 289
03-19 10:59:33 pageStore: freeUnused 290
03-19 10:59:33 pageStore: freeUnused 291
03-19 10:59:33 pageStore: freeUnused 292
03-19 10:59:33 pageStore: freeUnused 293
03-19 10:59:33 pageStore: freeUnused 294
03-19 10:59:33 pageStore: freeUnused 295
03-19 10:59:33 pageStore: freeUnused 296
03-19 10:59:33 pageStore: freeUnused 297
03-19 10:59:33 pageStore: freeUnused 298
03-19 10:59:33 pageStore: freeUnused 299
03-19 10:59:33 pageStore: freeUnused 300
03-19 10:59:33 pageStore: freeUnused 301
03-19 10:59:33 pageStore: freeUnused 302
03-19 10:59:33 pageStore: freeUnused 303
03-19 10:59:33 pageStore: freeUnused 304
03-19 10:59:33 pageStore: freeUnused 305
03-19 10:59:33 pageStore: freeUnused 306
03-19 10:59:33 pageStore: freeUnused 307
03-19 10:59:33 pageStore: freeUnused 308
03-19 10:59:33 pageStore: freeUnused 309
03-19 10:59:33 pageStore: freeUnused 310
03-19 10:59:33 pageStore: freeUnused 311
03-19 10:59:33 pageStore: freeUnused 312
03-19 10:59:33 pageStore: freeUnused 313
03-19 10:59:33 pageStore: freeUnused 314
03-19 10:59:33 pageStore: freeUnused 315
03-19 10:59:33 pageStore: freeUnused 316
03-19 10:59:33 pageStore: freeUnused 317
03-19 10:59:33 pageStore: freeUnused 318
03-19 10:59:33 pageStore: freeUnused 319
03-19 10:59:33 pageStore: freeUnused 320
03-19 10:59:33 pageStore: freeUnused 321
03-19 10:59:33 pageStore: freeUnused 322
03-19 10:59:33 pageStore: freeUnused 323
03-19 10:59:33 pageStore: freeUnused 324
03-19 10:59:33 pageStore: freeUnused 325
03-19 10:59:33 pageStore: freeUnused 326
03-19 10:59:33 pageStore: freeUnused 327
03-19 10:59:33 pageStore: freeUnused 328
03-19 10:59:33 pageStore: freeUnused 329
03-19 10:59:33 pageStore: freeUnused 330
03-19 10:59:33 pageStore: freeUnused 331
03-19 10:59:33 pageStore: freeUnused 332
03-19 10:59:33 pageStore: freeUnused 333
03-19 10:59:33 pageStore: freeUnused 334
03-19 10:59:33 pageStore: freeUnused 335
03-19 10:59:33 pageStore: freeUnused 336
03-19 10:59:33 pageStore: freeUnused 337
03-19 10:59:33 pageStore: freeUnused 338
03-19 10:59:33 pageStore: freeUnused 339
03-19 10:59:33 pageStore: freeUnused 340
03-19 10:59:33 pageStore: freeUnused 341
03-19 10:59:33 pageStore: freeUnused 342
03-19 10:59:33 pageStore: freeUnused 343
03-19 10:59:33 pageStore: freeUnused 344
03-19 10:59:33 pageStore: freeUnused 345
03-19 10:59:33 pageStore: freeUnused 346
03-19 10:59:33 pageStore: freeUnused 347
03-19 10:59:33 pageStore: freeUnused 348
03-19 10:59:33 pageStore: freeUnused 349
03-19 10:59:33 pageStore: freeUnused 350
03-19 10:59:33 pageStore: freeUnused 351
03-19 10:59:33 pageStore: freeUnused 352
03-19 10:59:33 pageStore: freeUnused 353
03-19 10:59:33 pageStore: freeUnused 354
03-19 10:59:33 pageStore: freeUnused 355
03-19 10:59:33 pageStore: freeUnused 356
03-19 10:59:33 pageStore: freeUnused 357
03-19 10:59:33 pageStore: freeUnused 358
03-19 10:59:33 pageStore: freeUnused 359
03-19 10:59:33 pageStore: freeUnused 360
03-19 10:59:33 pageStore: freeUnused 361
03-19 10:59:33 pageStore: freeUnused 362
03-19 10:59:33 pageStore: freeUnused 363
03-19 10:59:33 pageStore: freeUnused 364
03-19 10:59:33 pageStore: freeUnused 365
03-19 10:59:33 pageStore: freeUnused 366
03-19 10:59:33 pageStore: freeUnused 367
03-19 10:59:33 pageStore: freeUnused 368
03-19 10:59:33 pageStore: freeUnused 369
03-19 10:59:33 pageStore: freeUnused 370
03-19 10:59:33 pageStore: freeUnused 371
03-19 10:59:33 pageStore: freeUnused 372
03-19 10:59:33 pageStore: freeUnused 373
03-19 10:59:33 pageStore: freeUnused 374
03-19 10:59:33 pageStore: freeUnused 375
03-19 10:59:33 pageStore: freeUnused 376
03-19 10:59:33 pageStore: freeUnused 377
03-19 10:59:33 pageStore: freeUnused 378
03-19 10:59:33 pageStore: freeUnused 379
03-19 10:59:33 pageStore: freeUnused 380
03-19 10:59:33 pageStore: freeUnused 381
03-19 10:59:33 pageStore: freeUnused 382
03-19 10:59:33 pageStore: freeUnused 383
03-19 10:59:33 pageStore: freeUnused 384
03-19 10:59:33 pageStore: freeUnused 385
03-19 10:59:33 pageStore: freeUnused 386
03-19 10:59:33 pageStore: freeUnused 387
03-19 10:59:33 pageStore: freeUnused 388
03-19 10:59:33 pageStore: freeUnused 389
03-19 10:59:33 pageStore: freeUnused 390
03-19 10:59:33 pageStore: freeUnused 391
03-19 10:59:33 pageStore: freeUnused 392
03-19 10:59:33 pageStore: freeUnused 393
03-19 10:59:33 pageStore: freeUnused 394
03-19 10:59:33 pageStore: freeUnused 395
03-19 10:59:33 pageStore: freeUnused 396
03-19 10:59:33 pageStore: freeUnused 397
03-19 10:59:33 pageStore: freeUnused 398
03-19 10:59:33 pageStore: freeUnused 399
03-19 10:59:33 pageStore: freeUnused 400
03-19 10:59:33 pageStore: freeUnused 401
03-19 10:59:33 pageStore: freeUnused 402
03-19 10:59:33 pageStore: freeUnused 403
03-19 10:59:33 pageStore: freeUnused 404
03-19 10:59:33 pageStore: freeUnused 405
03-19 10:59:33 pageStore: freeUnused 406
03-19 10:59:33 pageStore: freeUnused 407
03-19 10:59:33 pageStore: freeUnused 408
03-19 10:59:33 pageStore: freeUnused 409
03-19 10:59:33 pageStore: freeUnused 410
03-19 10:59:33 pageStore: freeUnused 411
03-19 10:59:33 pageStore: freeUnused 412
03-19 10:59:33 pageStore: freeUnused 413
03-19 10:59:33 pageStore: freeUnused 414
03-19 10:59:33 pageStore: freeUnused 415
03-19 10:59:33 pageStore: freeUnused 416
03-19 10:59:33 pageStore: freeUnused 417
03-19 10:59:33 pageStore: freeUnused 418
03-19 10:59:33 pageStore: freeUnused 419
03-19 10:59:33 pageStore: freeUnused 420
03-19 10:59:33 pageStore: freeUnused 421
03-19 10:59:33 pageStore: freeUnused 422
03-19 10:59:33 pageStore: freeUnused 423
03-19 10:59:33 pageStore: freeUnused 424
03-19 10:59:33 pageStore: freeUnused 425
03-19 10:59:33 pageStore: freeUnused 426
03-19 10:59:33 pageStore: freeUnused 427
03-19 10:59:33 pageStore: freeUnused 428
03-19 10:59:33 pageStore: freeUnused 429
03-19 10:59:33 pageStore: freeUnused 430
03-19 10:59:33 pageStore: freeUnused 431
03-19 10:59:33 pageStore: freeUnused 432
03-19 10:59:33 pageStore: freeUnused 433
03-19 10:59:33 pageStore: freeUnused 434
03-19 10:59:33 pageStore: freeUnused 435
03-19 10:59:33 pageStore: freeUnused 436
03-19 10:59:33 pageStore: freeUnused 437
03-19 10:59:33 pageStore: freeUnused 438
03-19 10:59:33 pageStore: freeUnused 439
03-19 10:59:33 pageStore: freeUnused 440
03-19 10:59:33 pageStore: freeUnused 441
03-19 10:59:33 pageStore: freeUnused 442
03-19 10:59:33 pageStore: freeUnused 443
03-19 10:59:33 pageStore: freeUnused 444
03-19 10:59:33 pageStore: freeUnused 445
03-19 10:59:33 pageStore: freeUnused 446
03-19 10:59:33 pageStore: freeUnused 447
03-19 10:59:33 pageStore: freeUnused 448
03-19 10:59:33 pageStore: freeUnused 449
03-19 10:59:33 pageStore: freeUnused 450
03-19 10:59:33 pageStore: freeUnused 451
03-19 10:59:33 pageStore: freeUnused 452
03-19 10:59:33 pageStore: freeUnused 453
03-19 10:59:33 pageStore: freeUnused 454
03-19 10:59:33 pageStore: freeUnused 455
03-19 10:59:33 pageStore: freeUnused 456
03-19 10:59:33 pageStore: freeUnused 457
03-19 10:59:33 pageStore: freeUnused 458
03-19 10:59:33 pageStore: freeUnused 459
03-19 10:59:33 pageStore: freeUnused 460
03-19 10:59:33 pageStore: freeUnused 461
03-19 10:59:33 pageStore: freeUnused 462
03-19 10:59:33 pageStore: freeUnused 463
03-19 10:59:33 pageStore: freeUnused 464
03-19 10:59:33 pageStore: freeUnused 465
03-19 10:59:33 pageStore: freeUnused 466
03-19 10:59:33 pageStore: freeUnused 467
03-19 10:59:33 pageStore: freeUnused 468
03-19 10:59:33 pageStore: freeUnused 469
03-19 10:59:33 pageStore: freeUnused 470
03-19 10:59:33 pageStore: freeUnused 471
03-19 10:59:33 pageStore: freeUnused 472
03-19 10:59:33 pageStore: freeUnused 473
03-19 10:59:33 pageStore: freeUnused 474
03-19 10:59:33 pageStore: freeUnused 475
03-19 10:59:33 pageStore: freeUnused 476
03-19 10:59:33 pageStore: freeUnused 477
03-19 10:59:33 pageStore: freeUnused 478
03-19 10:59:33 pageStore: freeUnused 479
03-19 10:59:33 pageStore: freeUnused 480
03-19 10:59:33 pageStore: freeUnused 481
03-19 10:59:33 pageStore: freeUnused 482
03-19 10:59:33 pageStore: freeUnused 483
03-19 10:59:33 pageStore: freeUnused 484
03-19 10:59:33 pageStore: freeUnused 485
03-19 10:59:33 pageStore: freeUnused 486
03-19 10:59:33 pageStore: freeUnused 487
03-19 10:59:33 pageStore: freeUnused 488
03-19 10:59:33 pageStore: freeUnused 489
03-19 10:59:33 pageStore: freeUnused 490
03-19 10:59:33 pageStore: freeUnused 491
03-19 10:59:33 pageStore: freeUnused 492
03-19 10:59:33 pageStore: freeUnused 493
03-19 10:59:33 pageStore: freeUnused 494
03-19 10:59:33 pageStore: freeUnused 495
03-19 10:59:33 pageStore: freeUnused 496
03-19 10:59:33 pageStore: freeUnused 497
03-19 10:59:33 pageStore: freeUnused 498
03-19 10:59:33 pageStore: freeUnused 499
03-19 10:59:33 pageStore: freeUnused 500
03-19 10:59:33 pageStore: freeUnused 501
03-19 10:59:33 pageStore: freeUnused 502
03-19 10:59:33 pageStore: freeUnused 503
03-19 10:59:33 pageStore: freeUnused 504
03-19 10:59:33 pageStore: freeUnused 505
03-19 10:59:33 pageStore: freeUnused 506
03-19 10:59:33 pageStore: freeUnused 507
03-19 10:59:33 pageStore: freeUnused 508
03-19 10:59:33 pageStore: freeUnused 509
03-19 10:59:33 pageStore: freeUnused 510
03-19 10:59:33 pageStore: freeUnused 511
03-19 10:59:33 pageStore: freeUnused 512
03-19 10:59:33 pageStore: log openForWriting firstPage: 521
03-19 10:59:33 pageStore: setLogFirstPage key: 2 trunk: 521 data: 522
03-19 10:59:33 pageStore: writeVariableHeader
03-19 10:59:33 pageStore: pageOut.storePage [522] stream data key:2 pos:12 
remaining:2036
03-19 10:59:33 pageStore: pageOut.storePage fill 522
03-19 10:59:33 pageStore: move 520 to 5
03-19 10:59:33 pageStore: log undo 520
03-19 10:59:33 pageStore: log undo 5
03-19 10:59:33 pageStore: pageOut.storePage [523] stream data key:2 pos:2048 
remaining:0
03-19 10:59:33 pageStore: updateRecord page[5] data leaf table:10 LOB_DATA 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: log undo 3
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:11 */ 10, 0, 10, 520, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: log undo 4
03-19 10:59:33 pageStore: updateRecord page[4] data leaf table:-1 PAGE_INDEX 
entries:8 parent:0 keys:[1, 3, 4, 6, 7, 8, 10, 12, 12, 0] offsets:[2020, 1994, 
1973, 1951, 1921, 1897, 1873, 1852, 1826, 0]
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:11 */ 10, 0, 10, 
520, 'OFF,0,,,false', '0,1,2')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:11 */ 10, 0, 10, 5, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:11 */ 10, 0, 10, 
5, 'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: move 519 to 6
03-19 10:59:33 pageStore: log undo 6
03-19 10:59:33 pageStore: log undo 519
03-19 10:59:33 pageStore: updateRecord page[6] b-tree leaf table:9 entries:0
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:10 */ 9, 1, 6, 519, 
'OFF,0,,,false', '4,0')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:10 */ 9, 1, 6, 
519, 'OFF,0,,,false', '4,0')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:10 */ 9, 1, 6, 6, 
'OFF,0,,,false', '4,0')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:10 */ 9, 1, 6, 6, 
'OFF,0,,,false', '4,0')
03-19 10:59:33 pageStore: move 518 to 7
03-19 10:59:33 pageStore: log undo 7
03-19 10:59:33 pageStore: log undo 518
03-19 10:59:33 pageStore: updateRecord page[7] b-tree leaf table:7 entries:0
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:8 */ 7, 1, 6, 518, 
'OFF,0,,,false', '0,1')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:8 */ 7, 1, 6, 518, 
'OFF,0,,,false', '0,1')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:8 */ 7, 1, 6, 7, 
'OFF,0,,,false', '0,1')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:8 */ 7, 1, 6, 7, 
'OFF,0,,,false', '0,1')
03-19 10:59:33 pageStore: move 517 to 8
03-19 10:59:33 pageStore: log undo 517
03-19 10:59:33 pageStore: log undo 8
03-19 10:59:33 pageStore: updateRecord page[8] data leaf table:6 LOB_MAP 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:7 */ 6, 0, 6, 517, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:7 */ 6, 0, 6, 517, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:7 */ 6, 0, 6, 8, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:7 */ 6, 0, 6, 8, 
'OFF,0,,,false', '0,1,2,3,4')
03-19 10:59:33 pageStore: move 516 to 9
03-19 10:59:33 pageStore: log undo 9
03-19 10:59:33 pageStore: log undo 516
03-19 10:59:33 pageStore: updateRecord page[9] b-tree leaf table:5 entries:0
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:6 */ 5, 1, 2, 516, 
'OFF,0,,,false', '2')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:6 */ 5, 1, 2, 516, 
'OFF,0,,,false', '2')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:6 */ 5, 1, 2, 9, 
'OFF,0,,,false', '2')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:6 */ 5, 1, 2, 9, 
'OFF,0,,,false', '2')
03-19 10:59:33 pageStore: move 515 to 10
03-19 10:59:33 pageStore: log undo 515
03-19 10:59:33 pageStore: log undo 10
03-19 10:59:33 pageStore: updateRecord page[10] data leaf table:2 LOBS 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:3 */ 2, 0, 2, 515, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:3 */ 2, 0, 2, 515, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:3 */ 2, 0, 2, 10, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:3 */ 2, 0, 2, 10, 
'OFF,0,,,false', '0,1,2')
03-19 10:59:33 pageStore: move 514 to 11
03-19 10:59:33 pageStore: log undo 514
03-19 10:59:33 pageStore: pageOut.storePage [524] stream data key:2 pos:2048 
remaining:0
03-19 10:59:33 pageStore: log undo 11
03-19 10:59:33 pageStore: updateRecord page[11] data leaf table:0 SYS 
entries:17 parent:0 keys:[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 
16, 17, 0, 0, 0] offsets:[2024, 1890, 1789, 1632, 1532, 1362, 1252, 1086, 971, 
831, 723, 559, 423, 399, 380, 346, 321, 0, 0, 0]
03-19 10:59:33 index: PAGE_INDEX_DATA remove ( /* key:1 */ 0, 0, 0, 514, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:33 pageStore: log - s: 0 table: -1 row: ( /* key:1 */ 0, 0, 0, 514, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:33 index: PAGE_INDEX_DATA add ( /* key:1 */ 0, 0, 0, 11, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:33 pageStore: log + s: 0 table: -1 row: ( /* key:1 */ 0, 0, 0, 11, 
'OFF,0,,,false', '0,1,2,3')
03-19 10:59:33 pageStore: checkpoint
03-19 10:59:33 pageStore: pageOut.storePage [525] stream data key:2 pos:774 
remaining:1274
03-19 10:59:33 pageStore: pageOut.storePage fill 525
03-19 10:59:33 pageStore: writeBack page [3] freeList
03-19 10:59:33 pageStore: writeBack page[4] data leaf table:-1 PAGE_INDEX 
entries:9 parent:0 keys:[1, 3, 4, 6, 7, 8, 10, 11, 12, 0] offsets:[2022, 1998, 
1977, 1957, 1929, 1907, 1885, 1861, 1840, 0]
03-19 10:59:33 pageStore: writeBack page[5] data leaf table:10 LOB_DATA 
entries:0 parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: writeBack page[6] b-tree leaf table:9 entries:0
03-19 10:59:33 pageStore: writeBack page[7] b-tree leaf table:7 entries:0
03-19 10:59:33 pageStore: writeBack page[8] data leaf table:6 LOB_MAP entries:0 
parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: writeBack page[9] b-tree leaf table:5 entries:0
03-19 10:59:33 pageStore: writeBack page[10] data leaf table:2 LOBS entries:0 
parent:0 keys:null offsets:null
03-19 10:59:33 pageStore: writeBack page[11] data leaf table:0 SYS entries:17 
parent:0 keys:[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 0, 0, 
0] offsets:[2024, 1890, 1789, 1632, 1532, 1362, 1252, 1086, 971, 831, 723, 559, 
423, 399, 380, 346, 321, 0, 0, 0]
03-19 10:59:33 pageStore: getFirstUncommittedSection
03-19 10:59:33 pageStore: log.removeUntil 521 526
03-19 10:59:33 pageStore: setLogFirstPage key: 2 trunk: 521 data: 526
03-19 10:59:33 pageStore: writeVariableHeader
03-19 10:59:33 pageStore: pageOut.storePage [526] stream data key:2 pos:12 
remaining:2036
03-19 10:59:33 pageStore: pageOut.storePage fill 526
03-19 10:59:33 pageStore: writeFree
03-19 10:59:33 pageStore: free 513
03-19 10:59:33 pageStore: free 514
03-19 10:59:33 pageStore: free 515
03-19 10:59:33 pageStore: free 516
03-19 10:59:33 pageStore: free 517
03-19 10:59:33 pageStore: free 518
03-19 10:59:33 pageStore: free 519
03-19 10:59:33 pageStore: free 520
03-19 10:59:33 pageStore: pageOut.storePage [527] stream data key:2 pos:12 
remaining:2036
03-19 10:59:33 pageStore: pageOut.storePage fill 527
03-19 10:59:33 pageStore: pageOut.storePage [528] stream data key:2 pos:12 
remaining:2036
03-19 10:59:33 pageStore: pageOut.storePage fill 528
03-19 10:59:33 pageStore: log commit s: 0
03-19 10:59:33 pageStore: pageOut.storePage [529] stream data key:2 pos:14 
remaining:2034
03-19 10:59:33 pageStore: pageOut.storePage fill 529
03-19 10:59:33 pageStore: log free
03-19 10:59:33 pageStore: updateRecord page [3] freeList
03-19 10:59:33 pageStore: freeUnused 531
03-19 10:59:33 pageStore: freeUnused 532
03-19 10:59:33 pageStore: freeUnused 533
03-19 10:59:33 pageStore: freeUnused 534
03-19 10:59:33 pageStore: freeUnused 535
03-19 10:59:33 pageStore: freeUnused 536
03-19 10:59:33 pageStore: freeUnused 537
03-19 10:59:33 pageStore: freeUnused 538
03-19 10:59:33 pageStore: freeUnused 539
03-19 10:59:33 pageStore: freeUnused 540
03-19 10:59:33 pageStore: freeUnused 541
03-19 10:59:33 pageStore: freeUnused 542
03-19 10:59:33 pageStore: freeUnused 543
03-19 10:59:33 pageStore: freeUnused 544
03-19 10:59:33 pageStore: freeUnused 545
03-19 10:59:33 pageStore: freeUnused 546
03-19 10:59:33 pageStore: freeUnused 547
03-19 10:59:33 pageStore: freeUnused 548
03-19 10:59:33 pageStore: freeUnused 549
03-19 10:59:33 pageStore: freeUnused 550
03-19 10:59:33 pageStore: freeUnused 551
03-19 10:59:33 pageStore: freeUnused 552
03-19 10:59:33 pageStore: freeUnused 553
03-19 10:59:33 pageStore: freeUnused 554
03-19 10:59:33 pageStore: freeUnused 555
03-19 10:59:33 pageStore: freeUnused 556
03-19 10:59:33 pageStore: freeUnused 557
03-19 10:59:33 pageStore: freeUnused 558
03-19 10:59:33 pageStore: freeUnused 559
03-19 10:59:33 pageStore: freeUnused 560
03-19 10:59:33 pageStore: freeUnused 561
03-19 10:59:33 pageStore: freeUnused 562
03-19 10:59:33 pageStore: freeUnused 563
03-19 10:59:33 pageStore: freeUnused 564
03-19 10:59:33 pageStore: freeUnused 565
03-19 10:59:33 pageStore: freeUnused 566
03-19 10:59:33 pageStore: freeUnused 567
03-19 10:59:33 pageStore: freeUnused 568
03-19 10:59:33 pageStore: freeUnused 569
03-19 10:59:33 pageStore: freeUnused 570
03-19 10:59:33 pageStore: freeUnused 571
03-19 10:59:33 pageStore: freeUnused 572
03-19 10:59:33 pageStore: freeUnused 573
03-19 10:59:33 pageStore: freeUnused 574
03-19 10:59:33 pageStore: freeUnused 575
03-19 10:59:33 pageStore: freeUnused 576
03-19 10:59:33 pageStore: freeUnused 577
03-19 10:59:33 pageStore: freeUnused 578
03-19 10:59:33 pageStore: freeUnused 579
03-19 10:59:33 pageStore: freeUnused 580
03-19 10:59:33 pageStore: freeUnused 581
03-19 10:59:33 pageStore: freeUnused 582
03-19 10:59:33 pageStore: freeUnused 583
03-19 10:59:33 pageStore: freeUnused 584
03-19 10:59:33 pageStore: freeUnused 585
03-19 10:59:33 pageStore: freeUnused 586
03-19 10:59:33 pageStore: freeUnused 587
03-19 10:59:33 pageStore: freeUnused 588
03-19 10:59:33 pageStore: freeUnused 589
03-19 10:59:33 pageStore: freeUnused 590
03-19 10:59:33 pageStore: freeUnused 591
03-19 10:59:33 pageStore: freeUnused 592
03-19 10:59:33 pageStore: freeUnused 593
03-19 10:59:33 pageStore: freeUnused 594
03-19 10:59:33 pageStore: freeUnused 595
03-19 10:59:33 pageStore: freeUnused 596
03-19 10:59:33 pageStore: freeUnused 597
03-19 10:59:33 pageStore: freeUnused 598
03-19 10:59:33 pageStore: freeUnused 599
03-19 10:59:33 pageStore: freeUnused 600
03-19 10:59:33 pageStore: freeUnused 601
03-19 10:59:33 pageStore: freeUnused 602
03-19 10:59:33 pageStore: freeUnused 603
03-19 10:59:33 pageStore: freeUnused 604
03-19 10:59:33 pageStore: freeUnused 605
03-19 10:59:33 pageStore: freeUnused 606
03-19 10:59:33 pageStore: freeUnused 607
03-19 10:59:33 pageStore: freeUnused 608
03-19 10:59:33 pageStore: freeUnused 609
03-19 10:59:33 pageStore: freeUnused 610
03-19 10:59:33 pageStore: freeUnused 611
03-19 10:59:33 pageStore: freeUnused 612
03-19 10:59:33 pageStore: freeUnused 613
03-19 10:59:33 pageStore: freeUnused 614
03-19 10:59:33 pageStore: freeUnused 615
03-19 10:59:33 pageStore: freeUnused 616
03-19 10:59:33 pageStore: freeUnused 617
03-19 10:59:33 pageStore: freeUnused 618
03-19 10:59:33 pageStore: freeUnused 619
03-19 10:59:33 pageStore: freeUnused 620
03-19 10:59:33 pageStore: freeUnused 621
03-19 10:59:33 pageStore: freeUnused 622
03-19 10:59:33 pageStore: freeUnused 623
03-19 10:59:33 pageStore: freeUnused 624
03-19 10:59:33 pageStore: freeUnused 625
03-19 10:59:33 pageStore: freeUnused 626
03-19 10:59:33 pageStore: freeUnused 627
03-19 10:59:33 pageStore: freeUnused 628
03-19 10:59:33 pageStore: freeUnused 629
03-19 10:59:33 pageStore: freeUnused 630
03-19 10:59:33 pageStore: freeUnused 631
03-19 10:59:33 pageStore: freeUnused 632
03-19 10:59:33 pageStore: freeUnused 633
03-19 10:59:33 pageStore: freeUnused 634
03-19 10:59:33 pageStore: freeUnused 635
03-19 10:59:33 pageStore: freeUnused 636
03-19 10:59:33 pageStore: freeUnused 637
03-19 10:59:33 pageStore: freeUnused 638
03-19 10:59:33 pageStore: freeUnused 639
03-19 10:59:33 pageStore: freeUnused 640
03-19 10:59:33 pageStore: freeUnused 641
03-19 10:59:33 pageStore: freeUnused 642
03-19 10:59:33 pageStore: freeUnused 643
03-19 10:59:33 pageStore: freeUnused 644
03-19 10:59:33 pageStore: freeUnused 645
03-19 10:59:33 pageStore: freeUnused 646
03-19 10:59:33 pageStore: freeUnused 647
03-19 10:59:33 pageStore: freeUnused 648
03-19 10:59:33 pageStore: freeUnused 649
03-19 10:59:33 pageStore: freeUnused 650
03-19 10:59:33 pageStore: freeUnused 651
03-19 10:59:33 pageStore: freeUnused 652
03-19 10:59:33 pageStore: freeUnused 653
03-19 10:59:33 pageStore: freeUnused 654
03-19 10:59:33 pageStore: freeUnused 655
03-19 10:59:33 pageStore: freeUnused 656
03-19 10:59:33 pageStore: freeUnused 657
03-19 10:59:33 pageStore: freeUnused 658
03-19 10:59:33 pageStore: freeUnused 659
03-19 10:59:33 pageStore: freeUnused 660
03-19 10:59:33 pageStore: freeUnused 661
03-19 10:59:33 pageStore: freeUnused 662
03-19 10:59:33 pageStore: freeUnused 663
03-19 10:59:33 pageStore: freeUnused 664
03-19 10:59:33 pageStore: freeUnused 665
03-19 10:59:33 pageStore: freeUnused 666
03-19 10:59:33 pageStore: freeUnused 667
03-19 10:59:33 pageStore: freeUnused 668
03-19 10:59:33 pageStore: freeUnused 669
03-19 10:59:33 pageStore: freeUnused 670
03-19 10:59:33 pageStore: freeUnused 671
03-19 10:59:33 pageStore: freeUnused 672
03-19 10:59:33 pageStore: freeUnused 673
03-19 10:59:33 pageStore: freeUnused 674
03-19 10:59:33 pageStore: freeUnused 675
03-19 10:59:33 pageStore: freeUnused 676
03-19 10:59:33 pageStore: freeUnused 677
03-19 10:59:33 pageStore: freeUnused 678
03-19 10:59:33 pageStore: freeUnused 679
03-19 10:59:33 pageStore: freeUnused 680
03-19 10:59:33 pageStore: freeUnused 681
03-19 10:59:33 pageStore: freeUnused 682
03-19 10:59:33 pageStore: freeUnused 683
03-19 10:59:33 pageStore: freeUnused 684
03-19 10:59:33 pageStore: freeUnused 685
03-19 10:59:33 pageStore: freeUnused 686
03-19 10:59:33 pageStore: freeUnused 687
03-19 10:59:33 pageStore: freeUnused 688
03-19 10:59:33 pageStore: freeUnused 689
03-19 10:59:33 pageStore: freeUnused 690
03-19 10:59:33 pageStore: freeUnused 691
03-19 10:59:33 pageStore: freeUnused 692
03-19 10:59:33 pageStore: freeUnused 693
03-19 10:59:33 pageStore: freeUnused 694
03-19 10:59:33 pageStore: freeUnused 695
03-19 10:59:33 pageStore: freeUnused 696
03-19 10:59:33 pageStore: freeUnused 697
03-19 10:59:33 pageStore: freeUnused 698
03-19 10:59:33 pageStore: freeUnused 699
03-19 10:59:33 pageStore: freeUnused 700
03-19 10:59:33 pageStore: freeUnused 701
03-19 10:59:33 pageStore: freeUnused 702
03-19 10:59:33 pageStore: freeUnused 703
03-19 10:59:33 pageStore: freeUnused 704
03-19 10:59:33 pageStore: freeUnused 705
03-19 10:59:33 pageStore: freeUnused 706
03-19 10:59:33 pageStore: freeUnused 707
03-19 10:59:33 pageStore: freeUnused 708
03-19 10:59:33 pageStore: freeUnused 709
03-19 10:59:33 pageStore: freeUnused 710
03-19 10:59:33 pageStore: freeUnused 711
03-19 10:59:33 pageStore: freeUnused 712
03-19 10:59:33 pageStore: freeUnused 713
03-19 10:59:33 pageStore: freeUnused 714
03-19 10:59:33 pageStore: freeUnused 715
03-19 10:59:33 pageStore: freeUnused 716
03-19 10:59:33 pageStore: freeUnused 717
03-19 10:59:33 pageStore: freeUnused 718
03-19 10:59:33 pageStore: freeUnused 719
03-19 10:59:33 pageStore: freeUnused 720
03-19 10:59:33 pageStore: freeUnused 721
03-19 10:59:33 pageStore: freeUnused 722
03-19 10:59:33 pageStore: freeUnused 723
03-19 10:59:33 pageStore: freeUnused 724
03-19 10:59:33 pageStore: freeUnused 725
03-19 10:59:33 pageStore: freeUnused 726
03-19 10:59:33 pageStore: freeUnused 727
03-19 10:59:33 pageStore: freeUnused 728
03-19 10:59:33 pageStore: freeUnused 729
03-19 10:59:33 pageStore: freeUnused 730
03-19 10:59:33 pageStore: freeUnused 731
03-19 10:59:33 pageStore: freeUnused 732
03-19 10:59:33 pageStore: freeUnused 733
03-19 10:59:33 pageStore: freeUnused 734
03-19 10:59:33 pageStore: freeUnused 735
03-19 10:59:33 pageStore: freeUnused 736
03-19 10:59:33 pageStore: freeUnused 737
03-19 10:59:33 pageStore: freeUnused 738
03-19 10:59:33 pageStore: freeUnused 739
03-19 10:59:33 pageStore: freeUnused 740
03-19 10:59:33 pageStore: freeUnused 741
03-19 10:59:33 pageStore: freeUnused 742
03-19 10:59:33 pageStore: freeUnused 743
03-19 10:59:33 pageStore: freeUnused 744
03-19 10:59:33 pageStore: freeUnused 745
03-19 10:59:33 pageStore: freeUnused 746
03-19 10:59:33 pageStore: freeUnused 747
03-19 10:59:33 pageStore: freeUnused 748
03-19 10:59:33 pageStore: freeUnused 749
03-19 10:59:33 pageStore: freeUnused 750
03-19 10:59:33 pageStore: freeUnused 751
03-19 10:59:33 pageStore: freeUnused 752
03-19 10:59:33 pageStore: freeUnused 753
03-19 10:59:33 pageStore: freeUnused 754
03-19 10:59:33 pageStore: freeUnused 755
03-19 10:59:33 pageStore: freeUnused 756
03-19 10:59:33 pageStore: freeUnused 757
03-19 10:59:33 pageStore: freeUnused 758
03-19 10:59:33 pageStore: freeUnused 759
03-19 10:59:33 pageStore: freeUnused 760
03-19 10:59:33 pageStore: freeUnused 761
03-19 10:59:33 pageStore: freeUnused 762
03-19 10:59:33 pageStore: freeUnused 763
03-19 10:59:33 pageStore: freeUnused 764
03-19 10:59:33 pageStore: freeUnused 765
03-19 10:59:33 pageStore: freeUnused 766
03-19 10:59:33 pageStore: freeUnused 767
03-19 10:59:33 pageStore: freeUnused 768
03-19 10:59:33 pageStore: freeUnused 769
03-19 10:59:33 pageStore: freeUnused 770
03-19 10:59:33 pageStore: freeUnused 771
03-19 10:59:33 pageStore: freeUnused 772
03-19 10:59:33 pageStore: freeUnused 773
03-19 10:59:33 pageStore: freeUnused 774
03-19 10:59:33 pageStore: freeUnused 775
03-19 10:59:33 pageStore: freeUnused 776
03-19 10:59:33 pageStore: freeUnused 777
03-19 10:59:33 pageStore: freeUnused 778
03-19 10:59:33 pageStore: freeUnused 779
03-19 10:59:33 pageStore: freeUnused 780
03-19 10:59:33 pageStore: freeUnused 781
03-19 10:59:33 pageStore: freeUnused 782
03-19 10:59:33 pageStore: freeUnused 783
03-19 10:59:33 pageStore: freeUnused 784
03-19 10:59:33 pageStore: freeUnused 785
03-19 10:59:33 pageStore: freeUnused 786
03-19 10:59:33 pageStore: freeUnused 787
03-19 10:59:33 pageStore: freeUnused 788
03-19 10:59:33 pageStore: freeUnused 789
03-19 10:59:33 pageStore: freeUnused 790
03-19 10:59:33 pageStore: freeUnused 791
03-19 10:59:33 pageStore: freeUnused 792
03-19 10:59:33 pageStore: freeUnused 793
03-19 10:59:33 pageStore: freeUnused 794
03-19 10:59:33 pageStore: freeUnused 795
03-19 10:59:33 pageStore: freeUnused 796
03-19 10:59:33 pageStore: freeUnused 797
03-19 10:59:33 pageStore: freeUnused 798
03-19 10:59:33 pageStore: freeUnused 799
03-19 10:59:33 pageStore: freeUnused 800
03-19 10:59:33 pageStore: freeUnused 801
03-19 10:59:33 pageStore: freeUnused 802
03-19 10:59:33 pageStore: freeUnused 803
03-19 10:59:33 pageStore: freeUnused 804
03-19 10:59:33 pageStore: freeUnused 805
03-19 10:59:33 pageStore: freeUnused 806
03-19 10:59:33 pageStore: freeUnused 807
03-19 10:59:33 pageStore: freeUnused 808
03-19 10:59:33 pageStore: freeUnused 809
03-19 10:59:33 pageStore: freeUnused 810
03-19 10:59:33 pageStore: freeUnused 811
03-19 10:59:33 pageStore: freeUnused 812
03-19 10:59:33 pageStore: freeUnused 813
03-19 10:59:33 pageStore: freeUnused 814
03-19 10:59:33 pageStore: freeUnused 815
03-19 10:59:33 pageStore: freeUnused 816
03-19 10:59:33 pageStore: freeUnused 817
03-19 10:59:33 pageStore: freeUnused 818
03-19 10:59:33 pageStore: freeUnused 819
03-19 10:59:33 pageStore: freeUnused 820
03-19 10:59:33 pageStore: freeUnused 821
03-19 10:59:33 pageStore: freeUnused 822
03-19 10:59:33 pageStore: freeUnused 823
03-19 10:59:33 pageStore: freeUnused 824
03-19 10:59:33 pageStore: freeUnused 825
03-19 10:59:33 pageStore: freeUnused 826
03-19 10:59:33 pageStore: freeUnused 827
03-19 10:59:33 pageStore: freeUnused 828
03-19 10:59:33 pageStore: freeUnused 829
03-19 10:59:33 pageStore: freeUnused 830
03-19 10:59:33 pageStore: freeUnused 831
03-19 10:59:33 pageStore: freeUnused 832
03-19 10:59:33 pageStore: freeUnused 833
03-19 10:59:33 pageStore: freeUnused 834
03-19 10:59:33 pageStore: freeUnused 835
03-19 10:59:33 pageStore: freeUnused 836
03-19 10:59:33 pageStore: freeUnused 837
03-19 10:59:33 pageStore: freeUnused 838
03-19 10:59:33 pageStore: freeUnused 839
03-19 10:59:33 pageStore: freeUnused 840
03-19 10:59:33 pageStore: freeUnused 841
03-19 10:59:33 pageStore: freeUnused 842
03-19 10:59:33 pageStore: freeUnused 843
03-19 10:59:33 pageStore: freeUnused 844
03-19 10:59:33 pageStore: freeUnused 845
03-19 10:59:33 pageStore: freeUnused 846
03-19 10:59:33 pageStore: freeUnused 847
03-19 10:59:33 pageStore: freeUnused 848
03-19 10:59:33 pageStore: freeUnused 849
03-19 10:59:33 pageStore: freeUnused 850
03-19 10:59:33 pageStore: freeUnused 851
03-19 10:59:33 pageStore: freeUnused 852
03-19 10:59:33 pageStore: freeUnused 853
03-19 10:59:33 pageStore: freeUnused 854
03-19 10:59:33 pageStore: freeUnused 855
03-19 10:59:33 pageStore: freeUnused 856
03-19 10:59:33 pageStore: freeUnused 857
03-19 10:59:33 pageStore: freeUnused 858
03-19 10:59:33 pageStore: freeUnused 859
03-19 10:59:33 pageStore: freeUnused 860
03-19 10:59:33 pageStore: freeUnused 861
03-19 10:59:33 pageStore: freeUnused 862
03-19 10:59:33 pageStore: freeUnused 863
03-19 10:59:33 pageStore: freeUnused 864
03-19 10:59:33 pageStore: freeUnused 865
03-19 10:59:33 pageStore: freeUnused 866
03-19 10:59:33 pageStore: freeUnused 867
03-19 10:59:33 pageStore: freeUnused 868
03-19 10:59:33 pageStore: freeUnused 869
03-19 10:59:33 pageStore: freeUnused 870
03-19 10:59:33 pageStore: freeUnused 871
03-19 10:59:33 pageStore: freeUnused 872
03-19 10:59:33 pageStore: freeUnused 873
03-19 10:59:33 pageStore: freeUnused 874
03-19 10:59:33 pageStore: freeUnused 875
03-19 10:59:33 pageStore: freeUnused 876
03-19 10:59:33 pageStore: freeUnused 877
03-19 10:59:33 pageStore: freeUnused 878
03-19 10:59:33 pageStore: freeUnused 879
03-19 10:59:33 pageStore: freeUnused 880
03-19 10:59:33 pageStore: freeUnused 881
03-19 10:59:33 pageStore: freeUnused 882
03-19 10:59:33 pageStore: freeUnused 883
03-19 10:59:33 pageStore: freeUnused 884
03-19 10:59:33 pageStore: freeUnused 885
03-19 10:59:33 pageStore: freeUnused 886
03-19 10:59:33 pageStore: freeUnused 887
03-19 10:59:33 pageStore: freeUnused 888
03-19 10:59:33 pageStore: freeUnused 889
03-19 10:59:33 pageStore: freeUnused 890
03-19 10:59:33 pageStore: freeUnused 891
03-19 10:59:33 pageStore: freeUnused 892
03-19 10:59:33 pageStore: freeUnused 893
03-19 10:59:33 pageStore: freeUnused 894
03-19 10:59:33 pageStore: freeUnused 895
03-19 10:59:33 pageStore: freeUnused 896
03-19 10:59:33 pageStore: freeUnused 897
03-19 10:59:33 pageStore: freeUnused 898
03-19 10:59:33 pageStore: freeUnused 899
03-19 10:59:33 pageStore: freeUnused 900
03-19 10:59:33 pageStore: freeUnused 901
03-19 10:59:33 pageStore: freeUnused 902
03-19 10:59:33 pageStore: freeUnused 903
03-19 10:59:33 pageStore: freeUnused 904
03-19 10:59:33 pageStore: freeUnused 905
03-19 10:59:33 pageStore: freeUnused 906
03-19 10:59:33 pageStore: freeUnused 907
03-19 10:59:33 pageStore: freeUnused 908
03-19 10:59:33 pageStore: freeUnused 909
03-19 10:59:33 pageStore: freeUnused 910
03-19 10:59:33 pageStore: freeUnused 911
03-19 10:59:33 pageStore: freeUnused 912
03-19 10:59:33 pageStore: freeUnused 913
03-19 10:59:33 pageStore: freeUnused 914
03-19 10:59:33 pageStore: freeUnused 915
03-19 10:59:33 pageStore: freeUnused 916
03-19 10:59:33 pageStore: freeUnused 917
03-19 10:59:33 pageStore: freeUnused 918
03-19 10:59:33 pageStore: freeUnused 919
03-19 10:59:33 pageStore: freeUnused 920
03-19 10:59:33 pageStore: freeUnused 921
03-19 10:59:33 pageStore: freeUnused 922
03-19 10:59:33 pageStore: freeUnused 923
03-19 10:59:33 pageStore: freeUnused 924
03-19 10:59:33 pageStore: freeUnused 925
03-19 10:59:33 pageStore: freeUnused 926
03-19 10:59:33 pageStore: freeUnused 927
03-19 10:59:33 pageStore: freeUnused 928
03-19 10:59:33 pageStore: freeUnused 929
03-19 10:59:33 pageStore: freeUnused 930
03-19 10:59:33 pageStore: freeUnused 931
03-19 10:59:33 pageStore: freeUnused 932
03-19 10:59:33 pageStore: freeUnused 933
03-19 10:59:33 pageStore: freeUnused 934
03-19 10:59:33 pageStore: freeUnused 935
03-19 10:59:33 pageStore: freeUnused 936
03-19 10:59:33 pageStore: freeUnused 937
03-19 10:59:33 pageStore: freeUnused 938
03-19 10:59:33 pageStore: freeUnused 939
03-19 10:59:33 pageStore: freeUnused 940
03-19 10:59:33 pageStore: freeUnused 941
03-19 10:59:33 pageStore: freeUnused 942
03-19 10:59:33 pageStore: freeUnused 943
03-19 10:59:33 pageStore: freeUnused 944
03-19 10:59:33 pageStore: freeUnused 945
03-19 10:59:33 pageStore: freeUnused 946
03-19 10:59:33 pageStore: freeUnused 947
03-19 10:59:33 pageStore: freeUnused 948
03-19 10:59:33 pageStore: freeUnused 949
03-19 10:59:33 pageStore: freeUnused 950
03-19 10:59:33 pageStore: freeUnused 951
03-19 10:59:33 pageStore: freeUnused 952
03-19 10:59:33 pageStore: freeUnused 953
03-19 10:59:33 pageStore: freeUnused 954
03-19 10:59:33 pageStore: freeUnused 955
03-19 10:59:33 pageStore: freeUnused 956
03-19 10:59:33 pageStore: freeUnused 957
03-19 10:59:33 pageStore: freeUnused 958
03-19 10:59:33 pageStore: freeUnused 959
03-19 10:59:33 pageStore: freeUnused 960
03-19 10:59:33 pageStore: freeUnused 961
03-19 10:59:33 pageStore: freeUnused 962
03-19 10:59:33 pageStore: freeUnused 963
03-19 10:59:33 pageStore: freeUnused 964
03-19 10:59:33 pageStore: freeUnused 965
03-19 10:59:33 pageStore: freeUnused 966
03-19 10:59:33 pageStore: freeUnused 967
03-19 10:59:33 pageStore: freeUnused 968
03-19 10:59:33 pageStore: freeUnused 969
03-19 10:59:33 pageStore: freeUnused 970
03-19 10:59:33 pageStore: freeUnused 971
03-19 10:59:33 pageStore: freeUnused 972
03-19 10:59:33 pageStore: freeUnused 973
03-19 10:59:33 pageStore: freeUnused 974
03-19 10:59:33 pageStore: freeUnused 975
03-19 10:59:33 pageStore: freeUnused 976
03-19 10:59:33 pageStore: freeUnused 977
03-19 10:59:33 pageStore: freeUnused 978
03-19 10:59:33 pageStore: freeUnused 979
03-19 10:59:33 pageStore: freeUnused 980
03-19 10:59:33 pageStore: freeUnused 981
03-19 10:59:33 pageStore: freeUnused 982
03-19 10:59:33 pageStore: freeUnused 983
03-19 10:59:33 pageStore: freeUnused 984
03-19 10:59:33 pageStore: freeUnused 985
03-19 10:59:33 pageStore: freeUnused 986
03-19 10:59:33 pageStore: freeUnused 987
03-19 10:59:33 pageStore: freeUnused 988
03-19 10:59:33 pageStore: freeUnused 989
03-19 10:59:33 pageStore: freeUnused 990
03-19 10:59:33 pageStore: freeUnused 991
03-19 10:59:33 pageStore: freeUnused 992
03-19 10:59:33 pageStore: freeUnused 993
03-19 10:59:33 pageStore: freeUnused 994
03-19 10:59:33 pageStore: freeUnused 995
03-19 10:59:33 pageStore: freeUnused 996
03-19 10:59:33 pageStore: freeUnused 997
03-19 10:59:33 pageStore: freeUnused 998
03-19 10:59:33 pageStore: freeUnused 999
03-19 10:59:33 pageStore: freeUnused 1000
03-19 10:59:33 pageStore: freeUnused 1001
03-19 10:59:33 pageStore: freeUnused 1002
03-19 10:59:33 pageStore: freeUnused 1003
03-19 10:59:33 pageStore: freeUnused 1004
03-19 10:59:33 pageStore: freeUnused 1005
03-19 10:59:33 pageStore: freeUnused 1006
03-19 10:59:33 pageStore: freeUnused 1007
03-19 10:59:33 pageStore: freeUnused 1008
03-19 10:59:33 pageStore: freeUnused 1009
03-19 10:59:33 pageStore: freeUnused 1010
03-19 10:59:33 pageStore: freeUnused 1011
03-19 10:59:33 pageStore: freeUnused 1012
03-19 10:59:33 pageStore: freeUnused 1013
03-19 10:59:33 pageStore: freeUnused 1014
03-19 10:59:33 pageStore: freeUnused 1015
03-19 10:59:33 pageStore: freeUnused 1016
03-19 10:59:33 pageStore: freeUnused 1017
03-19 10:59:33 pageStore: freeUnused 1018
03-19 10:59:33 pageStore: freeUnused 1019
03-19 10:59:33 pageStore: freeUnused 1020
03-19 10:59:33 pageStore: freeUnused 1021
03-19 10:59:33 pageStore: freeUnused 1022
03-19 10:59:33 pageStore: freeUnused 1023
03-19 10:59:33 pageStore: freeUnused 1024
03-19 10:59:33 pageStore: freeUnused 1025
03-19 10:59:33 pageStore: freeUnused 1026
03-19 10:59:33 pageStore: freeUnused 1027
03-19 10:59:33 pageStore: freeUnused 1028
03-19 10:59:33 pageStore: setLogFirstPage key: 3 trunk: 0 data: 0
03-19 10:59:33 pageStore: writeVariableHeader
03-19 10:59:33 pageStore: writeBack page [3] freeList
03-19 10:59:33 pageStore: pageCount: 12
03-19 10:59:33 pageStore: close
03-19 10:59:33 pageStore: log close
03-19 10:59:33 fileLock: watchdog end
03-19 10:59:33 fileLock: load {method=file, 
id=14c317936d23f67c6aabe86040af1fbbf6dcf3fd544}
03-19 10:59:33 database: closed