h2 - DbVisualizer から H2 サーバーへの接続

Question

H2 データベースを次のように構成しました。

@Configuration
@Profile({ Profiles.DEV })
public class DevDataSourceConfiguration {

    @Bean(initMethod = "start", destroyMethod = "stop")
    public Server h2WebServer() throws SQLException {
        return Server.createWebServer("-web", "-webAllowOthers", "-webPort", "8082");
    }

    @Bean(initMethod = "start", destroyMethod = "stop")
    @DependsOn("h2WebServer")
    public Server h2Server() throws SQLException {
        return Server.createTcpServer("-tcp", "-tcpAllowOthers", "-tcpPort", "9092");
    }

    @Bean
    @DependsOn("h2Server")
    public DataSource datasource() {
        HikariDataSource ds = new HikariDataSource();
        ds.setDriverClassName("org.h2.Driver");
        ds.setJdbcUrl("jdbc:h2:tcp://localhost/~/bignibou");
        return ds;
    }
}

現在、次の jdbc URL を使用して DBVisualizer からデータベースにアクセスしようとしています: jdbc:h2:tcp://localhost/~/bigniboudbvis ログに次のエラーが表示されます:

2015-05-17 17:02:24.544 WARN   595 [ExecutorRunner-pool-3-thread-11 - G.ￄﾃ] Could not setAutoCommit(true) for: bignibou
org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-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.engine.SessionRemote.done(SessionRemote.java:621)
    at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
    at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
    at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
    at org.h2.engine.SessionRemote.setAutoCommitSend(SessionRemote.java:243)
    at org.h2.engine.SessionRemote.setAutoCommit(SessionRemote.java:210)
    at org.h2.jdbc.JdbcConnection.setAutoCommit(JdbcConnection.java:431)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:497)
    at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
    at com.onseven.dbvis.h.B.F$A.call(Z:2515)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
2015-05-17 17:02:24.546 INFO   595 [ExecutorRunner-pool-3-thread-11 - AbstractFacade.getCatalog] Could not getCatalog for: bignibou
org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-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.engine.SessionRemote.done(SessionRemote.java:621)
    at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
    at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
    at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
    at org.h2.jdbc.JdbcConnection.prepareCommand(JdbcConnection.java:1188)
    at org.h2.jdbc.JdbcConnection.getCatalog(JdbcConnection.java:598)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:497)
    at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
    at com.onseven.dbvis.h.B.F$A.call(Z:2515)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)

edit;trace_level_system_out=3 :接続 URLに追加した後に取得するログ出力は次のとおりです。

2015-05-26 12:25:13.601 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/Connection conn1 = DriverManager.getConnection("jdbc:h2:tcp://localhost/~/bignibou;trace_level_system_out=3", "", "");
2015-05-26 12:25:13.602 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/DatabaseMetaData dbMeta1 = conn1.getMetaData();
2015-05-26 12:25:13.602 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.setAutoCommit(true);
2015-05-26 12:25:13.602 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: SESSION_PREPARE_READ_PARAMS 0
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: exception
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush] org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-176]
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.getJdbcSQLException(DbException.java:344)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.get(DbException.java:178)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.get(DbException.java:154)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.done(SessionRemote.java:621)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.setAutoCommitSend(SessionRemote.java:243)
2015-05-26 12:25:13.603 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.setAutoCommit(SessionRemote.java:210)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.jdbc.JdbcConnection.setAutoCommit(JdbcConnection.java:431)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at java.lang.reflect.Method.invoke(Method.java:497)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at com.onseven.dbvis.h.B.F$A.call(Z:2515)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.FutureTask.run(FutureTask.java:266)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
2015-05-26 12:25:13.604 INFO   159 [pool-3-thread-8 - Q.flush]  at java.lang.Thread.run(Thread.java:745)
2015-05-26 12:25:13.604 WARN   159 [ExecutorRunner-pool-2-thread-2 - G.ￄﾃ] Could not setAutoCommit(true) for: bignibou
org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-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.engine.SessionRemote.done(SessionRemote.java:621)
    at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
    at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
    at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
    at org.h2.engine.SessionRemote.setAutoCommitSend(SessionRemote.java:243)
    at org.h2.engine.SessionRemote.setAutoCommit(SessionRemote.java:210)
    at org.h2.jdbc.JdbcConnection.setAutoCommit(JdbcConnection.java:431)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:497)
    at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
    at com.onseven.dbvis.h.B.F$A.call(Z:2515)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
