Re: An I/O error occured while sending to the backend

Any chance we can see the server logs ?

do you have statement timeout set on the server ?

Dave Cramer

dave.cramer(at)credativ(dot)ca
http://www.credativ.ca

On Sat, Jun 9, 2012 at 7:25 AM, wbrana <wbrana(at)gmail(dot)com> wrote:
>        public Connection getConn(){
>                if (conn == null) {
>                        try {
>                                        Class.forName("org.postgresql.Driver"); //load the driver
>                                        conn = DriverManager.getConnection("jdbc:postgresql://localhost/forum?loglevel=1","forum","forum");
>                        } catch (Exception e) {
>                                if (debug) {
>                                        e.printStackTrace();
>                                }
>                        }
>                }
>                return conn;
>        }
>
> forum.ViewsThread.run:
>        public void run() {
>                Connection conn = new Jdbc().getConn();
>                try {
>                        conn.setAutoCommit(false);
>                        conn.prepareStatement("analyze forum_cats").executeUpdate();
>                        conn.prepareStatement("analyze forums").executeUpdate();
>                        conn.prepareStatement("analyze groups").executeUpdate();
>                        conn.prepareStatement("analyze posts").executeUpdate(); // Line 77
>                        conn.prepareStatement("analyze threads").executeUpdate();
>                        conn.prepareStatement("analyze user_groups").executeUpdate();
>                        conn.prepareStatement("analyze users").executeUpdate();
>                        conn.commit();
>
> 2012-06-09 12:43:52.654 CEST,,,2285,"",4fd328e8.8ed,1,"",2012-06-09
> 12:43:52 CEST,,0,LOG,00000,"connection received: host=127.0.0.1
> port=55770",,,,,,,,,""
> 2012-06-09 12:43:52.656
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,2,"authentication",2012-06-09
> 12:43:52 CEST,10/151,0,LOG,00000,"connection authorized: user=forum
> database=forum",,,,,,,,,""
> 2012-06-09 12:43:52.658
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,3,"SET",2012-06-09
> 12:43:52 CEST,10/152,0,LOG,00000,"execute <unnamed>: SET
> extra_float_digits = 3",,,,,,,,,""
> 2012-06-09 12:43:52.668
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,4,"BEGIN",2012-06-09
> 12:43:52 CEST,10/153,0,LOG,00000,"execute S_1: BEGIN",,,,,,,,,""
> 2012-06-09 12:43:52.668
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,5,"ANALYZE",2012-06-09
> 12:43:52 CEST,10/153,0,LOG,00000,"execute <unnamed>: analyze
> forum_cats",,,,,,,,,""
> 2012-06-09 12:43:52.670
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,6,"ANALYZE",2012-06-09
> 12:43:52 CEST,10/153,6274,LOG,00000,"execute <unnamed>: analyze
> forums",,,,,,,,,""
> 2012-06-09 12:43:52.671
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,7,"ANALYZE",2012-06-09
> 12:43:52 CEST,10/153,6274,LOG,00000,"execute <unnamed>: analyze
> groups",,,,,,,,,""
> 2012-06-09 12:43:52.671
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,8,"ANALYZE",2012-06-09
> 12:43:52 CEST,10/153,6274,LOG,00000,"execute <unnamed>: analyze
> posts",,,,,,,,,""
> 2012-06-09 12:43:52.691
> CEST,"forum","forum",2228,"127.0.0.1:55758",4fd328e4.8b4,8,"SELECT",2012-06-09
> 12:43:48 CEST,2/184,0,LOG,00000,"execute <unnamed>: SELECT forum_id,
> cat_id, cat_name, forum_description, forum_name, login, post_count,
> post_created, thread_count, thread_name FROM v_forums",,,,,,,,,""
> 2012-06-09 12:43:52.696
> CEST,"forum","forum",2228,"127.0.0.1:55758",4fd328e4.8b4,9,"SET",2012-06-09
> 12:43:48 CEST,2/185,0,LOG,00000,"execute <unnamed>: SET
> application_name = ''",,,,,,,,,""
> 2012-06-09 12:43:53.080
> CEST,"forum","forum",2285,"127.0.0.1:55770",4fd328e8.8ed,9,"idle in
> transaction",2012-06-09 12:43:52 CEST,,0,LOG,00000,"disconnection:
> session time: 0:00:00.425 user=forum database=forum host=127.0.0.1
> port=55770",,,,,,,,,""
>
> Launching GlassFish on Felix platform
> INFO: Running GlassFish Version: GlassFish Server Open Source Edition
> 3.1.2 (build 23)
> INFO: Grizzly Framework 1.9.46 started in: 33ms - bound to [0.0.0.0:8181]
> INFO: Grizzly Framework 1.9.46 started in: 29ms - bound to [0.0.0.0:4848]
> INFO: Grizzly Framework 1.9.46 started in: 47ms - bound to [0.0.0.0:8080]
> INFO: Grizzly Framework 1.9.46 started in: 22ms - bound to [0.0.0.0:3700]
> INFO: Grizzly Framework 1.9.46 started in: 15ms - bound to [0.0.0.0:7676]
> INFO: The Admin Console is already installed, but not yet loaded.
> INFO: Registered
> org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy for
> persistence-type = replicated in BackingStoreFactoryRegistry
> INFO: Created EjbThreadPoolExecutor with thread-core-pool-size 16
> thread-max-pool-size 32 thread-keep-alive-seconds 60
> thread-queue-capacity 2147483647 allow-core-thread-timeout false
> INFO: SEC1002: Security Manager is OFF.
> INFO: SEC1010: Entering Security Startup Service
> INFO: SEC1143: Loading policy provider
> com.sun.enterprise.security.provider.PolicyWrapper.
> INFO: SEC1115: Realm [admin-realm] of classtype
> [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully
> created.
> INFO: SEC1115: Realm [file] of classtype
> [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully
> created.
> INFO: SEC1115: Realm [certificate] of classtype
> [com.sun.enterprise.security.auth.realm.certificate.CertificateRealm]
> successfully created.
> INFO: SEC1115: Realm [jdbcDigestRealm] of classtype
> [com.sun.enterprise.security.auth.realm.jdbc.JDBCRealm] successfully
> created.
> INFO: SEC1011: Security Service(s) Started Successfully
> INFO: WEB0169: Created HTTP listener [http-listener-1] on host/port
> [0.0.0.0:8080]
> INFO: WEB0169: Created HTTP listener [http-listener-2] on host/port
> [0.0.0.0:8181]
> INFO: WEB0169: Created HTTP listener [admin-listener] on host/port
> [0.0.0.0:4848]
> INFO: WEB0171: Created virtual server [server]
> INFO: WEB0171: Created virtual server [__asadmin]
> INFO: WEB0172: Virtual server [server] loaded default web module []
> INFO: Hibernate Validator 4.2.0.Final
> INFO: EclipseLink, version: Eclipse Persistence Services -
> 2.3.2.v20111125-r10461
> INFO: file:/home/x/NetBeansProjects/forum/build/web/WEB-INF/classes/_forumPU
> login successful
> WARNING: Multiple [2] JMX MBeanServer instances exist, we will use the
> server at index [0] :
> [com(dot)sun(dot)enterprise(dot)v3(dot)admin(dot)DynamicInterceptor(at)1816407](dot)
> WARNING: JMX MBeanServer in use:
> [com(dot)sun(dot)enterprise(dot)v3(dot)admin(dot)DynamicInterceptor(at)1816407] from index
> [0]
> WARNING: JMX MBeanServer in use:
> [com(dot)sun(dot)jmx(dot)mbeanserver(dot)JmxMBeanServer(at)1e2a099] from index [1]
> INFO: EJB5181:Portable JNDI names for EJB ThreadsFacade:
> [java:global/forum/ThreadsFacade,
> java:global/forum/ThreadsFacade!forum.ThreadsFacade]
> INFO: EJB5181:Portable JNDI names for EJB UsersFacade:
> [java:global/forum/UsersFacade,
> java:global/forum/UsersFacade!forum.UsersFacade]
> INFO: EJB5181:Portable JNDI names for EJB ForumsPageFacade:
> [java:global/forum/ForumsPageFacade,
> java:global/forum/ForumsPageFacade!forum.ForumsPageFacade]
> INFO: EJB5181:Portable JNDI names for EJB GroupsFacade:
> [java:global/forum/GroupsFacade,
> java:global/forum/GroupsFacade!forum.GroupsFacade]
> INFO: EJB5181:Portable JNDI names for EJB VPostsFacade:
> [java:global/forum/VPostsFacade!forum.VPostsFacade,
> java:global/forum/VPostsFacade]
> INFO: EJB5181:Portable JNDI names for EJB VThreads2Facade:
> [java:global/forum/VThreads2Facade,
> java:global/forum/VThreads2Facade!forum.VThreads2Facade]
> INFO: EJB5181:Portable JNDI names for EJB VThreadsFacade:
> [java:global/forum/VThreadsFacade,
> java:global/forum/VThreadsFacade!forum.VThreadsFacade]
> INFO: EJB5181:Portable JNDI names for EJB PostsFacade:
> [java:global/forum/PostsFacade,
> java:global/forum/PostsFacade!forum.PostsFacade]
> INFO: EJB5181:Portable JNDI names for EJB ForumCatsFacade:
> [java:global/forum/ForumCatsFacade,
> java:global/forum/ForumCatsFacade!forum.ForumCatsFacade]
> INFO: EJB5181:Portable JNDI names for EJB UserGroupsFacade:
> [java:global/forum/UserGroupsFacade!forum.UserGroupsFacade,
> java:global/forum/UserGroupsFacade]
> INFO: EJB5181:Portable JNDI names for EJB VPostsFacade2:
> [java:global/forum/VPostsFacade2!forum.VPostsFacade2,
> java:global/forum/VPostsFacade2]
> INFO: EJB5181:Portable JNDI names for EJB VUserRoleFacade:
> [java:global/forum/VUserRoleFacade!forum.VUserRoleFacade,
> java:global/forum/VUserRoleFacade]
> INFO: EJB5181:Portable JNDI names for EJB AuthBackingBeanFacade:
> [java:global/forum/AuthBackingBeanFacade!forum.AuthBackingBeanFacade,
> java:global/forum/AuthBackingBeanFacade]
> INFO: WELD-000900 1.1.4 (Final)
> INFO: Initializing Mojarra 2.1.7 (SNAPSHOT 20120206) for context '/forum'
> WARNING: JSF1074: Managed bean named 'customerCRUD' has already been
> registered.  Replacing existing managed bean class type
> forum.CustomerCRUD with forum.CustomerCRUD.
> INFO: Monitoring jndi:/server/forum/WEB-INF/faces-config.xml for modifications
> INFO: WEB0671: Loading application [forum] at [/forum]
> INFO: CORE10010: Loading application forum done in 5,708 ms
> INFO: GlassFish Server Open Source Edition 3.1.2 (23) startup time :
> Felix (1,031ms), startup services(6,263ms), total(7,294ms)
> INFO: JMX005: JMXStartupService had Started JMXConnector on JMXService
> URL service:jmx:rmi://localhost:8686/jndi/rmi://localhost:8686/jmxrmi
> INFO: Initiating Jersey application, version 'Jersey: 1.11 12/09/2011 10:27 AM'
> INFO: WEB0169: Created HTTP listener [http-listener-1] on host/port
> [0.0.0.0:8080]
> INFO: Grizzly Framework 1.9.46 started in: 1ms - bound to [0.0.0.0:8080]
> INFO: 12:43:52.653 (9) PostgreSQL 9.2devel JDBC4 (build 1000)
>
> INFO: getConnection returning org.postgresql.Driver
>
> INFO: REST00001: Listening to REST requests at context: /management/domain
> INFO: The Admin Console is already installed, but not yet loaded.
> INFO: The Admin Console is starting. Please wait.
> INFO: org.postgresql.util.PSQLException: An I/O error occured while
> sending to the backend.
>
> INFO:   at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:281)
>
> INFO:   at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:553)
>
> INFO:   at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:415)
>
> INFO:   at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:361)
>
> INFO:   at forum.ViewsThread.run(ViewsThread.java:77)
>
> INFO: SQLException: SQLState(08006)
>
> SEVERE: org.postgresql.util.PSQLException: An I/O error occured while
> sending to the backend.
>        at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:281)
>        at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:553)
>        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:415)
>        at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:361)
>        at forum.ViewsThread.run(ViewsThread.java:77)
> Caused by: java.net.SocketException: Socket closed
>        at java.net.SocketInputStream.socketRead0(Native Method)
>        at java.net.SocketInputStream.read(SocketInputStream.java:150)
>        at java.net.SocketInputStream.read(SocketInputStream.java:121)
>        at org.postgresql.core.VisibleBufferedInputStream.readMore(VisibleBufferedInputStream.java:143)
>        at org.postgresql.core.VisibleBufferedInputStream.ensureBytes(VisibleBufferedInputStream.java:112)
>        at org.postgresql.core.VisibleBufferedInputStream.read(VisibleBufferedInputStream.java:71)
>        at org.postgresql.core.PGStream.ReceiveChar(PGStream.java:272)
>        at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1700)
>        at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:255)
>        ... 4 more
>
> SEVERE:         at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:281)
> SEVERE:         at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:553)
> SEVERE:         at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:415)
> SEVERE:         at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:361)
> SEVERE:         at forum.ViewsThread.run(ViewsThread.java:77)
> SEVERE: Caused by: java.net.SocketException: Socket closed
> SEVERE:         at java.net.SocketInputStream.socketRead0(Native Method)
> SEVERE:         at java.net.SocketInputStream.read(SocketInputStream.java:150)
> SEVERE:         at java.net.SocketInputStream.read(SocketInputStream.java:121)
> SEVERE:         at org.postgresql.core.VisibleBufferedInputStream.readMore(VisibleBufferedInputStream.java:143)
> SEVERE:         at org.postgresql.core.VisibleBufferedInputStream.ensureBytes(VisibleBufferedInputStream.java:112)
> SEVERE:         at org.postgresql.core.VisibleBufferedInputStream.read(VisibleBufferedInputStream.java:71)
> SEVERE:         at org.postgresql.core.PGStream.ReceiveChar(PGStream.java:272)
> SEVERE:         at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1700)
> SEVERE:         at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:255)
> SEVERE:         ... 4 more
> INFO: org.postgresql.util.PSQLException: This connection has been closed.
>
> INFO:   at org.postgresql.jdbc2.AbstractJdbc2Connection.checkClosed(AbstractJdbc2Connection.java:823)
>
> INFO:   at org.postgresql.jdbc2.AbstractJdbc2Connection.rollback(AbstractJdbc2Connection.java:840)
>
> INFO:   at forum.ViewsThread.run(ViewsThread.java:86)
>
> INFO: SQLException: SQLState(08003)
>
> SEVERE: org.postgresql.util.PSQLException: This connection has been closed.
>        at org.postgresql.jdbc2.AbstractJdbc2Connection.checkClosed(AbstractJdbc2Connection.java:823)
>        at org.postgresql.jdbc2.AbstractJdbc2Connection.rollback(AbstractJdbc2Connection.java:840)
>        at forum.ViewsThread.run(ViewsThread.java:86)
>
> SEVERE:         at org.postgresql.jdbc2.AbstractJdbc2Connection.checkClosed(AbstractJdbc2Connection.java:823)
> SEVERE:         at org.postgresql.jdbc2.AbstractJdbc2Connection.rollback(AbstractJdbc2Connection.java:840)
> SEVERE:         at forum.ViewsThread.run(ViewsThread.java:86)
>
> --
> Sent via pgsql-jdbc mailing list (pgsql-jdbc(at)postgresql(dot)org)
> To make changes to your subscription:
> http://www.postgresql.org/mailpref/pgsql-jdbc