7 Replies Latest reply: Jul 10, 2012 10:33 PM by 948641 RSS

    ... exited while connected to data store

    679822
      Hello,

      i am using
      TimesTen Release 7.0.5.0.0 (32 bit Linux/x86) (alm1:17000) 2008-04-04T00:09:04Z

      Connecting through JDBC driver (ttjdbc6-7.0.5.0.0.jar)

      i am getting the following exception:

      (Logger.java:70)2009-01-14 20:54:56,218 | ERROR | AWT-EventQueue-0 | java.sql.SQLException: [TimesTen][TimesTen 7.0.5.0.0 CLIENT]Communication link failure. System call recv() failed with OS error 10054. ECONNRESET: The connection has been broken during a network send or read operation. Probably the server exited unexpectedly.
      at com.timesten.jdbc.JdbcOdbc.createSQLException(JdbcOdbc.java:3184)
      at com.timesten.jdbc.JdbcOdbc.standardError(JdbcOdbc.java:3318)
      at com.timesten.jdbc.JdbcOdbc.standardError(JdbcOdbc.java:3283)
      at com.timesten.jdbc.JdbcOdbc.SQLPutData(JdbcOdbc.java:2248)
      at com.timesten.jdbc.JdbcOdbcPreparedStatement.processCharacterStream(JdbcOdbcPreparedStatement.java:1372)
      at com.timesten.jdbc.JdbcOdbcPreparedStatement.putParamData(JdbcOdbcPreparedStatement.java:1214)
      at com.timesten.jdbc.JdbcOdbcPreparedStatement.execute(JdbcOdbcPreparedStatement.java:367)
      at com.timesten.jdbc.JdbcOdbcPreparedStatement.executeUpdate(JdbcOdbcPreparedStatement.java:253)
      at com.mypackage.Saver.save(Saver.java:3296)

      tterrors.log on TimesTen shows at that time:

      20:47:53.67 Warn: : 25463: 27500 exited while connected to data store '/home/timesten/TimesTen/alm1/info/ECDataStore/ECData' shm 973111784 count=1

      ttmesg.log on TimesTen shows at that time:

      20:47:53.67 Info: : 25463: maind 46: socket closed, calling recovery (last cmd was 198)
      20:47:53.67 Info: : 25463: Starting daRecovery for 27500
      20:47:53.67 Info: : 25463: 27500 ------------------: process exited
      20:47:53.67 Warn: : 25463: 27500 exited while connected to data store '/home/timesten/TimesTen/alm1/info/ECDataStore/ECData' shm 973111784 count=1
      20:47:53.67 Info: : 25463: Examining /home/timesten/TimesTen/alm1/info/ECDataStore/ECData...
      20:47:53.75 Info: : 25473: hello
      20:47:53.75 Info: : 25463: Telling subdaemon 3 to evaluate /home/timesten/TimesTen/alm1/info/ECDataStore/ECData
      20:47:53.75 Info: : 25473: evaluate
      20:47:53.75 Info: : 25473: subd got #9.18, evaluate: name=/home/timesten/TimesTen/alm1/info/ECDataStore/ECData shmKey=%e8%81%00: pid=lk%00%00
      20:47:53.75 Info: : 25473: subd: evaluate '/home/timesten/TimesTen/alm1/info/ECDataStore/ECData' pid 27500
      20:47:53.76 Info: : 25473: subd: OK rc=0
      20:47:53.76 Info: : 25473: subd: done with request #9.18
      20:47:53.76 Info: : 25463: marking subdaemon #3 (pid 25473) idle
      20:47:53.76 Info: : 25463: Rolling back transactions for pid 27500
      20:47:53.86 Info: : 25467: hello
      20:47:53.86 Info: : 25467: rollback
      20:47:53.86 Info: : 25467: subd got #10.20, rollback: name=/home/timesten/TimesTen/alm1/info/ECDataStore/ECData shmKey=%e8%81%00: pid=lk%00%00
      20:47:53.86 Info: : 25467: subd: rollback pid 27500
      20:47:53.86 Info: : 25467: subd: found 1 connection belonging to pid 27500
      20:47:53.86 Info: : 25467: 27500 doRollbackWork: Calling sbOLUndoByConn for connid 2 -- java
      20:47:53.86 Info: : 25463: 25467/0xb746acc8: sbOLUndoByConn(): oplog stack for connection 2: <none>
      20:47:53.87 Info: : 25467: 27500 doRollbackWork: sbOLUndoByConn for connid 2 returned 0
      20:47:53.87 Info: : 25467: subd: OK rc=0
      20:47:53.87 Info: : 25467: subd: done with request #10.20
      20:47:53.87 Info: : 25463: Decrementing nUsers by 1 from 8 to 7, panicked=-1, trashed=-1, shmSeq=58
      20:47:53.87 Info: : 25463: Finished daRecovery for pid 27500.

      i tried the group of operations a few times, always failing at the same point, even after i dropped and re-created the relevant tables.

      Any advice please?



      Thanks and Regards,
      Edwin

      Edited by: user3355522 on 14-Jan-2009 05:16

      Edited by: user3355522 on 14-Jan-2009 05:17
        • 1. Re: ... exited while connected to data store
          Chrisjenkins-Oracle
          This looks like a bug. The TimesTen server process that is handling the client's connection has died. Please log an SR with support so they can diagnose this and raise a bug.

          Chris
          • 2. Re: ... exited while connected to data store
            679822
            Thanks Chris, shall just do that.

            In the meantime, is there any workaround or fast recovery from this (reboot machine, restart, etc)?



            Thanks and Regards,
            Edwin
            • 3. Re: ... exited while connected to data store
              Chrisjenkins-Oracle
              Unfortunately, it looks like some operation that the client is executing is causing the server to crash. You could try and pin it down to see if you can avoid that operation for the time being.

              Have you configured the TT server daemon for multi-threaded operation (i.e. set -maxConnsPerServer and -serversPerDSN in ttendaemon.options or specified the MaxConnsPerServer and ServersPerDSn attributes in the ODBC attributes)? If so, you could try increasing the server stack size by adding the ServerStackSize ODBC attribute and specify a higher value (the default is 128 [specified in Kb]). This parameter is only relevant if you are running the server in multi-threaded mode.

              Chris
              • 4. Re: ... exited while connected to data store
                679822
                hmm, it's strange...

                basically i was in the midst of executing a set of prepared statements when it happened.

                what i did is:
                1. prepare this statement
                2. set the parameters
                3. execute update
                4. clear the parameters
                5. repeat steps 2 - 4.

                there were like 10 iterations (using the same prepared statement) where it executed without problem. But on one particular iteration, it would give this error when executing update. But yet, this one was nothing special (just different values).

                i re-tried a few times, dropped the relevant tables, restarted server and daemon. But it would still always fail on that particular iteration. (and yet... when i isolated that particular statement with those particular values which failed and executed in a test programme, it would be fine...)

                Regarding multi-threaded, would it be relevant since i'm using just a single connection to the server at that time? (sorry if i understand wrongly)



                Thanks and Regards,
                Edwin
                • 5. Re: ... exited while connected to data store
                  Chrisjenkins-Oracle
                  Definitely sounds like a bug, a server stack overflow or similar. Even if you have just one connection to the server, if it is configured for multi-threaded operation then it handles connections differently and the server stack size is important.

                  Chris
                  • 6. Re: ... exited while connected to data store
                    948641
                    Hi Edwin,
                    I recently have the similar problem on timesten 11.2.2. Did you resolve it? Can you give me some suggestion of troubleshooting it ?


                    Best regards
                    Jacky
                    • 7. Re: ... exited while connected to data store
                      948641
                      Hi Edwin,
                      I recently have the similar problem on timesten 11.2.2. Did you resolve it? Can you give me some suggestion of troubleshooting it ?
                      Best regards
                      Jacky