It looks like an exception is occurring and the transaction is being rolled back. Is your fault handler being called on the client side? I think that there are certain types of Errors and RuntimeExceptions which are not being logged properly by the FDS MessageService so that is making this look mysterious in the logs. If the error is occurring after the updateItem call succeeds, it will be hard to track down without libraries that do that logging. 2.0.1 is coming out real soon now and has some improvements to the logging so that might be worth a try.
Jeff ________________________________ From: flexcoders@yahoogroups.com [mailto:[EMAIL PROTECTED] On Behalf Of parkerwhirlow Sent: Thursday, December 21, 2006 4:14 PM To: flexcoders@yahoogroups.com Subject: [flexcoders] DataService commit() doesn't finish. Hi guys, I have some functionality that used to work that isn't working anymore... using FDMS and HibernateAssembler. >From Flex, I've made one single change and used DataService.commit(), and added a responder to the AsyncToken. On the server, I can trace through the HibernateAssembler.updateItem() and everything goes fine. The commit code doesn't get called though because Transactions are true, and the "syncSession" is used. There is some server trace of an AcknowledgeMessage getting sent, but the responder never gets called, and if I refresh the flex client, the values are not saved. Please see the log trace below, and let me know if I missed anything. thanks, PW 12/21 15:49:55 user [Flex] 15:49:55.658 [DEBUG] [Message.Data.transacted] Before invoke service: data-service incomingMessage: Flex Message (flex.data.messages.DataMessage) operation = transacted id = null clientId = 37BE2173-400E-D4C7-CBC3-2943A841449A correlationId = destination = Model messageId = F4DE4EEE-9D72-806C-A4DB-A76BC6F02C11 timestamp = 1166744995648 timeToLive = 0 body = [ Flex Message (flex.data.messages.DataMessage) operation = update id = ASObject(32376284){id=1163778853188464256078} clientId = CCD745B5-3C9E-C584-4ED4-A7666B51EEF4 correlationId = F4DE4EEE-9D72-806C-A4DB-A76BC6F02C11 destination = Application messageId = 8577BADB-417B-D762-5E92-A76B983BAA25 timestamp = 0 timeToLive = 0 body = [ [ selecteddisplay ], [EMAIL PROTECTED], [EMAIL PROTECTED] ] hdr(newReferencedIds) = {displays= [ {id=1156440527883820192695}, {id=1164384322718557235986}, {id=1164388051550092880785}, {id=1164467025953663641911}, {id=1164467032523719875336}, {id=1164467037039304665983} ]} hdr(prevReferencedIds) = {displays= [ {id=1156440527883820192695}, {id=1164384322718557235986}, {id=1164388051550092880785}, {id=1164467025953663641911}, {id=1164467032523719875336}, {id=1164467037039304665983} ]} ] hdr(DSEndpoint) = my-rtmp 12/21 15:49:55 user [Flex] 15:49:55.819 [DEBUG] [DataService.Transaction] Started transaction using jndi name: java:comp/UserTransaction 12/21 15:49:55 user [Flex] 15:49:55.949 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1156440527883820192695 -> [EMAIL PROTECTED] 12/21 15:50:06 user [Flex] 15:50:06.864 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164384322718557235986 -> [EMAIL PROTECTED] 12/21 15:50:11 user [Flex] 15:50:11.261 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164388051550092880785 -> [EMAIL PROTECTED] 12/21 15:50:15 user [Flex] 15:50:15.707 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467025953663641911 -> [EMAIL PROTECTED] 12/21 15:50:19 user [Flex] 15:50:19.753 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467032523719875336 -> [EMAIL PROTECTED] 12/21 15:50:23 user [Flex] 15:50:23.789 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467037039304665983 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.684 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1156440527883820192695 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.784 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164384322718557235986 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.805 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164388051550092880785 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.825 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467025953663641911 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.845 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467032523719875336 -> [EMAIL PROTECTED] 12/21 15:50:27 user [Flex] 15:50:27.855 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1164467037039304665983 -> [EMAIL PROTECTED] 12/21 15:50:43 user [Flex] 15:50:43.577 [DEBUG] [DataService.Hibernate] Get object from hibernate with id=1163778853188464256078 -> [EMAIL PROTECTED] 8634a 12/21 15:52:31 debug Pool skimmer cleaning objects from the pool that have exceeded their allotted lifespan, has 1 pooled objects to evaluate 12/21 15:56:28 debug MM GC collected 0 messages, 0 remaining. 12/21 15:56:28 debug DMGC collected 0 caches, 0 remaining. 12/21 15:56:28 debug DMGC collected 0 destinations, 4 remaining. 12/21 15:58:27 user [Flex] 15:58:27.604 [DEBUG] [Message.Data.transacted] After invoke service: data-service reply: Flex Message (flex.messaging.messages.AcknowledgeMessage) clientId = null correlationId = null destination = null messageId = 37CDCCD7-C10A-8F1E-29CB-776833CA1097 timestamp = 1166745416273 timeToLive = 0 body = [ ] 12/21 15:59:20 user [Flex] 15:59:20.310 [DEBUG] [Endpoint.RTMP] Serializing AMF/RTMP response Version: 3 (Command method=_result (0) trxId=77) (Typed Object #0 'flex.messaging.messages.AcknowledgeMessage') destination = null headers = (Object #1) correlationId = "F4DE4EEE-9D72-806C-A4DB-A76BC6F02C11" messageId = "37CDCCD7-C10A-8F1E-29CB-776833CA1097" timestamp = 1.166745416273E12 clientId = "37BE2173-400E-D4C7-CBC3-2943A841449A" timeToLive = 0.0 body = (Array #2) 12/21 15:59:20 user [Flex] 15:59:20.310 [DEBUG] [Endpoint.RTMP] Created worker thread: RTMP-Worker-8
