Please find the logs below : *Error.log* 2012-04-05 17:47:02,615 (http-bio-0.0.0.0-80-exec-4) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_BG_WC_03], not adding to cart. 2012-04-05 17:48:33,466 (http-bio-0.0.0.0-80-exec-2) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_BG_WC_03], not adding to cart. 2012-04-05 17:57:48,575 (http-bio-0.0.0.0-80-exec-4) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_BL_LC_03], not adding to cart. 2012-04-05 18:06:25,814 (http-bio-0.0.0.0-80-exec-9) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_BL_LC_03], not adding to cart. 2012-04-05 18:06:44,870 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_BG_WC_03], not adding to cart. 2012-04-05 18:07:05,191 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:443:ERROR] Request additem caused an error with the following message: Could not find a valid price for the product with ID [WK_SG_TH_10], not adding to cart.
*Debug.log for http-bio-0.0.0.0-80-exec-4* 2012-04-05 17:57:48,431 (http-bio-0.0.0.0-80-exec-4) [ ControlServlet.java:141:INFO ] [[[additem(Domain:http://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2012-04-05 17:57:48,433 (http-bio-0.0.0.0-80-exec-4) [ ShoppingCartEvents.java:182:INFO ] adding item product WK_BL_LC_03 2012-04-05 17:57:48,433 (http-bio-0.0.0.0-80-exec-4) [ ShoppingCartEvents.java:183:INFO ] adding item parent product null 2012-04-05 17:57:48,440 (http-bio-0.0.0.0-80-exec-4) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 17:57:48,446 (http-bio-0.0.0.0-80-exec-4) [ ShoppingCartHelper.java:203:INFO ] carthelper productid WK_BL_LC_03 2012-04-05 17:57:48,446 (http-bio-0.0.0.0-80-exec-4) [ ShoppingCartHelper.java:204:INFO ] parent productid null 2012-04-05 17:57:48,540 (http-bio-0.0.0.0-80-exec-4) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailableOrNotRequired] finished in [85] milliseconds with response [{responseMessage=success, availableOrNotRequired=Y}] 2012-04-05 17:57:48,547 (http-bio-0.0.0.0-80-exec-4) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 17:57:48,568 (http-bio-0.0.0.0-80-exec-4) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 17:57:48,574 (http-bio-0.0.0.0-80-exec-4) [ RequestHandler.java:660:INFO ] Ran Event [java:org.ofbiz.order.shoppingcart.ShoppingCartEvents#addToCart] from [request], result is [error] 2012-04-05 17:57:48,575 (http-bio-0.0.0.0-80-exec-4) [ RequestHandler.java:762:INFO ] Rendering View [showcart], sessionId=AFE5C687E3372B5B3F931C21F9B804F2.jvm1 2012-04-05 17:57:49,156 (http-bio-0.0.0.0-80-exec-4) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/getVisualThemeResources] finished in [244] milliseconds with response [{themeResources={shortcutIcon=/images/ofbiz.ico, javaScripts={/images/jquery/jquery-1.7.min.js, /images/jquery/plugins/validate/jquery.validate.min.js, /images/jquery/ui/development-bundle/ui/jquery.ui.datepicker.js, /images/jquery/ui/js/jquery-ui-1.8.16.custom.min.js, /images/jquery/plugins/datetimepicker/jquery-ui-timepicker-addon-0.9.7.js, /images/jquery/plugins/datetimepicker/localization/jquery-ui-timepicker-en.js, /images/selectall.js}, VT_FTR_TMPLT_LOC={component://ecommerce/webapp/ecommerce/includes/footer.ftl}, VT_HDR_IMAGE_URL={/images/ofbiz_logo.gif}, VT_HDR_TMPLT_LOC={component://ecommerce/webapp/ecommerce/includes/header.ftl}, VT_SCREENSHOT={/images/ecdefaulttheme.jpg}, VT_SHORTCUT_ICON={/images/ofbiz.ico}, VT_STYLESHEET={/ecommerce/images/blog.css, /images/ecommain.css, /content/images/contentForum.css}}, responseMessage=success}] 2012-04-05 17:57:49,527 (http-bio-0.0.0.0-80-exec-4) [ ServerHitBin.java:633:INFO ] Visit delegatorName=default, ServerHitBin delegatorName=default 2012-04-05 17:57:49,568 (http-bio-0.0.0.0-80-exec-4) [ ControlServlet.java:324:INFO ] [[[additem(Domain:http://localhost)] Request Done- total:1.136,since last([additem(Domain:h...):1.136]] *Debug.log for http-bio-0.0.0.0-80-exec-9* 2012-04-05 18:06:25,593 (http-bio-0.0.0.0-80-exec-9) [ ControlServlet.java:141:INFO ] [[[additem(Domain:http://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2012-04-05 18:06:25,627 (http-bio-0.0.0.0-80-exec-9) [ ConfigXMLReader.java:120:INFO ] controller loaded: 0.014s, 300 requests, 99 views in jndi:/0.0.0.0//WEB-INF/controller.xml 2012-04-05 18:06:25,629 (http-bio-0.0.0.0-80-exec-9) [ ShoppingCartEvents.java:182:INFO ] adding item product WK_BL_LC_03 2012-04-05 18:06:25,630 (http-bio-0.0.0.0-80-exec-9) [ ShoppingCartEvents.java:183:INFO ] adding item parent product null 2012-04-05 18:06:25,653 (http-bio-0.0.0.0-80-exec-9) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 18:06:25,658 (http-bio-0.0.0.0-80-exec-9) [ ShoppingCartHelper.java:203:INFO ] carthelper productid WK_BL_LC_03 2012-04-05 18:06:25,660 (http-bio-0.0.0.0-80-exec-9) [ ShoppingCartHelper.java:204:INFO ] parent productid null 2012-04-05 18:06:25,755 (http-bio-0.0.0.0-80-exec-9) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/getInventoryAvailableByFacility] finished in [71] milliseconds with response [{availableToPromiseTotal=100, quantityOnHandTotal=100, responseMessage=success}] 2012-04-05 18:06:25,764 (http-bio-0.0.0.0-80-exec-9) [ Log.java:117:INFO ] [ProductStoreServices.xml#isStoreInventoryAvailable line 666] Inventory IS available in facility with id WK_Warehouse for product id WK_BL_LC_03; desired quantity is 1, available quantity is 100 2012-04-05 18:06:25,765 (http-bio-0.0.0.0-80-exec-9) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailable] finished in [99] milliseconds with response [{available=Y, responseMessage=success}] 2012-04-05 18:06:25,767 (http-bio-0.0.0.0-80-exec-9) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailableOrNotRequired] finished in [103] milliseconds with response [{responseMessage=success, availableOrNotRequired=Y}] 2012-04-05 18:06:25,783 (http-bio-0.0.0.0-80-exec-9) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 18:06:25,795 (http-bio-0.0.0.0-80-exec-9) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BL_LC_03 2012-04-05 18:06:25,799 (http-bio-0.0.0.0-80-exec-9) [ RequestHandler.java:660:INFO ] Ran Event [java:org.ofbiz.order.shoppingcart.ShoppingCartEvents#addToCart] from [request], result is [error] 2012-04-05 18:06:25,815 (http-bio-0.0.0.0-80-exec-9) [ RequestHandler.java:762:INFO ] Rendering View [showcart], sessionId=AFE5C687E3372B5B3F931C21F9B804F2.jvm1 2012-04-05 18:06:25,915 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.024s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CartScreens.xml 2012-04-05 18:06:26,201 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 16 screens in 0.025s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CommonScreens.xml 2012-04-05 18:06:27,295 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 37 screens in 0.026s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CatalogScreens.xml 2012-04-05 18:06:27,735 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 7 screens in 0.018s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/EmailContactListScreens.xml 2012-04-05 18:06:27,841 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.017s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ContentScreens.xml 2012-04-05 18:06:27,871 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 13 screens in 0.024s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ForumScreens.xml 2012-04-05 18:06:27,909 (http-bio-0.0.0.0-80-exec-9) [ ScreenFactory.java:130:INFO ] Got 15 screens in 0.025s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/blog/BlogScreens.xml 2012-04-05 18:06:28,026 (http-bio-0.0.0.0-80-exec-9) [ ServerHitBin.java:633:INFO ] Visit delegatorName=default, ServerHitBin delegatorName=default 2012-04-05 18:06:28,051 (http-bio-0.0.0.0-80-exec-9) [ ControlServlet.java:324:INFO ] [[[additem(Domain:http://localhost)] Request Done- total:2.457,since last([additem(Domain:h...):2.457]] *Debug.log for http-bio-0.0.0.0-80-exec-15* 2012-04-05 18:06:44,572 (http-bio-0.0.0.0-80-exec-15) [ ControlServlet.java:141:INFO ] [[[additem(Domain:http://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2012-04-05 18:06:44,621 (http-bio-0.0.0.0-80-exec-15) [ ConfigXMLReader.java:120:INFO ] controller loaded: 0.012s, 300 requests, 99 views in jndi:/0.0.0.0//WEB-INF/controller.xml 2012-04-05 18:06:44,623 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartEvents.java:182:INFO ] adding item product WK_BG_WC_03 2012-04-05 18:06:44,624 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartEvents.java:183:INFO ] adding item parent product null 2012-04-05 18:06:44,633 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BG_WC_03 2012-04-05 18:06:44,639 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartHelper.java:203:INFO ] carthelper productid WK_BG_WC_03 2012-04-05 18:06:44,639 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartHelper.java:204:INFO ] parent productid null 2012-04-05 18:06:44,835 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/getInventoryAvailableByFacility] finished in [111] milliseconds with response [{availableToPromiseTotal=100, quantityOnHandTotal=100, responseMessage=success}] 2012-04-05 18:06:44,837 (http-bio-0.0.0.0-80-exec-15) [ Log.java:117:INFO ] [ProductStoreServices.xml#isStoreInventoryAvailable line 666] Inventory IS available in facility with id WK_Warehouse for product id WK_BG_WC_03; desired quantity is 1, available quantity is 100 2012-04-05 18:06:44,838 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailable] finished in [118] milliseconds with response [{available=Y, responseMessage=success}] 2012-04-05 18:06:44,839 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailableOrNotRequired] finished in [195] milliseconds with response [{responseMessage=success, availableOrNotRequired=Y}] 2012-04-05 18:06:44,847 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BG_WC_03 2012-04-05 18:06:44,864 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_BG_WC_03 2012-04-05 18:06:44,869 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:660:INFO ] Ran Event [java:org.ofbiz.order.shoppingcart.ShoppingCartEvents#addToCart] from [request], result is [error] 2012-04-05 18:06:44,871 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:762:INFO ] Rendering View [showcart], sessionId=AFE5C687E3372B5B3F931C21F9B804F2.jvm1 2012-04-05 18:06:45,183 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.028s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CartScreens.xml 2012-04-05 18:06:45,364 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 16 screens in 0.022s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CommonScreens.xml 2012-04-05 18:06:45,624 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 37 screens in 0.031s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CatalogScreens.xml 2012-04-05 18:06:45,967 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 7 screens in 0.014s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/EmailContactListScreens.xml 2012-04-05 18:06:46,088 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.018s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ContentScreens.xml 2012-04-05 18:06:46,119 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 13 screens in 0.026s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ForumScreens.xml 2012-04-05 18:06:46,158 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 15 screens in 0.022s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/blog/BlogScreens.xml 2012-04-05 18:06:46,225 (http-bio-0.0.0.0-80-exec-15) [ ServerHitBin.java:633:INFO ] Visit delegatorName=default, ServerHitBin delegatorName=default 2012-04-05 18:06:46,234 (http-bio-0.0.0.0-80-exec-15) [ ControlServlet.java:324:INFO ] [[[additem(Domain:http://localhost)] Request Done- total:1.66,since last([additem(Domain:h...):1.661]] 2012-04-05 18:07:04,864 (http-bio-0.0.0.0-80-exec-15) [ ControlServlet.java:141:INFO ] [[[additem(Domain:http://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2012-04-05 18:07:04,909 (http-bio-0.0.0.0-80-exec-15) [ ConfigXMLReader.java:120:INFO ] controller loaded: 0.012s, 300 requests, 99 views in jndi:/0.0.0.0//WEB-INF/controller.xml 2012-04-05 18:07:04,911 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartEvents.java:182:INFO ] adding item product WK_SG_TH_10 2012-04-05 18:07:04,911 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartEvents.java:183:INFO ] adding item parent product null 2012-04-05 18:07:04,920 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_SG_TH_10 2012-04-05 18:07:04,925 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartHelper.java:203:INFO ] carthelper productid WK_SG_TH_10 2012-04-05 18:07:04,926 (http-bio-0.0.0.0-80-exec-15) [ ShoppingCartHelper.java:204:INFO ] parent productid null 2012-04-05 18:07:05,149 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/getInventoryAvailableByFacility] finished in [91] milliseconds with response [{availableToPromiseTotal=100, quantityOnHandTotal=100, responseMessage=success}] 2012-04-05 18:07:05,150 (http-bio-0.0.0.0-80-exec-15) [ Log.java:117:INFO ] [ProductStoreServices.xml#isStoreInventoryAvailable line 666] Inventory IS available in facility with id WK_Warehouse for product id WK_SG_TH_10; desired quantity is 1, available quantity is 100 2012-04-05 18:07:05,152 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailable] finished in [100] milliseconds with response [{available=Y, responseMessage=success}] 2012-04-05 18:07:05,153 (http-bio-0.0.0.0-80-exec-15) [ ServiceDispatcher.java:593:INFO ] Sync service [ecommerce/isStoreInventoryAvailableOrNotRequired] finished in [222] milliseconds with response [{responseMessage=success, availableOrNotRequired=Y}] 2012-04-05 18:07:05,177 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_SG_TH_10 2012-04-05 18:07:05,184 (http-bio-0.0.0.0-80-exec-15) [ ProductStoreWorker.java:481:INFO ] getSurvey for product WK_SG_TH_10 2012-04-05 18:07:05,190 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:660:INFO ] Ran Event [java:org.ofbiz.order.shoppingcart.ShoppingCartEvents#addToCart] from [request], result is [error] 2012-04-05 18:07:05,191 (http-bio-0.0.0.0-80-exec-15) [ RequestHandler.java:762:INFO ] Rendering View [showcart], sessionId=AFE5C687E3372B5B3F931C21F9B804F2.jvm1 2012-04-05 18:07:05,445 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.018s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CartScreens.xml 2012-04-05 18:07:05,668 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 16 screens in 0.036s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CommonScreens.xml 2012-04-05 18:07:05,981 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 37 screens in 0.039s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/CatalogScreens.xml 2012-04-05 18:07:06,361 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 7 screens in 0.013s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/EmailContactListScreens.xml 2012-04-05 18:07:06,454 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 8 screens in 0.019s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ContentScreens.xml 2012-04-05 18:07:06,501 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 13 screens in 0.04s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/ForumScreens.xml 2012-04-05 18:07:06,548 (http-bio-0.0.0.0-80-exec-15) [ ScreenFactory.java:130:INFO ] Got 15 screens in 0.031s from: file:/D:/testbed/apache-ofbiz-trunk-1309752/specialpurpose/ecommerce/widget/blog/BlogScreens.xml 2012-04-05 18:07:06,638 (http-bio-0.0.0.0-80-exec-15) [ ServerHitBin.java:633:INFO ] Visit delegatorName=default, ServerHitBin delegatorName=default 2012-04-05 18:07:06,644 (http-bio-0.0.0.0-80-exec-15) [ ControlServlet.java:324:INFO ] [[[additem(Domain:http://localhost)] Request Done- total:1.779,since last([additem(Domain:h...):1.779]] ----- Rgds Sanjeev -- View this message in context: http://ofbiz.135035.n4.nabble.com/Could-not-find-a-valid-price-for-the-product-with-ID-when-using-the-trunk-release-tp4534702p4535666.html Sent from the OFBiz - User mailing list archive at Nabble.com.