2015-05-26 12:25:13.605 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.isClosed();
2015-05-26 12:25:13.605 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.getAutoCommit();
2015-05-26 12:25:13.608 INFO   159 [ExecutorRunner-pool-2-thread-2 - Q.flush] 05-26 12:25:13 jdbc: 
/**/dbMeta1.getSearchStringEscape();
2015-05-26 12:25:13.608 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.isClosed();
2015-05-26 12:25:13.608 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.getAutoCommit();
2015-05-26 12:25:13.608 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.getCatalog();
2015-05-26 12:25:13.608 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: SESSION_PREPARE_READ_PARAMS 1
2015-05-26 12:25:13.608 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: exception
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush] org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-176]
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.getJdbcSQLException(DbException.java:344)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.get(DbException.java:178)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.message.DbException.get(DbException.java:154)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.done(SessionRemote.java:621)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.jdbc.JdbcConnection.prepareCommand(JdbcConnection.java:1188)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at org.h2.jdbc.JdbcConnection.getCatalog(JdbcConnection.java:598)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at java.lang.reflect.Method.invoke(Method.java:497)
2015-05-26 12:25:13.609 INFO   159 [pool-3-thread-8 - Q.flush]  at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
2015-05-26 12:25:13.610 INFO   159 [pool-3-thread-8 - Q.flush]  at com.onseven.dbvis.h.B.F$A.call(Z:2515)
2015-05-26 12:25:13.610 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.FutureTask.run(FutureTask.java:266)
2015-05-26 12:25:13.610 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
2015-05-26 12:25:13.610 INFO   159 [pool-3-thread-8 - Q.flush]  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
2015-05-26 12:25:13.610 INFO   159 [pool-3-thread-8 - Q.flush]  at java.lang.Thread.run(Thread.java:745)
2015-05-26 12:25:13.610 INFO   159 [ExecutorRunner-pool-2-thread-2 - AbstractFacade.getCatalog] Could not getCatalog for: bignibou
org.h2.jdbc.JdbcSQLException: Connection is broken: "unexpected status 16777216" [90067-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.engine.SessionRemote.done(SessionRemote.java:621)
    at org.h2.command.CommandRemote.prepare(CommandRemote.java:69)
    at org.h2.command.CommandRemote.<init>(CommandRemote.java:46)
    at org.h2.engine.SessionRemote.prepareCommand(SessionRemote.java:476)
    at org.h2.jdbc.JdbcConnection.prepareCommand(JdbcConnection.java:1188)
    at org.h2.jdbc.JdbcConnection.getCatalog(JdbcConnection.java:598)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:497)
    at com.onseven.dbvis.h.B.C.ￄﾁ(Z:2206)
    at com.onseven.dbvis.h.B.F$A.call(Z:2515)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
2015-05-26 12:25:13.611 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.isClosed();
2015-05-26 12:25:13.611 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/conn1.getAutoCommit();
2015-05-26 12:25:13.611 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/Statement stat1 = conn1.createStatement();
2015-05-26 12:25:13.611 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: 
/**/ResultSet rs1 = stat1.executeQuery("call schema()");
2015-05-26 12:25:13.611 INFO   159 [pool-3-thread-8 - Q.flush] 05-26 12:25:13 jdbc: SESSION_PREPARE_READ_PARAMS 2

編集2：これにも気づきました（アプリケーションコンソールログで）：

05-26 12:25:13 database: connecting session #14 to /Users/julien/bignibou
05-26 12:25:13 jdbc[14]: 
/*SQL */SET TRACE_LEVEL_SYSTEM_OUT 3;
05-26 12:29:04 jdbc[13]: 
/*SQL */ROLLBACK;
05-26 12:29:04 jdbc[14]: 
/*SQL */ROLLBACK;
05-26 12:29:04 database: disconnecting session #14
05-26 12:29:04 database: disconnected session #14
05-26 12:29:04 database: disconnecting session #13
05-26 12:29:04 database: disconnected session #13

score 12 · Accepted Answer

最新の H2 安定版リリース: 1.3.176。
最新の dbVisualizer H2 ドライバー: 1.3.176。

おそらく、クライアント/サーバー通信に何らかのバグがある H2 (1.4.x) のベータリリースを使用している可能性があります (クライアントとサーバーが使用するプロトコルバージョンをネゴシエートするため、バージョンの不一致は問題になりません)。最新のベータリリースを使用してみてください。 H2 から、または H2 の最新の安定版リリースを使用します。

score 3 · Accepted Answer

DBVisualizer で使用している h2 JDBC ドライバーのバージョンを確認します。具体的には、サーバーで使用しているバージョンと一致するかどうかを確認してください。通常、バージョンが一致することは問題ではありませんが、H2 にはしばらく前に、一致しないバージョンを使用するとこの種のエラーが発生するという問題がありました。

それでも解決しない場合は、クライアントとサーバーの両方で使用している H2 のバージョンを正確に報告することもできます。

h2 - DbVisualizer から H2 サーバーへの接続

3 に答える 3

Related

Reference