OFBiz › OFBiz - User

POS order status change error

‹ Previous Topic Next Topic ›
 
classic Classic list List threaded Threaded
♦
♦
 4 messages Options
Bilgin Ibryam
Reply | Threaded
Open this post in threaded view
♦
♦
|

POS order status change error

Bilgin Ibryam
Hi guys,
I use latest ofbiz trunk and  when i do a POS order i get an error in the console saying "Could not change order status ; status is not a valid change." Then the order in POS is finished in normal way. But when i go to  order manger i can see that the order is in created status (insted of completed). Also there is no inventory movements... Is this a bug ?
Here i atache POS error log

  [java] 2007-07-31 15:57:59,548 (Thread-162) [  Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - add item(GZ-5005/1.0)
     [java] 2007-07-31 15:58:04,095 (Thread-177) [  Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - removing payment(CASH)
     [java] 2007-07-31 15:58:04,114 (Thread-177) [       ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType: CASH / Amt: null / Ref: null!null
     [java] 2007-07-31 15:58:04,115 (Thread-177) [      PaymentEvents.java:334:INFO ] Amount is empty; assumption is full amount : 47.99
     [java] 2007-07-31 15:58:04,119 (Thread-177) [      PaymentEvents.java:43 :INFO ] Processing [Cash] Amount : 47.99
     [java] 2007-07-31 15:58:04,119 (Thread-177) [  Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - added payment(CASH/47.99)
     [java] 2007-07-31 15:58:04,119 (Thread-177) [       ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType: CASH / Amt: null / Ref: null!null
     [java] 2007-07-31 15:58:04,120 (Thread-177) [       ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType: CASH / Amt: 47.99 / Ref: null!null
     [java] 2007-07-31 15:58:04,973 (Thread-179) [  Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - process sale
     [java] 2007-07-31 15:58:04,976 (Thread-179) [   ShoppingCartItem.java:1400:INFO ] Setting orderItemSeqId - 00001
     [java] 2007-07-31 15:58:04,978 (Thread-179) [      GenericEntity.java:386:WARN ] In entity field [OrderPaymentPreference.maxAmount] set the value passed in [java.math.BigDecimal] is not compatible with the Java type of the field [Double]
     [java] 2007-07-31 15:58:04,979 (Thread-179) [       ShoppingCart.java:4368:INFO ] Creating OrderPaymentPreference - [GenericEntity:OrderPaymentPreference][billingPostalCode,null()][finAccountId,null()][manualAuthCode,null()][manualRefNum,null()][maxAmount,47.99(java.math.BigDecimal)][overflowFlag,N(java.lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.String)][presentFlag,N(java.lang.String)][statusId,PAYMENT_RECEIVED(java.lang.String)]
     [java] 2007-07-31 15:58:05,404 (Thread-179) [                Log.java:94 :INFO ] In getNextOrderId partyId is [Company], partyAcctgPreference: [GenericEntity:PartyAcctgPreference][baseCurrencyUomId,USD(java.lang.String)][cogsMethodId,COGS_AVG_COST(java.lang.String)][createdStamp,2007-07-31 15:56:40.852(java.sql.Timestamp)][createdTxStamp,2007-07-31 15:56:40.602(java.sql.Timestamp)][fiscalYearStartDay,null()][fiscalYearStartMonth,null()][invoiceIdPrefix,CI(java.lang.String)][invoiceSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][lastInvoiceNumber,0(java.lang.Long)][lastInvoiceRestartDate,null()][lastOrderNumber,0(java.lang.Long)][lastQuoteNumber,0(java.lang.Long)][lastUpdatedStamp,2007-07-31 15:56:40.852(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31 15:56:40.602(java.sql.Timestamp)][orderIdPrefix,CO(java.lang.String)][orderSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][partyId,Company(java.lang.String)][quoteIdPrefix,CQ(java.lang.String)][quoteSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][refundPaymentMethodId,null()][taxFormId,US_IRS_1120(java.lang.String)][useInvoiceIdForReturns,null()]
     [java] 2007-07-31 15:58:05,420 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [OrderHeader]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='OrderHeader'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:05,440 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [OrderHeader]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:05,502 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [OrderStatus]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='OrderStatus'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:05,522 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [OrderStatus]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:05,551 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [OrderPaymentPreference]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='OrderPaymentPreference'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:05,570 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [OrderPaymentPreference]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:05,725 (Thread-179) [      EntityEcaRule.java:111:INFO ] Running Entity ECA Service: checkCreateOrderRequirement, triggered by rule on Entity: OrderItem
     [java] 2007-07-31 15:58:06,021 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: updateShoppingListQuantitiesFromOrder, triggered by rule on Service: storeOrder
     [java] 2007-07-31 15:58:06,051 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: resetGrandTotal, triggered by rule on Service: storeOrder
     [java] 2007-07-31 15:58:06,148 (Thread-179) [      GenericEntity.java:386:WARN ] In entity field [OrderHeader.grandTotal] set the value passed in [java.math.BigDecimal] is not compatible with the Java type of the field [Double]
     [java] 2007-07-31 15:58:06,149 (Thread-179) [      GenericEntity.java:386:WARN ] In entity field [OrderHeader.remainingSubTotal] set the value passed in [java.math.BigDecimal] is not compatible with the Java type of the field [Double]
     [java] 2007-07-31 15:58:06,187 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: addSuggestionsToShoppingList, triggered by rule on Service: storeOrder
     [java] 2007-07-31 15:58:06,203 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [RuntimeData]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='RuntimeData'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:06,223 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [RuntimeData]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:06,304 (Thread-179) [ GenericAsyncEngine.java:142:INFO ] Persisted job queued : 1185886686273
     [java] 2007-07-31 15:58:06,312 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: checkCreateDropShipPurchaseOrders, triggered by rule on Service: storeOrder
     [java] 2007-07-31 15:58:06,423 (Thread-179) [     CheckOutHelper.java:1038:INFO ] Face-To-Face Sale - RSCO10000
     [java] 2007-07-31 15:58:06,629 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [Payment]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='Payment'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:06,647 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [Payment]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:06,909 (Thread-179) [                Log.java:94 :INFO ] In getNextInvoiceId partyId is [Company], partyAcctgPreference: [GenericEntity:PartyAcctgPreference][baseCurrencyUomId,USD(java.lang.String)][cogsMethodId,COGS_AVG_COST(java.lang.String)][createdStamp,2007-07-31 15:56:40.852(java.sql.Timestamp)][createdTxStamp,2007-07-31 15:56:40.602(java.sql.Timestamp)][fiscalYearStartDay,null()][fiscalYearStartMonth,null()][invoiceIdPrefix,CI(java.lang.String)][invoiceSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][lastInvoiceNumber,0(java.lang.Long)][lastInvoiceRestartDate,null()][lastOrderNumber,0(java.lang.Long)][lastQuoteNumber,0(java.lang.Long)][lastUpdatedStamp,2007-07-31 15:56:40.852(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31 15:56:40.602(java.sql.Timestamp)][orderIdPrefix,CO(java.lang.String)][orderSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][partyId,Company(java.lang.String)][quoteIdPrefix,CQ(java.lang.String)][quoteSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][refundPaymentMethodId,null()][taxFormId,US_IRS_1120(java.lang.String)][useInvoiceIdForReturns,null()]
     [java] 2007-07-31 15:58:06,910 (Thread-179) [                Log.java:94 :INFO ] In createInvoice sequence enum INVSQ_ENF_SEQ
     [java] 2007-07-31 15:58:07,128 (Thread-179) [    InvoiceServices.java:335:WARN ] No billing locations found for order [RSCO10000] and none were created for Invoice [CI1]
     [java] 2007-07-31 15:58:07,741 (Thread-179) [       SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first select failed: will try to add new row, result set was empty for sequence [PaymentApplication]
     [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE SEQ_NAME='PaymentApplication'
     [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
     [java] 2007-07-31 15:58:07,757 (Thread-179) [       SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [PaymentApplication]; curSeqId=10000, maxSeqId=10010, bankSize=10
     [java] 2007-07-31 15:58:07,793 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: checkInvoicePaymentApplications, triggered by rule on Service: createPaymentApplication
     [java] 2007-07-31 15:58:07,796 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: createCommissionInvoices, triggered by rule on Service: createPaymentApplication
     [java] 2007-07-31 15:58:08,140 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: capturePaymentsByInvoice, triggered by rule on Service: createInvoiceForOrder
     [java] 2007-07-31 15:58:08,162 (Thread-179) [PaymentGatewayServices.java:995:INFO ] (Capture) Invoice [#CI1] total: 0.0
     [java] 2007-07-31 15:58:08,206 (Thread-179) [PaymentGatewayServices.java:1060:INFO ] The Remaining Total for order: RSCO10000 is: 0.00
     [java] 2007-07-31 15:58:08,208 (Thread-179) [PaymentGatewayServices.java:1063:INFO ] Actual Expected Capture Amount : 0.00
     [java] 2007-07-31 15:58:08,231 (Thread-179) [  ServiceDispatcher.java:410:ERROR] Service Error [changeOrderStatus]: ERROR : Could not change order status ; status is not a valid change.
     [java] 2007-07-31 15:58:08,232 (Thread-179) [    TransactionUtil.java:255:ERROR]
     [java] ---- exception report ----------------------------------------------------------
     [java] [TransactionUtil.rollback]
     [java] Exception: java.lang.Exception
     [java] Message: Stack Trace
     [java] ---- stack trace ---------------------------------------------------------------
     [java] java.lang.Exception: Stack Trace
     [java] org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:254)
     [java] org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:236)
     [java] org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:414)
     [java] org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:210)
     [java] org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:136)
     [java] org.ofbiz.order.order.OrderChangeHelper.orderStatusChanges(OrderChangeHelper.java:158)
     [java] org.ofbiz.order.order.OrderChangeHelper.completeOrder(OrderChangeHelper.java:121)
     [java] org.ofbiz.order.shoppingcart.CheckOutHelper.processPayment(CheckOutHelper.java:1040)
     [java] org.ofbiz.order.shoppingcart.CheckOutHelper.processPayment(CheckOutHelper.java:845)
     [java] org.ofbiz.pos.PosTransaction.processSale(PosTransaction.java:625)
     [java] org.ofbiz.pos.event.PaymentEvents.processSale(PaymentEvents.java:304)
     [java] sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
     [java] sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
     [java] sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
     [java] java.lang.reflect.Method.invoke(Method.java:585)
     [java] org.ofbiz.pos.config.ButtonEventConfig.invoke(ButtonEventConfig.java:208)
     [java] org.ofbiz.pos.config.ButtonEventConfig.invokeButtonEvent(ButtonEventConfig.java:105)
     [java] org.ofbiz.pos.component.PosButton$1.construct(PosButton.java:120)
     [java] net.xoetrope.xui.helper.SwingWorker$2.run(Unknown Source)
     [java] java.lang.Thread.run(Thread.java:595)
     [java] --------------------------------------------------------------------------------
     [java] 2007-07-31 15:58:08,234 (Thread-179) [    TransactionUtil.java:265:INFO ] [TransactionUtil.rollback] transaction rolled back
     [java] 2007-07-31 15:58:08,237 (Thread-179) [  OrderChangeHelper.java:160:ERROR] Problems adjusting order header status for order #RSCO10000
     [java] 2007-07-31 15:58:08,270 (Thread-179) [     ServiceEcaRule.java:112:INFO ] Got false for condition: [null][][statusId][equals][null][ITEM_CANCELLED][true][String][]
     [java] 2007-07-31 15:58:08,271 (Thread-179) [     ServiceEcaRule.java:137:INFO ] Running Service ECA Service: checkOrderItemStatus, triggered by rule on Service: changeOrderItemStatus
     [java] 2007-07-31 15:58:08,305 (Thread-179) [     ServiceEcaRule.java:112:INFO ] Got false for condition: [null][][statusId][equals][null][ITEM_APPROVED][true][String][]
     [java] 2007-07-31 15:58:08,306 (Thread-179) [     ServiceEcaRule.java:112:INFO ] Got false for condition: [null][][statusId][equals][null][ITEM_APPROVED][true][String][]
     [java] 2007-07-31 15:58:08,308 (Thread-179) [     CheckOutHelper.java:1041:INFO ] Complete Order Result - true
     [java] 2007-07-31 15:58:08,311 (Thread-215) [            Receipt.java:140:INFO ] Print Receipt Requested : 10000
     [java] 2007-07-31 15:58:08,352 (Thread-215) [     PosTransaction.java:283:ERROR] No Authorization transaction found for payment preference - [GenericEntity:OrderPaymentPreference][billingPostalCode,null()][createdByUserLogin,1(java.lang.String)][createdDate,2007-07-31 15:58:05.572(java.sql.Timestamp)][createdStamp,2007-07-31 15:58:05.982(java.sql.Timestamp)][createdTxStamp,2007-07-31 15:58:04.98(java.sql.Timestamp)][finAccountId,null()][lastUpdatedStamp,2007-07-31 15:58:05.982(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31 15:58:04.98(java.sql.Timestamp)][manualAuthCode,null()][manualRefNum,null()][maxAmount,47.99(java.lang.Double)][needsNsfRetry,null()][orderId,RSCO10000(java.lang.String)][orderItemSeqId,null()][orderPaymentPreferenceId,10000(java.lang.String)][overflowFlag,N(java.lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.String)][presentFlag,N(java.lang.String)][processAttempt,null()][productPricePurposeId,null()][securityCode,null()][statusId,PAYMENT_RECEIVED(java.lang.String)]
     [java] 2007-07-31 15:58:11,361 (Thread-215) [     NullPosPrinter.java:519:INFO ] transactionPrint:
     [java] 2007-07-31 15:58:11,368 (Thread-215) [     PosTransaction.java:283:ERROR] No Authorization transaction found for payment preference - [GenericEntity:OrderPaymentPreference][billingPostalCode,null()][createdByUserLogin,1(java.lang.String)][createdDate,2007-07-31 15:58:05.572(java.sql.Timestamp)][createdStamp,2007-07-31 15:58:05.982(java.sql.Timestamp)][createdTxStamp,2007-07-31 15:58:04.98(java.sql.Timestamp)][finAccountId,null()][lastUpdatedStamp,2007-07-31 15:58:05.982(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31 15:58:04.98(java.sql.Timestamp)][manualAuthCode,null()][manualRefNum,null()][maxAmount,47.99(java.lang.Double)][needsNsfRetry,null()][orderId,RSCO10000(java.lang.String)][orderItemSeqId,null()][orderPaymentPreferenceId,10000(java.lang.String)][overflowFlag,N(java.lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.String)][presentFlag,N(java.lang.String)][processAttempt,null()][productPricePurposeId,null()][securityCode,null()][statusId,PAYMENT_RECEIVED(java.lang.String)]
     [java] 2007-07-31 15:58:11,370 (Thread-215) [FlexibleStringExpander.java:355:WARN ] Could not find value in environment for the name [nameOnCard], inserting nothing.
     [java] 2007-07-31 15:58:11,370 (Thread-215) [FlexibleStringExpander.java:355:WARN ] Could not find value in environment for the name [authInfoString], inserting nothing.
     [java] 2007-07-31 15:58:11,372 (Thread-215) [     NullPosPrinter.java:484:INFO ] Normal:
     [java] Normal:|cA|4C|bCCompany XYZ
     [java] Normal:|cA|bC7 E. 8th St. #308
     [java] Normal:|cA|bCNew York, NY 10003
     [java] Normal:|cA|bC212.655.3052
     [java] Normal:
     [java] Normal:|cASale: RSCO10000 Tx: 10000 Dr: 1 Clerk: 1
     [java] Normal:|cATue, 31 Jul 2007 15:58:11 EEST
     [java] Normal:
     [java] Normal:DESC                              PRICE    QTY
     [java] Normal:==============================================
     [java] Normal:GZ-5005                     T     47.99      1
     [java] Normal:The stylish gizmo
     [java] Normal:
     [java] Normal:                         SALES TAX:       0.00
     [java] Normal:                             TOTAL:      47.99
     [java] Normal:
     [java] Normal:                              Cash:      47.99
     [java] Normal:
     [java] Normal:                            CHANGE:       0.00
     [java] Normal:
     [java] Normal:
     [java] Barcode:RSCO10000Normal:
     [java] Normal:|cA|4C|bCTHANK-YOU
     [java] Normal:
     [java] Normal:
     [java] Normal:
     [java] Normal:|100fP
     [java] 2007-07-31 15:58:11,373 (Thread-215) [     NullPosPrinter.java:519:INFO ] transactionPrint:

Regards,
Bilgin Ibryam
Jacques Le Roux
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: POS order status change error

Jacques Le Roux
Administrator
Bilgin,

Yes I noticed that too for a while now. The POS module is really at the end of the chain (it depends of lot of other modules). So
sometimes problems like this appear when other modules change. It should not be too hard to track and fix if needed (at least no
inventory movements seems a bug). Sorry, I have no time for the moment. Of course any help will be appreciated.

Jacques

De : "Bilgin" <[hidden email]>

>
> Hi guys,
> I use latest ofbiz trunk and  when i do a POS order i get an error in the
> console saying "Could not change order status ; status is not a valid
> change." Then the order in POS is finished in normal way. But when i go to
> order manger i can see that the order is in created status (insted of
> completed). Also there is no inventory movements... Is this a bug ?
> Here i atache POS error log
>
>   [java] 2007-07-31 15:57:59,548 (Thread-162) [  Log4jLoggerWriter.java:67
> :INFO ] [POS @ pos-1 TX:10000] - add item(GZ-5005/1.0)
>      [java] 2007-07-31 15:58:04,095 (Thread-177) [
> Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - removing
> payment(CASH)
>      [java] 2007-07-31 15:58:04,114 (Thread-177) [
> ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType:
> CASH / Amt: null / Ref: null!null
>      [java] 2007-07-31 15:58:04,115 (Thread-177) [
> PaymentEvents.java:334:INFO ] Amount is empty; assumption is full amount :
> 47.99
>      [java] 2007-07-31 15:58:04,119 (Thread-177) [
> PaymentEvents.java:43 :INFO ] Processing [Cash] Amount : 47.99
>      [java] 2007-07-31 15:58:04,119 (Thread-177) [
> Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - added
> payment(CASH/47.99)
>      [java] 2007-07-31 15:58:04,119 (Thread-177) [
> ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType:
> CASH / Amt: null / Ref: null!null
>      [java] 2007-07-31 15:58:04,120 (Thread-177) [
> ShoppingCart.java:1436:INFO ] Returned new PaymentInfo - Pm: null / PmType:
> CASH / Amt: 47.99 / Ref: null!null
>      [java] 2007-07-31 15:58:04,973 (Thread-179) [
> Log4jLoggerWriter.java:67 :INFO ] [POS @ pos-1 TX:10000] - process sale
>      [java] 2007-07-31 15:58:04,976 (Thread-179) [
> ShoppingCartItem.java:1400:INFO ] Setting orderItemSeqId - 00001
>      [java] 2007-07-31 15:58:04,978 (Thread-179) [
> GenericEntity.java:386:WARN ] In entity field
> [OrderPaymentPreference.maxAmount] set the value passed in
> [java.math.BigDecimal] is not compatible with the Java type of the field
> [Double]
>      [java] 2007-07-31 15:58:04,979 (Thread-179) [
> ShoppingCart.java:4368:INFO ] Creating OrderPaymentPreference -
>
[GenericEntity:OrderPaymentPreference][billingPostalCode,null()][finAccountId,null()][manualAuthCode,null()][manualRefNum,null()][ma
xAmount,47.99(java.math.BigDecimal)][overflowFlag,N(java.lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.St
ring)][presentFlag,N(java.lang.String)][statusId,PAYMENT_RECEIVED(java.lang.String)]
>      [java] 2007-07-31 15:58:05,404 (Thread-179) [
> Log.java:94 :INFO ] In getNextOrderId partyId is [Company],
> partyAcctgPreference:
>
[GenericEntity:PartyAcctgPreference][baseCurrencyUomId,USD(java.lang.String)][cogsMethodId,COGS_AVG_COST(java.lang.String)][createdS
tamp,2007-07-31
> 15:56:40.852(java.sql.Timestamp)][createdTxStamp,2007-07-31
>
15:56:40.602(java.sql.Timestamp)][fiscalYearStartDay,null()][fiscalYearStartMonth,null()][invoiceIdPrefix,CI(java.lang.String)][invo
iceSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][lastInvoiceNumber,0(java.lang.Long)][lastInvoiceRestartDate,null()][lastOrderNumb
er,0(java.lang.Long)][lastQuoteNumber,0(java.lang.Long)][lastUpdatedStamp,2007-07-31
> 15:56:40.852(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31
>
15:56:40.602(java.sql.Timestamp)][orderIdPrefix,CO(java.lang.String)][orderSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][partyId,C
ompany(java.lang.String)][quoteIdPrefix,CQ(java.lang.String)][quoteSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][refundPaymentMeth
odId,null()][taxFormId,US_IRS_1120(java.lang.String)][useInvoiceIdForReturns,null()]

>      [java] 2007-07-31 15:58:05,420 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [OrderHeader]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='OrderHeader'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:05,440 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [OrderHeader];
> curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:05,502 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [OrderStatus]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='OrderStatus'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:05,522 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [OrderStatus];
> curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:05,551 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [OrderPaymentPreference]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='OrderPaymentPreference'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:05,570 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for
> [OrderPaymentPreference]; curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:05,725 (Thread-179) [
> EntityEcaRule.java:111:INFO ] Running Entity ECA Service:
> checkCreateOrderRequirement, triggered by rule on Entity: OrderItem
>      [java] 2007-07-31 15:58:06,021 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> updateShoppingListQuantitiesFromOrder, triggered by rule on Service:
> storeOrder
>      [java] 2007-07-31 15:58:06,051 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service: resetGrandTotal,
> triggered by rule on Service: storeOrder
>      [java] 2007-07-31 15:58:06,148 (Thread-179) [
> GenericEntity.java:386:WARN ] In entity field [OrderHeader.grandTotal] set
> the value passed in [java.math.BigDecimal] is not compatible with the Java
> type of the field [Double]
>      [java] 2007-07-31 15:58:06,149 (Thread-179) [
> GenericEntity.java:386:WARN ] In entity field
> [OrderHeader.remainingSubTotal] set the value passed in
> [java.math.BigDecimal] is not compatible with the Java type of the field
> [Double]
>      [java] 2007-07-31 15:58:06,187 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> addSuggestionsToShoppingList, triggered by rule on Service: storeOrder
>      [java] 2007-07-31 15:58:06,203 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [RuntimeData]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='RuntimeData'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:06,223 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [RuntimeData];
> curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:06,304 (Thread-179) [
> GenericAsyncEngine.java:142:INFO ] Persisted job queued : 1185886686273
>      [java] 2007-07-31 15:58:06,312 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> checkCreateDropShipPurchaseOrders, triggered by rule on Service: storeOrder
>      [java] 2007-07-31 15:58:06,423 (Thread-179) [
> CheckOutHelper.java:1038:INFO ] Face-To-Face Sale - RSCO10000
>      [java] 2007-07-31 15:58:06,629 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [Payment]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='Payment'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:06,647 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for [Payment];
> curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:06,909 (Thread-179) [
> Log.java:94 :INFO ] In getNextInvoiceId partyId is [Company],
> partyAcctgPreference:
>
[GenericEntity:PartyAcctgPreference][baseCurrencyUomId,USD(java.lang.String)][cogsMethodId,COGS_AVG_COST(java.lang.String)][createdS
tamp,2007-07-31
> 15:56:40.852(java.sql.Timestamp)][createdTxStamp,2007-07-31
>
15:56:40.602(java.sql.Timestamp)][fiscalYearStartDay,null()][fiscalYearStartMonth,null()][invoiceIdPrefix,CI(java.lang.String)][invo
iceSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][lastInvoiceNumber,0(java.lang.Long)][lastInvoiceRestartDate,null()][lastOrderNumb
er,0(java.lang.Long)][lastQuoteNumber,0(java.lang.Long)][lastUpdatedStamp,2007-07-31
> 15:56:40.852(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31
>
15:56:40.602(java.sql.Timestamp)][orderIdPrefix,CO(java.lang.String)][orderSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][partyId,C
ompany(java.lang.String)][quoteIdPrefix,CQ(java.lang.String)][quoteSequenceEnumId,INVSQ_ENF_SEQ(java.lang.String)][refundPaymentMeth
odId,null()][taxFormId,US_IRS_1120(java.lang.String)][useInvoiceIdForReturns,null()]

>      [java] 2007-07-31 15:58:06,910 (Thread-179) [
> Log.java:94 :INFO ] In createInvoice sequence enum INVSQ_ENF_SEQ
>      [java] 2007-07-31 15:58:07,128 (Thread-179) [
> InvoiceServices.java:335:WARN ] No billing locations found for order
> [RSCO10000] and none were created for Invoice [CI1]
>      [java] 2007-07-31 15:58:07,741 (Thread-179) [
> SequenceUtil.java:203:WARN ] [SequenceUtil.SequenceBank.fillBank] first
> select failed: will try to add new row, result set was empty for sequence
> [PaymentApplication]
>      [java] Used SQL: SELECT SEQ_ID FROM OFBIZ.SEQUENCE_VALUE_ITEM WHERE
> SEQ_NAME='PaymentApplication'
>      [java] Thread Name is: Thread-179:Thread[Thread-179,6,main]
>      [java] 2007-07-31 15:58:07,757 (Thread-179) [
> SequenceUtil.java:254:INFO ] Got bank of sequenced IDs for
> [PaymentApplication]; curSeqId=10000, maxSeqId=10010, bankSize=10
>      [java] 2007-07-31 15:58:07,793 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> checkInvoicePaymentApplications, triggered by rule on Service:
> createPaymentApplication
>      [java] 2007-07-31 15:58:07,796 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> createCommissionInvoices, triggered by rule on Service:
> createPaymentApplication
>      [java] 2007-07-31 15:58:08,140 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> capturePaymentsByInvoice, triggered by rule on Service:
> createInvoiceForOrder
>      [java] 2007-07-31 15:58:08,162 (Thread-179)
> [PaymentGatewayServices.java:995:INFO ] (Capture) Invoice [#CI1] total: 0.0
>      [java] 2007-07-31 15:58:08,206 (Thread-179)
> [PaymentGatewayServices.java:1060:INFO ] The Remaining Total for order:
> RSCO10000 is: 0.00
>      [java] 2007-07-31 15:58:08,208 (Thread-179)
> [PaymentGatewayServices.java:1063:INFO ] Actual Expected Capture Amount :
> 0.00
>      [java] 2007-07-31 15:58:08,231 (Thread-179) [
> ServiceDispatcher.java:410:ERROR] Service Error [changeOrderStatus]: ERROR :
> Could not change order status ; status is not a valid change.
>      [java] 2007-07-31 15:58:08,232 (Thread-179) [
> TransactionUtil.java:255:ERROR]
>      [java] ---- exception report
> ----------------------------------------------------------
>      [java] [TransactionUtil.rollback]
>      [java] Exception: java.lang.Exception
>      [java] Message: Stack Trace
>      [java] ---- stack trace
> ---------------------------------------------------------------
>      [java] java.lang.Exception: Stack Trace
>      [java]
> org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:254)
>      [java]
> org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:236)
>      [java]
> org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:414)
>      [java]
> org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:210)
>      [java]
> org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:136)
>      [java]
> org.ofbiz.order.order.OrderChangeHelper.orderStatusChanges(OrderChangeHelper.java:158)
>      [java]
> org.ofbiz.order.order.OrderChangeHelper.completeOrder(OrderChangeHelper.java:121)
>      [java]
> org.ofbiz.order.shoppingcart.CheckOutHelper.processPayment(CheckOutHelper.java:1040)
>      [java]
> org.ofbiz.order.shoppingcart.CheckOutHelper.processPayment(CheckOutHelper.java:845)
>      [java]
> org.ofbiz.pos.PosTransaction.processSale(PosTransaction.java:625)
>      [java]
> org.ofbiz.pos.event.PaymentEvents.processSale(PaymentEvents.java:304)
>      [java] sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>      [java]
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>      [java]
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>      [java] java.lang.reflect.Method.invoke(Method.java:585)
>      [java]
> org.ofbiz.pos.config.ButtonEventConfig.invoke(ButtonEventConfig.java:208)
>      [java]
> org.ofbiz.pos.config.ButtonEventConfig.invokeButtonEvent(ButtonEventConfig.java:105)
>      [java]
> org.ofbiz.pos.component.PosButton$1.construct(PosButton.java:120)
>      [java] net.xoetrope.xui.helper.SwingWorker$2.run(Unknown Source)
>      [java] java.lang.Thread.run(Thread.java:595)
>      [java]
> --------------------------------------------------------------------------------
>      [java] 2007-07-31 15:58:08,234 (Thread-179) [
> TransactionUtil.java:265:INFO ] [TransactionUtil.rollback] transaction
> rolled back
>      [java] 2007-07-31 15:58:08,237 (Thread-179) [
> OrderChangeHelper.java:160:ERROR] Problems adjusting order header status for
> order #RSCO10000
>      [java] 2007-07-31 15:58:08,270 (Thread-179) [
> ServiceEcaRule.java:112:INFO ] Got false for condition:
> [null][][statusId][equals][null][ITEM_CANCELLED][true][String][]
>      [java] 2007-07-31 15:58:08,271 (Thread-179) [
> ServiceEcaRule.java:137:INFO ] Running Service ECA Service:
> checkOrderItemStatus, triggered by rule on Service: changeOrderItemStatus
>      [java] 2007-07-31 15:58:08,305 (Thread-179) [
> ServiceEcaRule.java:112:INFO ] Got false for condition:
> [null][][statusId][equals][null][ITEM_APPROVED][true][String][]
>      [java] 2007-07-31 15:58:08,306 (Thread-179) [
> ServiceEcaRule.java:112:INFO ] Got false for condition:
> [null][][statusId][equals][null][ITEM_APPROVED][true][String][]
>      [java] 2007-07-31 15:58:08,308 (Thread-179) [
> CheckOutHelper.java:1041:INFO ] Complete Order Result - true
>      [java] 2007-07-31 15:58:08,311 (Thread-215) [
> Receipt.java:140:INFO ] Print Receipt Requested : 10000
>      [java] 2007-07-31 15:58:08,352 (Thread-215) [
> PosTransaction.java:283:ERROR] No Authorization transaction found for
> payment preference -
> [GenericEntity:OrderPaymentPreference][billingPostalCode,null()][createdByUserLogin,1(java.lang.String)][createdDate,2007-07-31
> 15:58:05.572(java.sql.Timestamp)][createdStamp,2007-07-31
> 15:58:05.982(java.sql.Timestamp)][createdTxStamp,2007-07-31
> 15:58:04.98(java.sql.Timestamp)][finAccountId,null()][lastUpdatedStamp,2007-07-31
> 15:58:05.982(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31
>
15:58:04.98(java.sql.Timestamp)][manualAuthCode,null()][manualRefNum,null()][maxAmount,47.99(java.lang.Double)][needsNsfRetry,null()
][orderId,RSCO10000(java.lang.String)][orderItemSeqId,null()][orderPaymentPreferenceId,10000(java.lang.String)][overflowFlag,N(java.
lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.String)][presentFlag,N(java.lang.String)][processAttempt,nu
ll()][productPricePurposeId,null()][securityCode,null()][statusId,PAYMENT_RECEIVED(java.lang.String)]

>      [java] 2007-07-31 15:58:11,361 (Thread-215) [
> NullPosPrinter.java:519:INFO ] transactionPrint:
>      [java] 2007-07-31 15:58:11,368 (Thread-215) [
> PosTransaction.java:283:ERROR] No Authorization transaction found for
> payment preference -
> [GenericEntity:OrderPaymentPreference][billingPostalCode,null()][createdByUserLogin,1(java.lang.String)][createdDate,2007-07-31
> 15:58:05.572(java.sql.Timestamp)][createdStamp,2007-07-31
> 15:58:05.982(java.sql.Timestamp)][createdTxStamp,2007-07-31
> 15:58:04.98(java.sql.Timestamp)][finAccountId,null()][lastUpdatedStamp,2007-07-31
> 15:58:05.982(java.sql.Timestamp)][lastUpdatedTxStamp,2007-07-31
>
15:58:04.98(java.sql.Timestamp)][manualAuthCode,null()][manualRefNum,null()][maxAmount,47.99(java.lang.Double)][needsNsfRetry,null()
][orderId,RSCO10000(java.lang.String)][orderItemSeqId,null()][orderPaymentPreferenceId,10000(java.lang.String)][overflowFlag,N(java.
lang.String)][paymentMethodId,null()][paymentMethodTypeId,CASH(java.lang.String)][presentFlag,N(java.lang.String)][processAttempt,nu
ll()][productPricePurposeId,null()][securityCode,null()][statusId,PAYMENT_RECEIVED(java.lang.String)]

>      [java] 2007-07-31 15:58:11,370 (Thread-215)
> [FlexibleStringExpander.java:355:WARN ] Could not find value in environment
> for the name [nameOnCard], inserting nothing.
>      [java] 2007-07-31 15:58:11,370 (Thread-215)
> [FlexibleStringExpander.java:355:WARN ] Could not find value in environment
> for the name [authInfoString], inserting nothing.
>      [java] 2007-07-31 15:58:11,372 (Thread-215) [
> NullPosPrinter.java:484:INFO ] Normal:
>      [java] Normal:|cA|4C|bCCompany XYZ
>      [java] Normal:|cA|bC7 E. 8th St. #308
>      [java] Normal:|cA|bCNew York, NY 10003
>      [java] Normal:|cA|bC212.655.3052
>      [java] Normal:
>      [java] Normal:|cASale: RSCO10000 Tx: 10000 Dr: 1 Clerk: 1
>      [java] Normal:|cATue, 31 Jul 2007 15:58:11 EEST
>      [java] Normal:
>      [java] Normal:DESC                              PRICE    QTY
>      [java] Normal:==============================================
>      [java] Normal:GZ-5005                     T     47.99      1
>      [java] Normal:The stylish gizmo
>      [java] Normal:
>      [java] Normal:                         SALES TAX:       0.00
>      [java] Normal:                             TOTAL:      47.99
>      [java] Normal:
>      [java] Normal:                              Cash:      47.99
>      [java] Normal:
>      [java] Normal:                            CHANGE:       0.00
>      [java] Normal:
>      [java] Normal:
>      [java] Barcode:RSCO10000Normal:
>      [java] Normal:|cA|4C|bCTHANK-YOU
>      [java] Normal:
>      [java] Normal:
>      [java] Normal:
>      [java] Normal:|100fP
>      [java] 2007-07-31 15:58:11,373 (Thread-215) [
> NullPosPrinter.java:519:INFO ] transactionPrint:
>
> Regards,
> Bilgin Ibryam
> --
> View this message in context: http://www.nabble.com/POS-order-status-change-error-tf4192871.html#a11923722
> Sent from the OFBiz - User mailing list archive at Nabble.com.
>

Bilgin Ibryam
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: POS order status change error

Bilgin Ibryam
Jacques,

I created a jira and attached a patch here https://issues.apache.org/jira/browse/OFBIZ-1176
You can take a look, also may be you can asnwer to my question :)

Bilgin
Jacques Le Roux
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: POS order status change error

Jacques Le Roux
Administrator
Great Bilgin,

I will have a look soon... (tomorrow I hope)

Jacques

De : "Bilgin Ibryam" <[hidden email]>

>
> Jacques,
>
> I created a jira and attached a patch here
> https://issues.apache.org/jira/browse/OFBIZ-1176
> You can take a look, also may be you can asnwer to my question :)
>
> Bilgin
> --
> View this message in context: http://www.nabble.com/POS-order-status-change-error-tf4192871.html#a11963782
> Sent from the OFBiz - User mailing list archive at Nabble.com.
Free forum by Nabble Edit this page