{"action":"created","issue":{"url":"https://api.github.com/repos/thinkaurelius/titan/issues/1113","repository_url":"https://api.github.com/repos/thinkaurelius/titan","labels_url":"https://api.github.com/repos/thinkaurelius/titan/issues/1113/labels{/name}","comments_url":"https://api.github.com/repos/thinkaurelius/titan/issues/1113/comments","events_url":"https://api.github.com/repos/thinkaurelius/titan/issues/1113/events","html_url":"https://github.com/thinkaurelius/titan/issues/1113","id":90643351,"number":1113,"title":"berkeley LockTimeoutException.","user":{"login":"PommeVerte","id":1415875,"avatar_url":"https://avatars.githubusercontent.com/u/1415875?v=3","gravatar_id":"","url":"https://api.github.com/users/PommeVerte","html_url":"https://github.com/PommeVerte","followers_url":"https://api.github.com/users/PommeVerte/followers","following_url":"https://api.github.com/users/PommeVerte/following{/other_user}","gists_url":"https://api.github.com/users/PommeVerte/gists{/gist_id}","starred_url":"https://api.github.com/users/PommeVerte/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/PommeVerte/subscriptions","organizations_url":"https://api.github.com/users/PommeVerte/orgs","repos_url":"https://api.github.com/users/PommeVerte/repos","events_url":"https://api.github.com/users/PommeVerte/events{/privacy}","received_events_url":"https://api.github.com/users/PommeVerte/received_events","type":"User","site_admin":false},"labels":[],"state":"closed","locked":false,"assignee":{"login":"spmallette","id":384249,"avatar_url":"https://avatars.githubusercontent.com/u/384249?v=3","gravatar_id":"","url":"https://api.github.com/users/spmallette","html_url":"https://github.com/spmallette","followers_url":"https://api.github.com/users/spmallette/followers","following_url":"https://api.github.com/users/spmallette/following{/other_user}","gists_url":"https://api.github.com/users/spmallette/gists{/gist_id}","starred_url":"https://api.github.com/users/spmallette/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/spmallette/subscriptions","organizations_url":"https://api.github.com/users/spmallette/orgs","repos_url":"https://api.github.com/users/spmallette/repos","events_url":"https://api.github.com/users/spmallette/events{/privacy}","received_events_url":"https://api.github.com/users/spmallette/received_events","type":"User","site_admin":false},"milestone":null,"comments":37,"created_at":"2015-06-24T11:00:42Z","updated_at":"2016-03-30T10:34:38Z","closed_at":"2016-03-20T15:17:36Z","body":"Hi Guys,\r\n\r\nI'm continuing with my testing. The following works with cassandra-es but if I use **titan-berkeley-es.properties** I get the following error.\r\n\r\nI'm trying to understand which timeout this is and if it's something I need to change in the configuration or not. But I can't seem to figure it out:\r\n\r\nThe error is as follows. The app does a few things:\r\n- opens a session\r\n- executes some code (can take some time)\r\n- submits queries for the session. \r\n\r\nWe can see roughly that 1500ms pass between the session creation and script submission then the lock timeout happens. Any help would be appreciated. \r\n(this works with cassandra-es)\r\n\r\n```\r\n1220682 [gremlin-server-worker-1] INFO  org.apache.tinkerpop.gremlin.server.op.session.Session  - New session established for b150ab0a-1424-4b42-9361-d8e6bd4aabe6\r\n1220708 [gremlin-server-worker-1] INFO  org.apache.tinkerpop.gremlin.groovy.engine.ScriptEngines  - Loaded nashorn ScriptEngine\r\n1220721 [gremlin-server-worker-1] INFO  org.apache.tinkerpop.gremlin.groovy.engine.ScriptEngines  - Loaded gremlin-groovy ScriptEngine\r\n1221081 [gremlin-server-worker-1] INFO  org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor  - Initialized gremlin-groovy ScriptEngine with scripts/empty-sample.groovy\r\n1222523 [pool-98-thread-1] ERROR com.thinkaurelius.titan.graphdb.database.StandardTitanGraph  - Could not commit transaction [94] due to storage exception in commit\r\ncom.thinkaurelius.titan.core.TitanException: Could not execute operation due to backend exception\r\n\tat com.thinkaurelius.titan.diskstorage.util.BackendOperation.execute(BackendOperation.java:44)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.cache.CacheTransaction.persist(CacheTransaction.java:87)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.cache.CacheTransaction.flushInternal(CacheTransaction.java:141)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.cache.CacheTransaction.commit(CacheTransaction.java:198)\r\n\tat com.thinkaurelius.titan.diskstorage.BackendTransaction.commitStorage(BackendTransaction.java:118)\r\n\tat com.thinkaurelius.titan.graphdb.database.StandardTitanGraph.commit(StandardTitanGraph.java:717)\r\n\tat com.thinkaurelius.titan.graphdb.transaction.StandardTitanTx.commit(StandardTitanTx.java:1329)\r\n\tat com.thinkaurelius.titan.graphdb.tinkerpop.TitanBlueprintsGraph$GraphTransaction.doCommit(TitanBlueprintsGraph.java:263)\r\n\tat org.apache.tinkerpop.gremlin.structure.util.AbstractTransaction.commit(AbstractTransaction.java:94)\r\n\tat org.apache.tinkerpop.gremlin.structure.Transaction$commit$2.call(Unknown Source)\r\n\tat org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:45)\r\n\tat org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:110)\r\n\tat org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:114)\r\n\tat Script4.run(Script4.groovy:1)\r\n\tat org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:447)\r\n\tat org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:293)\r\n\tat javax.script.AbstractScriptEngine.eval(AbstractScriptEngine.java:233)\r\n\tat org.apache.tinkerpop.gremlin.groovy.engine.ScriptEngines.eval(ScriptEngines.java:89)\r\n\tat org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$2(GremlinExecutor.java:244)\r\n\tat org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor$$Lambda$108/1268451829.call(Unknown Source)\r\n\tat java.util.concurrent.FutureTask.run(FutureTask.java:266)\r\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)\r\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)\r\n\tat java.lang.Thread.run(Thread.java:745)\r\nCaused by: com.thinkaurelius.titan.diskstorage.PermanentBackendException: Permanent failure in storage backend\r\n\tat com.thinkaurelius.titan.diskstorage.berkeleyje.BerkeleyJEKeyValueStore.insert(BerkeleyJEKeyValueStore.java:206)\r\n\tat com.thinkaurelius.titan.diskstorage.berkeleyje.BerkeleyJEKeyValueStore.insert(BerkeleyJEKeyValueStore.java:183)\r\n\tat com.thinkaurelius.titan.diskstorage.berkeleyje.BerkeleyJEStoreManager.mutateMany(BerkeleyJEStoreManager.java:195)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.keyvalue.OrderedKeyValueStoreManagerAdapter.mutateMany(OrderedKeyValueStoreManagerAdapter.java:107)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.cache.CacheTransaction$1.call(CacheTransaction.java:90)\r\n\tat com.thinkaurelius.titan.diskstorage.keycolumnvalue.cache.CacheTransaction$1.call(CacheTransaction.java:87)\r\n\tat com.thinkaurelius.titan.diskstorage.util.BackendOperation.executeDirect(BackendOperation.java:56)\r\n\tat com.thinkaurelius.titan.diskstorage.util.BackendOperation.execute(BackendOperation.java:42)\r\n\t... 23 more\r\nCaused by: com.sleepycat.je.LockTimeoutException: (JE 5.0.73) Lock expired. Locker 2094710972 1873_pool-98-thread-1_Txn: waited for lock on database=edgestore LockAddr:313929167 LSN=0x0/0x2708f type=WRITE grant=WAIT_PROMOTION timeoutMillis=500 startTime=1435142947866 endTime=1435142948366\r\nOwners: [<LockInfo locker=\"104208586 1872_gremlin-server-worker-1_Txn\" type=\"READ\"/>, <LockInfo locker=\"2094710972 1873_pool-98-thread-1_Txn\" type=\"READ\"/>]\r\nWaiters: []\r\nTransaction 2094710972 1873_pool-98-thread-1_Txn owns LockAddr:313929167 <LockInfo locker=\"2094710972 1873_pool-98-thread-1_Txn\" type=\"READ\"/>\r\nTransaction 2094710972 1873_pool-98-thread-1_Txn waits for LockAddr:313929167\r\n\r\n\tat com.sleepycat.je.txn.LockManager.newLockTimeoutException(LockManager.java:664)\r\n\tat com.sleepycat.je.txn.LockManager.makeTimeoutMsgInternal(LockManager.java:623)\r\n\tat com.sleepycat.je.txn.SyncedLockManager.makeTimeoutMsg(SyncedLockManager.java:97)\r\n\tat com.sleepycat.je.txn.LockManager.lockInternal(LockManager.java:390)\r\n\tat com.sleepycat.je.txn.LockManager.lock(LockManager.java:276)\r\n\tat com.sleepycat.je.txn.Txn.lockInternal(Txn.java:498)\r\n\tat com.sleepycat.je.txn.Locker.lock(Locker.java:443)\r\n\tat com.sleepycat.je.dbi.CursorImpl.lockLN(CursorImpl.java:2621)\r\n\tat com.sleepycat.je.dbi.CursorImpl.getSlotReuseInfo(CursorImpl.java:1091)\r\n\tat com.sleepycat.je.dbi.CursorImpl.putInternal(CursorImpl.java:880)\r\n\tat com.sleepycat.je.dbi.CursorImpl.put(CursorImpl.java:811)\r\n\tat com.sleepycat.je.Cursor.putAllowPhantoms(Cursor.java:2243)\r\n\tat com.sleepycat.je.Cursor.putNoNotify(Cursor.java:2200)\r\n\tat com.sleepycat.je.Cursor.putNotify(Cursor.java:2117)\r\n\tat com.sleepycat.je.Cursor.putNoDups(Cursor.java:2052)\r\n\tat com.sleepycat.je.Cursor.putInternal(Cursor.java:2020)\r\n\tat com.sleepycat.je.Database.putInternal(Database.java:1302)\r\n\tat com.sleepycat.je.Database.put(Database.java:1172)\r\n\tat com.thinkaurelius.titan.diskstorage.berkeleyje.BerkeleyJEKeyValueStore.insert(BerkeleyJEKeyValueStore.java:194)\r\n\t... 30 more\r\n```"},"comment":{"url":"https://api.github.com/repos/thinkaurelius/titan/issues/comments/203371741","html_url":"https://github.com/thinkaurelius/titan/issues/1113#issuecomment-203371741","issue_url":"https://api.github.com/repos/thinkaurelius/titan/issues/1113","id":203371741,"user":{"login":"jimlack","id":18164205,"avatar_url":"https://avatars.githubusercontent.com/u/18164205?v=3","gravatar_id":"","url":"https://api.github.com/users/jimlack","html_url":"https://github.com/jimlack","followers_url":"https://api.github.com/users/jimlack/followers","following_url":"https://api.github.com/users/jimlack/following{/other_user}","gists_url":"https://api.github.com/users/jimlack/gists{/gist_id}","starred_url":"https://api.github.com/users/jimlack/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/jimlack/subscriptions","organizations_url":"https://api.github.com/users/jimlack/orgs","repos_url":"https://api.github.com/users/jimlack/repos","events_url":"https://api.github.com/users/jimlack/events{/privacy}","received_events_url":"https://api.github.com/users/jimlack/received_events","type":"User","site_admin":false},"created_at":"2016-03-30T10:34:38Z","updated_at":"2016-03-30T10:34:38Z","body":"Apologies mybad, found a dangling transaction. All good now"}}